vm-test-run-systemd-homed
checks.x86_64-linux.systemd-homed
· build #32
· 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 vm10sshClient: QEMU running (pid 48)11sshClient # Disk image does not exist, creating the virtualisation disk image...12sshClient # Formatting '/build/vm-state-sshClient/tmp.GNdkVPh0U3', fmt=raw size=107374182413sshClient # mke2fs 1.47.4 (6-Mar-2025)14sshClient # Discarding device blocks: 0/262144 done15sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes16sshClient # Filesystem UUID: 51872491-804b-47ff-9689-9e95a3f0563e17sshClient # Superblock backups stored on blocks:18sshClient # 32768, 98304, 163840, 22937619sshClient # 20sshClient # Allocating group tables: 0/8 done21sshClient # Writing inode tables: 0/8 done22sshClient # Creating journal (8192 blocks): done23sshClient # Writing superblocks and filesystem accounting information: 0/8 done24sshClient # 25sshClient # Virtualisation disk image created.26machine # Disk image does not exist, creating the virtualisation disk image...27machine: QEMU running (pid 47)28machine # Formatting '/build/vm-state-machine/tmp.yn6akPMP1C', fmt=raw size=107374182429machine # mke2fs 1.47.4 (6-Mar-2025)30machine # Discarding device blocks: 0/262144 done31machine # Creating filesystem with 262144 4k blocks and 65536 inodes32machine # Filesystem UUID: a14a70c9-7e91-4905-9fc6-c2e2cd9c68c833(finished: start all VMs, in 0.32 seconds)34machine # Superblock backups stored on blocks:35subtest: create systemd-homed user on first boot prompt36machine # 32768, 98304, 163840, 22937637machine: waiting for unit systemd-homed.service38machine # 39machine: waiting for the VM to finish booting40machine # Allocating group tables: 0/8 done41machine # Writing inode tables: 0/8 done42machine # Creating journal (8192 blocks): done43machine # Writing superblocks and filesystem accounting information: 0/8 done44machine # 45machine # 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 # 50sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0051sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)...52sshClient # 53sshClient # 54sshClient # 55sshClient # 56sshClient # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0057sshClient # Press Ctrl-B to configure iPXE (PCI 00:08.0)...58sshClient # 59sshClient # 60machine # 61machine # 62machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0063machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...64machine # 65machine # 66machine # 67machine # 68machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0069machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...70machine # 71machine # 72machine # Booting from ROM...73sshClient # Booting from ROM...74sshClient # Probing EDD (edd=off to disable)... ok75machine # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 7 15:23:00 UTC 202676machine # [ 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/snf179hyv8fqssx2q1z1jg1hzbx0n949-nixos-system-machine-test/init regInfo=/nix/store/97qnv4m2p05xsarj6fl35d1ldmcik3a4-closure-info/registration console=ttyS0,115200n8 console=tty077machine # [ 0.000000] BIOS-provided physical RAM map:78machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable79machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved80machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved81machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable82machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved83sshClient # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 7 15:23:00 UTC 202684machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved85machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved86machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved87machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved88machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved89sshClient # [ 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/hxdxb8q25kfcw5jhacl5knylm0vmjzzv-nixos-system-sshClient-test/init regInfo=/nix/store/wgn40m61g0vvnqp1ywjz6dip8qla8y7v-closure-info/registration console=ttyS0,115200n8 console=tty090machine # [ 0.000000] NX (Execute Disable) protection: active91sshClient # [ 0.000000] BIOS-provided physical RAM map:92machine # [ 0.000000] APIC: Static calls initialized93sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable94machine # [ 0.000000] SMBIOS 2.8 present.95sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved96machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201497sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved98machine # [ 0.000000] DMI: Memory slots populated: 1/199machine # [ 0.000000] Hypervisor detected: KVM100sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable101machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000102sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved103machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00104sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved105machine # [ 0.000000] kvm-clock: using sched offset of 528642447 cycles106sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved107machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns108sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved109machine # [ 0.000005] tsc: Detected 2400.010 MHz processor110sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved111machine # [ 0.000812] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000112sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved113machine # [ 0.000850] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs114sshClient # [ 0.000000] NX (Execute Disable) protection: active115machine # [ 0.000853] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT116sshClient # [ 0.000000] APIC: Static calls initialized117sshClient # [ 0.000000] SMBIOS 2.8 present.118machine # [ 0.002765] found SMP MP-table at [mem 0x000f5450-0x000f545f]119machine # [ 0.002776] Using GB pages for direct mapping120sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014121machine # [ 0.002843] RAMDISK: [mem 0x3e425000-0x3ffcffff]122sshClient # [ 0.000000] DMI: Memory slots populated: 1/1123machine # [ 0.002850] ACPI: Early table checksum verification disabled124sshClient # [ 0.000000] Hypervisor detected: KVM125machine # [ 0.002853] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )126sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000127sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00128machine # [ 0.002857] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)129sshClient # [ 0.000001] kvm-clock: using sched offset of 576945885 cycles130machine # [ 0.002862] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)131sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns132machine # [ 0.002869] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)133sshClient # [ 0.000005] tsc: Detected 2400.010 MHz processor134machine # [ 0.002870] ACPI: FACS 0x000000003FFE0000 000040135sshClient # [ 0.000817] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000136machine # [ 0.002872] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)137sshClient # [ 0.000854] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs138machine # [ 0.002873] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)139sshClient # [ 0.000857] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT140sshClient # [ 0.002777] found SMP MP-table at [mem 0x000f5450-0x000f545f]141machine # [ 0.002875] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)142sshClient # [ 0.002788] Using GB pages for direct mapping143sshClient # [ 0.002892] RAMDISK: [mem 0x3e426000-0x3ffcffff]144machine # [ 0.002876] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)145sshClient # [ 0.002900] ACPI: Early table checksum verification disabled146machine # [ 0.002878] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]147sshClient # [ 0.002902] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )148machine # [ 0.002879] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]149sshClient # [ 0.002906] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)150machine # [ 0.002879] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]151sshClient # [ 0.002910] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)152machine # [ 0.002880] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]153machine # [ 0.002880] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]154sshClient # [ 0.002917] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)155sshClient # [ 0.002919] ACPI: FACS 0x000000003FFE0000 000040156machine # [ 0.002881] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]157sshClient # [ 0.002920] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)158machine # [ 0.002881] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]159machine # [ 0.003366] No NUMA configuration found160sshClient # [ 0.002922] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)161machine # [ 0.003367] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]162sshClient # [ 0.002923] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)163machine # [ 0.003370] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]164machine # [ 0.005879] Zone ranges:165sshClient # [ 0.002925] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)166machine # [ 0.005880] DMA [mem 0x0000000000001000-0x0000000000ffffff]167sshClient # [ 0.002926] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]168machine # [ 0.005882] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]169machine # [ 0.005883] Normal empty170sshClient # [ 0.002927] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]171machine # [ 0.005884] Device empty172machine # [ 0.005885] Movable zone start for each node173sshClient # [ 0.002928] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]174machine # [ 0.005885] Early memory node ranges175sshClient # [ 0.002928] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]176machine # [ 0.005886] node 0: [mem 0x0000000000001000-0x000000000009efff]177sshClient # [ 0.002929] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]178machine # [ 0.005887] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]179sshClient # [ 0.002929] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]180machine # [ 0.005888] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]181sshClient # [ 0.002930] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]182machine # [ 0.005907] On node 0, zone DMA: 1 pages in unavailable ranges183sshClient # [ 0.003422] No NUMA configuration found184machine # [ 0.006177] On node 0, zone DMA: 97 pages in unavailable ranges185sshClient # [ 0.003423] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]186machine # [ 0.024358] On node 0, zone DMA32: 40 pages in unavailable ranges187sshClient # [ 0.003426] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]188machine # [ 0.025498] ACPI: PM-Timer IO Port: 0x608189sshClient # [ 0.005940] Zone ranges:190machine # [ 0.025511] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])191sshClient # [ 0.005941] DMA [mem 0x0000000000001000-0x0000000000ffffff]192machine # [ 0.025544] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23193sshClient # [ 0.005943] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]194sshClient # [ 0.005944] Normal empty195machine # [ 0.025547] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)196sshClient # [ 0.005944] Device empty197sshClient # [ 0.005945] Movable zone start for each node198machine # [ 0.025548] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)199sshClient # [ 0.005946] Early memory node ranges200machine # [ 0.025549] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)201sshClient # [ 0.005946] node 0: [mem 0x0000000000001000-0x000000000009efff]202machine # [ 0.025550] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)203sshClient # [ 0.005947] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]204machine # [ 0.025551] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)205sshClient # [ 0.005948] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]206machine # [ 0.025553] ACPI: Using ACPI (MADT) for SMP configuration information207sshClient # [ 0.005967] On node 0, zone DMA: 1 pages in unavailable ranges208machine # [ 0.025554] ACPI: HPET id: 0x8086a201 base: 0xfed00000209sshClient # [ 0.006240] On node 0, zone DMA: 97 pages in unavailable ranges210machine # [ 0.025558] TSC deadline timer available211machine # [ 0.025562] CPU topo: Max. logical packages: 1212sshClient # [ 0.024625] On node 0, zone DMA32: 40 pages in unavailable ranges213sshClient # [ 0.025750] ACPI: PM-Timer IO Port: 0x608214machine # [ 0.025563] CPU topo: Max. logical dies: 1215machine # [ 0.025563] CPU topo: Max. dies per package: 1216sshClient # [ 0.025763] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])217machine # [ 0.025566] CPU topo: Max. threads per core: 1218sshClient # [ 0.025794] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23219machine # [ 0.025571] CPU topo: Num. cores per package: 1220sshClient # [ 0.025797] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)221machine # [ 0.025572] CPU topo: Num. threads per package: 1222machine # [ 0.025572] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs223sshClient # [ 0.025799] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)224sshClient # [ 0.025800] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)225machine # [ 0.025590] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()226sshClient # [ 0.025801] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)227machine # [ 0.025625] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]228sshClient # [ 0.025802] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)229machine # [ 0.025627] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]230sshClient # [ 0.025804] ACPI: Using ACPI (MADT) for SMP configuration information231machine # [ 0.025628] [mem 0x40000000-0xafffffff] available for PCI devices232sshClient # [ 0.025805] ACPI: HPET id: 0x8086a201 base: 0xfed00000233machine # [ 0.025629] Booting paravirtualized kernel on KVM234sshClient # [ 0.025810] TSC deadline timer available235sshClient # [ 0.025814] CPU topo: Max. logical packages: 1236machine # [ 0.025632] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns237sshClient # [ 0.025814] CPU topo: Max. logical dies: 1238sshClient # [ 0.025815] CPU topo: Max. dies per package: 1239machine # [ 0.030073] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1240sshClient # [ 0.025818] CPU topo: Max. threads per core: 1241machine # [ 0.032360] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152242sshClient # [ 0.025818] CPU topo: Num. cores per package: 1243machine # [ 0.032405] kvm-guest: PV spinlocks disabled, single CPU244sshClient # [ 0.025819] CPU topo: Num. threads per package: 1245sshClient # [ 0.025819] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs246sshClient # [ 0.025836] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()247sshClient # [ 0.025872] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]248sshClient # [ 0.025873] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]249machine # [ 0.032407] 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/snf179hyv8fqssx2q1z1jg1hzbx0n949-nixos-system-machine-test/init regInfo=/nix/store/97qnv4m2p05xsarj6fl35d1ldmcik3a4-closure-info/registration console=ttyS0,115200n8 console=tty0250sshClient # [ 0.025874] [mem 0x40000000-0xafffffff] available for PCI devices251sshClient # [ 0.025876] Booting paravirtualized kernel on KVM252machine # [ 0.032503] Unknown kernel command line parameters "regInfo=/nix/store/97qnv4m2p05xsarj6fl35d1ldmcik3a4-closure-info/registration", will be passed to user space.253machine # [ 0.032517] random: crng init done254sshClient # [ 0.025879] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns255machine # [ 0.032517] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes256sshClient # [ 0.030443] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1257machine # [ 0.032538] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)258sshClient # [ 0.032692] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152259sshClient # [ 0.032736] kvm-guest: PV spinlocks disabled, single CPU260machine # [ 0.032550] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)261machine # [ 0.032582] Fallback order for Node 0: 0262machine # [ 0.032585] Built 1 zonelists, mobility grouping on. Total pages: 262006263machine # [ 0.032586] Policy zone: DMA32264machine # [ 0.035161] mem auto-init: stack:all(zero), heap alloc:on, heap free:off265machine # [ 0.037612] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1266sshClient # [ 0.032737] 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/hxdxb8q25kfcw5jhacl5knylm0vmjzzv-nixos-system-sshClient-test/init regInfo=/nix/store/wgn40m61g0vvnqp1ywjz6dip8qla8y7v-closure-info/registration console=ttyS0,115200n8 console=tty0267machine # [ 0.040122] allocated 2097152 bytes of page_ext268machine # [ 0.050038] ftrace: allocating 48731 entries in 192 pages269machine # [ 0.050040] ftrace: allocated 192 pages with 2 groups270sshClient # [ 0.032827] Unknown kernel command line parameters "regInfo=/nix/store/wgn40m61g0vvnqp1ywjz6dip8qla8y7v-closure-info/registration", will be passed to user space.271machine # [ 0.050886] Dynamic Preempt: lazy272sshClient # [ 0.032840] random: crng init done273machine # [ 0.051061] rcu: Preemptible hierarchical RCU implementation.274sshClient # [ 0.032841] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes275machine # [ 0.051061] rcu: RCU event tracing is enabled.276machine # [ 0.051062] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.277sshClient # [ 0.032861] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)278machine # [ 0.051063] Trampoline variant of Tasks RCU enabled.279sshClient # [ 0.032874] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)280machine # [ 0.051064] Rude variant of Tasks RCU enabled.281sshClient # [ 0.032904] Fallback order for Node 0: 0282machine # [ 0.051064] Tracing variant of Tasks RCU enabled.283sshClient # [ 0.032907] Built 1 zonelists, mobility grouping on. Total pages: 262006284machine # [ 0.051065] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.285sshClient # [ 0.032908] Policy zone: DMA32286machine # [ 0.051066] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1287sshClient # [ 0.035461] mem auto-init: stack:all(zero), heap alloc:on, heap free:off288sshClient # [ 0.037929] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1289machine # [ 0.051081] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.290sshClient # [ 0.040253] allocated 2097152 bytes of page_ext291sshClient # [ 0.050255] ftrace: allocating 48731 entries in 192 pages292machine # [ 0.051083] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.293sshClient # [ 0.050257] ftrace: allocated 192 pages with 2 groups294sshClient # [ 0.051098] Dynamic Preempt: lazy295machine # [ 0.051083] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.296sshClient # [ 0.051267] rcu: Preemptible hierarchical RCU implementation.297machine # [ 0.055570] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16298sshClient # [ 0.051268] rcu: RCU event tracing is enabled.299machine # [ 0.055845] rcu: srcu_init: Setting srcu_struct sizes based on contention.300sshClient # [ 0.051268] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.301sshClient # [ 0.051269] Trampoline variant of Tasks RCU enabled.302machine # [ 0.055852] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns303sshClient # [ 0.051270] Rude variant of Tasks RCU enabled.304sshClient # [ 0.051270] Tracing variant of Tasks RCU enabled.305machine # [ 0.055959] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)306machine # [ 0.063276] Console: colour VGA+ 80x25307sshClient # [ 0.051271] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.308machine # [ 0.063280] printk: legacy console [tty0] enabled309sshClient # [ 0.051272] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1310machine # [ 0.106693] printk: legacy console [ttyS0] enabled311machine # [ 0.307557] ACPI: Core revision 20250807312sshClient # [ 0.051297] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.313sshClient # [ 0.051299] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.314machine # [ 0.309082] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns315machine # [ 0.311957] APIC: Switch to symmetric I/O mode setup316sshClient # [ 0.051300] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.317machine # [ 0.313711] x2apic enabled318sshClient # [ 0.055675] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16319machine # [ 0.314962] APIC: Switched APIC routing to: physical x2apic320sshClient # [ 0.055949] rcu: srcu_init: Setting srcu_struct sizes based on contention.321sshClient # [ 0.055955] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns322machine # [ 0.317875] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1323sshClient # [ 0.056058] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)324sshClient # [ 0.063371] Console: colour VGA+ 80x25325machine # [ 0.319741] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns326sshClient # [ 0.063374] printk: legacy console [tty0] enabled327sshClient # [ 0.106498] printk: legacy console [ttyS0] enabled328machine # [ 0.322855] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)329sshClient # [ 0.306597] ACPI: Core revision 20250807330machine # [ 0.325097] x86/cpu: User Mode Instruction Prevention (UMIP) activated331sshClient # [ 0.308275] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns332machine # [ 0.326011] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127333sshClient # [ 0.311148] APIC: Switch to symmetric I/O mode setup334machine # [ 0.327853] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0335sshClient # [ 0.312907] x2apic enabled336sshClient # [ 0.314151] APIC: Switched APIC routing to: physical x2apic337machine # [ 0.328858] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto338sshClient # [ 0.317012] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1339machine # [ 0.330853] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl340machine # [ 0.332854] Transient Scheduler Attacks: Mitigation: Clear CPU buffers341sshClient # [ 0.318881] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns342machine # [ 0.333854] Spectre V2 : Mitigation: Enhanced / Automatic IBRS343sshClient # [ 0.322003] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)344machine # [ 0.334853] Speculative Return Stack Overflow: Mitigation: Safe RET345sshClient # [ 0.324120] x86/cpu: User Mode Instruction Prevention (UMIP) activated346sshClient # [ 0.325147] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127347sshClient # [ 0.326001] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0348machine # [ 0.335853] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization349sshClient # [ 0.327005] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto350machine # [ 0.337863] Spectre V2 : Enabling IBPB for BPF351sshClient # [ 0.328001] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl352machine # [ 0.339855] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier353sshClient # [ 0.330001] Transient Scheduler Attacks: Mitigation: Clear CPU buffers354machine # [ 0.340854] active return thunk: srso_alias_return_thunk355sshClient # [ 0.331001] Spectre V2 : Mitigation: Enhanced / Automatic IBRS356machine # [ 0.342883] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'357sshClient # [ 0.332001] Speculative Return Stack Overflow: Mitigation: Safe RET358machine # [ 0.344853] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'359machine # [ 0.346853] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'360machine # [ 0.348853] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'361machine # [ 0.350853] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'362sshClient # [ 0.334001] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization363machine # [ 0.352853] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'364sshClient # [ 0.336010] Spectre V2 : Enabling IBPB for BPF365machine # [ 0.353853] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'366sshClient # [ 0.338003] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier367machine # [ 0.355854] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'368sshClient # [ 0.339002] active return thunk: srso_alias_return_thunk369machine # [ 0.357854] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'370sshClient # [ 0.341030] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'371machine # [ 0.358854] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256372sshClient # [ 0.342001] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'373machine # [ 0.360853] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64374sshClient # [ 0.344001] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'375machine # [ 0.362853] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512376sshClient # [ 0.345001] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'377machine # [ 0.363853] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024378sshClient # [ 0.346001] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'379machine # [ 0.364853] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8380sshClient # [ 0.347001] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'381machine # [ 0.365853] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16382sshClient # [ 0.348001] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'383machine # [ 0.366854] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24384sshClient # [ 0.349001] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'385machine # [ 0.367854] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.386sshClient # [ 0.351001] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'387sshClient # [ 0.352001] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256388sshClient # [ 0.354001] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64389sshClient # [ 0.355001] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512390sshClient # [ 0.356001] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024391sshClient # [ 0.357001] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8392sshClient # [ 0.358001] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16393sshClient # [ 0.359001] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24394sshClient # [ 0.360003] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.395machine # [ 0.402620] Freeing SMP alternatives memory: 44K396machine # [ 0.403855] pid_max: default: 32768 minimum: 301397machine # [ 0.404945] LSM: initializing lsm=capability,landlock,yama,bpf,ima398machine # [ 0.406954] landlock: Up and running.399machine # [ 0.408853] Yama: becoming mindful.400machine # [ 0.410067] LSM support for eBPF active401machine # [ 0.410995] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)402machine # [ 0.412880] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)403machine # [ 0.415402] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)404machine # [ 0.416391] Performance Events: Fam17h+ core perfctr, AMD PMU driver.405sshClient # [ 0.396246] Freeing SMP alternatives memory: 44K406machine # [ 0.416859] ... version: 2407sshClient # [ 0.397009] pid_max: default: 32768 minimum: 301408machine # [ 0.417855] ... bit width: 48409sshClient # [ 0.398104] LSM: initializing lsm=capability,landlock,yama,bpf,ima410machine # [ 0.418869] ... generic counters: 6411sshClient # [ 0.399109] landlock: Up and running.412machine # [ 0.419855] ... generic bitmap: 000000000000003f413sshClient # [ 0.400001] Yama: becoming mindful.414machine # [ 0.420855] ... fixed-purpose counters: 0415sshClient # [ 0.401225] LSM support for eBPF active416machine # [ 0.421855] ... fixed-purpose bitmap: 0000000000000000417sshClient # [ 0.403118] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)418machine # [ 0.422855] ... value mask: 0000ffffffffffff419machine # [ 0.423855] ... max period: 00007fffffffffff420sshClient # [ 0.404029] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)421machine # [ 0.424855] ... global_ctrl mask: 000000000000003f422machine # [ 0.425969] signal: max sigframe size: 3376423sshClient # [ 0.406966] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)424machine # [ 0.426999] rcu: Hierarchical SRCU implementation.425machine # [ 0.427860] rcu: Max phase no-delay instances is 400.426sshClient # [ 0.407595] Performance Events: Fam17h+ core perfctr, AMD PMU driver.427sshClient # [ 0.408006] ... version: 2428sshClient # [ 0.409005] ... bit width: 48429sshClient # [ 0.410017] ... generic counters: 6430machine # [ 0.433544] smp: Bringing up secondary CPUs ...431machine # [ 0.433871] smp: Brought up 1 node, 1 CPU432sshClient # [ 0.411003] ... generic bitmap: 000000000000003f433sshClient # [ 0.412003] ... fixed-purpose counters: 0434machine # [ 0.434858] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)435sshClient # [ 0.413003] ... fixed-purpose bitmap: 0000000000000000436sshClient # [ 0.414003] ... value mask: 0000ffffffffffff437machine # [ 0.436023] Memory: 941804K/1048024K available (17223K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98856K reserved, 0K cma-reserved)438sshClient # [ 0.415014] ... max period: 00007fffffffffff439machine # [ 0.437093] devtmpfs: initialized440sshClient # [ 0.416003] ... global_ctrl mask: 000000000000003f441machine # [ 0.438070] x86/mm: Memory block size: 128MB442sshClient # [ 0.417134] signal: max sigframe size: 3376443sshClient # [ 0.418106] rcu: Hierarchical SRCU implementation.444machine # [ 0.439808] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)445sshClient # [ 0.419007] rcu: Max phase no-delay instances is 400.446machine # [ 0.440895] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).447machine # [ 0.441946] pinctrl core: initialized pinctrl subsystem448machine # [ 0.443203] PM: RTC time: 02:43:22, date: 2026-09-11449sshClient # [ 0.424591] smp: Bringing up secondary CPUs ...450sshClient # [ 0.425028] smp: Brought up 1 node, 1 CPU451sshClient # [ 0.426006] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)452machine # [ 0.446781] NET: Registered PF_NETLINK/PF_ROUTE protocol family453machine # [ 0.448244] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations454sshClient # [ 0.427170] Memory: 941828K/1048024K available (17223K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98852K reserved, 0K cma-reserved)455sshClient # [ 0.428247] devtmpfs: initialized456machine # [ 0.448876] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations457sshClient # [ 0.429252] x86/mm: Memory block size: 128MB458machine # [ 0.450016] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations459sshClient # [ 0.430996] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)460machine # [ 0.450868] audit: initializing netlink subsys (disabled)461sshClient # [ 0.432041] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).462machine # [ 0.452155] thermal_sys: Registered thermal governor 'fair_share'463sshClient # [ 0.433250] pinctrl core: initialized pinctrl subsystem464machine # [ 0.452157] thermal_sys: Registered thermal governor 'bang_bang'465sshClient # [ 0.434411] PM: RTC time: 02:43:22, date: 2026-09-11466machine # [ 0.452856] thermal_sys: Registered thermal governor 'step_wise'467machine # [ 0.453860] audit: type=2000 audit(1789094602.544:1): state=initialized audit_enabled=0 res=1468sshClient # [ 0.437887] NET: Registered PF_NETLINK/PF_ROUTE protocol family469machine # [ 0.455858] thermal_sys: Registered thermal governor 'user_space'470machine # [ 0.455860] thermal_sys: Registered thermal governor 'power_allocator'471sshClient # [ 0.439362] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations472machine # [ 0.456875] cpuidle: using governor menu473sshClient # [ 0.440024] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations474machine # [ 0.460066] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5475sshClient # [ 0.441157] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations476sshClient # [ 0.442014] audit: initializing netlink subsys (disabled)477machine # [ 0.461231] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]478sshClient # [ 0.443308] thermal_sys: Registered thermal governor 'fair_share'479machine # [ 0.461859] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry480sshClient # [ 0.443311] thermal_sys: Registered thermal governor 'bang_bang'481machine # [ 0.462868] PCI: Using configuration type 1 for base access482sshClient # [ 0.444004] thermal_sys: Registered thermal governor 'step_wise'483machine # [ 0.464068] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.484sshClient # [ 0.445009] audit: type=2000 audit(1789094602.555:1): state=initialized audit_enabled=0 res=1485sshClient # [ 0.447006] thermal_sys: Registered thermal governor 'user_space'486sshClient # [ 0.447008] thermal_sys: Registered thermal governor 'power_allocator'487sshClient # [ 0.448047] cpuidle: using governor menu488machine # [ 0.469148] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages489machine # [ 0.469857] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page490sshClient # [ 0.451286] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5491sshClient # [ 0.452312] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]492sshClient # [ 0.453006] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry493machine # [ 0.474856] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages494sshClient # [ 0.454017] PCI: Using configuration type 1 for base access495machine # [ 0.475856] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page496sshClient # [ 0.455216] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.497sshClient # [ 0.462296] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages498machine # [ 0.486358] ACPI: Added _OSI(Module Device)499sshClient # [ 0.463004] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page500machine # [ 0.486857] ACPI: Added _OSI(Processor Device)501machine # [ 0.490816] ACPI: Added _OSI(Processor Aggregator Device)502sshClient # [ 0.468003] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages503sshClient # [ 0.469004] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page504machine # [ 0.496414] ACPI: 1 ACPI AML tables successfully acquired and loaded505sshClient # [ 0.478535] ACPI: Added _OSI(Module Device)506machine # [ 0.502294] ACPI: Interpreter enabled507sshClient # [ 0.479004] ACPI: Added _OSI(Processor Device)508machine # [ 0.502872] ACPI: PM: (supports S0 S3 S4 S5)509machine # [ 0.503858] ACPI: Using IOAPIC for interrupt routing510sshClient # [ 0.482008] ACPI: Added _OSI(Processor Aggregator Device)511machine # [ 0.505015] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug512sshClient # [ 0.487624] ACPI: 1 ACPI AML tables successfully acquired and loaded513machine # [ 0.510854] PCI: Using E820 reservations for host bridge windows514machine # [ 0.512017] ACPI: Enabled 2 GPEs in block 00 to 3F515sshClient # [ 0.493447] ACPI: Interpreter enabled516sshClient # [ 0.494021] ACPI: PM: (supports S0 S3 S4 S5)517machine # [ 0.519201] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])518sshClient # [ 0.497002] ACPI: Using IOAPIC for interrupt routing519machine # [ 0.519861] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]520sshClient # [ 0.498058] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug521machine # [ 0.520950] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]522machine # [ 0.521985] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]523sshClient # [ 0.501002] PCI: Using E820 reservations for host bridge windows524sshClient # [ 0.502160] ACPI: Enabled 2 GPEs in block 00 to 3F525machine # [ 0.523491] PCI host bridge to bus 0000:00526machine # [ 0.523867] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]527machine # [ 0.524856] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]528machine # [ 0.525881] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]529sshClient # [ 0.509061] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])530machine # [ 0.526856] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]531sshClient # [ 0.510009] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]532machine # [ 0.527857] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]533sshClient # [ 0.511085] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]534machine # [ 0.528856] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]535machine # [ 0.529857] pci_bus 0000:00: root bus resource [bus 00-ff]536sshClient # [ 0.512135] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]537sshClient # [ 0.513634] PCI host bridge to bus 0000:00538machine # [ 0.530994] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint539sshClient # [ 0.514009] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]540machine # [ 0.532849] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint541sshClient # [ 0.515009] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]542sshClient # [ 0.516004] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]543sshClient # [ 0.517032] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]544sshClient # [ 0.518004] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]545machine # [ 0.535954] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]546machine # [ 0.536883] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]547sshClient # [ 0.519004] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]548sshClient # [ 0.520005] pci_bus 0000:00: root bus resource [bus 00-ff]549machine # [ 0.537912] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]550sshClient # [ 0.521149] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint551machine # [ 0.539093] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]552sshClient # [ 0.522969] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint553machine # [ 0.540872] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint554machine # [ 0.543889] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]555machine # [ 0.544870] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]556sshClient # [ 0.526084] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]557machine # [ 0.545909] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]558sshClient # [ 0.527032] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]559machine # [ 0.546870] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]560sshClient # [ 0.528058] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]561machine # [ 0.549097] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint562sshClient # [ 0.529239] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]563sshClient # [ 0.531085] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint564machine # [ 0.552038] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]565machine # [ 0.552871] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]566sshClient # [ 0.534040] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]567machine # [ 0.553909] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]568sshClient # [ 0.535018] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]569sshClient # [ 0.536058] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]570machine # [ 0.556104] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint571sshClient # [ 0.537044] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]572machine # [ 0.558406] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]573machine # [ 0.558871] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]574sshClient # [ 0.539370] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint575machine # [ 0.559908] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]576sshClient # [ 0.542040] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]577machine # [ 0.562081] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint578sshClient # [ 0.543018] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]579sshClient # [ 0.544058] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]580machine # [ 0.564870] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]581machine # [ 0.565870] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]582machine # [ 0.566909] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]583sshClient # [ 0.546272] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint584machine # [ 0.569152] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint585sshClient # [ 0.549038] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]586sshClient # [ 0.550019] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]587machine # [ 0.571610] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]588sshClient # [ 0.551059] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]589machine # [ 0.572870] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]590machine # [ 0.573909] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]591sshClient # [ 0.553617] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint592machine # [ 0.576103] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint593sshClient # [ 0.556912] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]594sshClient # [ 0.558018] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]595machine # [ 0.578673] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]596sshClient # [ 0.559062] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]597machine # [ 0.579870] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]598machine # [ 0.580909] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]599sshClient # [ 0.561253] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint600machine # [ 0.583096] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint601sshClient # [ 0.563837] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]602sshClient # [ 0.565018] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]603machine # [ 0.585704] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]604machine # [ 0.586870] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]605sshClient # [ 0.566057] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]606machine # [ 0.587909] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]607machine # [ 0.588870] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]608sshClient # [ 0.568225] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint609sshClient # [ 0.570707] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]610machine # [ 0.591385] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint611sshClient # [ 0.572018] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]612machine # [ 0.592903] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]613sshClient # [ 0.573057] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]614machine # [ 0.593909] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]615sshClient # [ 0.575341] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint616machine # [ 0.596080] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint617sshClient # [ 0.577607] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]618machine # [ 0.598479] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]619sshClient # [ 0.578018] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]620machine # [ 0.598870] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]621sshClient # [ 0.579057] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]622machine # [ 0.599913] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]623sshClient # [ 0.580018] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]624machine # [ 0.602104] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint625sshClient # [ 0.582288] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint626machine # [ 0.603889] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]627sshClient # [ 0.584317] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]628machine # [ 0.604870] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]629sshClient # [ 0.585057] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]630machine # [ 0.605908] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]631sshClient # [ 0.587268] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint632sshClient # [ 0.589546] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]633sshClient # [ 0.590018] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]634sshClient # [ 0.591056] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]635sshClient # [ 0.593256] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint636machine # [ 0.608478] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint637sshClient # [ 0.595019] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]638sshClient # [ 0.596019] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]639machine # [ 0.610939] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]640sshClient # [ 0.597057] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]641machine # [ 0.612255] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint642machine # [ 0.613942] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]643machine # [ 0.615288] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint644machine # [ 0.616916] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]645machine # [ 0.618274] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint646sshClient # [ 0.599307] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint647machine # [ 0.619870] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]648sshClient # [ 0.602577] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]649machine # [ 0.621594] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint650sshClient # [ 0.603412] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint651machine # [ 0.623565] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO652sshClient # [ 0.605102] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]653machine # [ 0.625341] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint654sshClient # [ 0.606356] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint655machine # [ 0.627057] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]656sshClient # [ 0.607976] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]657machine # [ 0.627939] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]658sshClient # [ 0.609411] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint659machine # [ 0.629745] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint660sshClient # [ 0.611018] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]661machine # [ 0.631833] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]662sshClient # [ 0.612686] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint663sshClient # [ 0.614716] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO664machine # [ 0.639404] ACPI: PCI: Interrupt link LNKA configured for IRQ 10665sshClient # [ 0.616516] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint666machine # [ 0.640030] ACPI: PCI: Interrupt link LNKB configured for IRQ 10667machine # [ 0.641008] ACPI: PCI: Interrupt link LNKC configured for IRQ 11668sshClient # [ 0.618354] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]669sshClient # [ 0.619091] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]670machine # [ 0.642020] ACPI: PCI: Interrupt link LNKD configured for IRQ 11671machine # [ 0.643012] ACPI: PCI: Interrupt link LNKE configured for IRQ 10672sshClient # [ 0.620939] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint673machine # [ 0.644016] ACPI: PCI: Interrupt link LNKF configured for IRQ 10674machine # [ 0.645012] ACPI: PCI: Interrupt link LNKG configured for IRQ 11675sshClient # [ 0.622942] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]676machine # [ 0.646013] ACPI: PCI: Interrupt link LNKH configured for IRQ 11677machine # [ 0.646920] ACPI: PCI: Interrupt link GSIA configured for IRQ 16678machine # [ 0.647878] ACPI: PCI: Interrupt link GSIB configured for IRQ 17679machine # [ 0.648878] ACPI: PCI: Interrupt link GSIC configured for IRQ 18680sshClient # [ 0.630566] ACPI: PCI: Interrupt link LNKA configured for IRQ 10681machine # [ 0.649873] ACPI: PCI: Interrupt link GSID configured for IRQ 19682sshClient # [ 0.631168] ACPI: PCI: Interrupt link LNKB configured for IRQ 10683machine # [ 0.650878] ACPI: PCI: Interrupt link GSIE configured for IRQ 20684sshClient # [ 0.632163] ACPI: PCI: Interrupt link LNKC configured for IRQ 11685machine # [ 0.651885] ACPI: PCI: Interrupt link GSIF configured for IRQ 21686sshClient # [ 0.633162] ACPI: PCI: Interrupt link LNKD configured for IRQ 11687machine # [ 0.652872] ACPI: PCI: Interrupt link GSIG configured for IRQ 22688sshClient # [ 0.634169] ACPI: PCI: Interrupt link LNKE configured for IRQ 10689machine # [ 0.653879] ACPI: PCI: Interrupt link GSIH configured for IRQ 23690sshClient # [ 0.635158] ACPI: PCI: Interrupt link LNKF configured for IRQ 10691machine # [ 0.656011] iommu: Default domain type: Translated692sshClient # [ 0.636163] ACPI: PCI: Interrupt link LNKG configured for IRQ 11693machine # [ 0.656866] iommu: DMA domain TLB invalidation policy: lazy mode694sshClient # [ 0.637157] ACPI: PCI: Interrupt link LNKH configured for IRQ 11695machine # [ 0.658185] ACPI: bus type USB registered696machine # [ 0.658929] usbcore: registered new interface driver usbfs697sshClient # [ 0.638077] ACPI: PCI: Interrupt link GSIA configured for IRQ 16698machine # [ 0.659886] usbcore: registered new interface driver hub699sshClient # [ 0.639027] ACPI: PCI: Interrupt link GSIB configured for IRQ 17700machine # [ 0.660883] usbcore: registered new device driver usb701sshClient # [ 0.640022] ACPI: PCI: Interrupt link GSIC configured for IRQ 18702machine # [ 0.662766] NetLabel: Initializing703sshClient # [ 0.641026] ACPI: PCI: Interrupt link GSID configured for IRQ 19704machine # [ 0.663683] NetLabel: domain hash size = 128705sshClient # [ 0.642025] ACPI: PCI: Interrupt link GSIE configured for IRQ 20706machine # [ 0.664855] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO707sshClient # [ 0.643022] ACPI: PCI: Interrupt link GSIF configured for IRQ 21708machine # [ 0.665901] NetLabel: unlabeled traffic allowed by default709sshClient # [ 0.644027] ACPI: PCI: Interrupt link GSIG configured for IRQ 22710machine # [ 0.666872] PCI: Using ACPI for IRQ routing711sshClient # [ 0.645022] ACPI: PCI: Interrupt link GSIH configured for IRQ 23712sshClient # [ 0.647186] iommu: Default domain type: Translated713sshClient # [ 0.648014] iommu: DMA domain TLB invalidation policy: lazy mode714sshClient # [ 0.649276] ACPI: bus type USB registered715sshClient # [ 0.650084] usbcore: registered new interface driver usbfs716sshClient # [ 0.651021] usbcore: registered new interface driver hub717sshClient # [ 0.652033] usbcore: registered new device driver usb718sshClient # [ 0.654045] NetLabel: Initializing719sshClient # [ 0.655003] NetLabel: domain hash size = 128720sshClient # [ 0.656003] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO721sshClient # [ 0.657073] NetLabel: unlabeled traffic allowed by default722sshClient # [ 0.658021] PCI: Using ACPI for IRQ routing723machine # [ 0.775137] pci 0000:00:01.0: vgaarb: setting as boot VGA device724machine # [ 0.775850] pci 0000:00:01.0: vgaarb: bridge control possible725machine # [ 0.775850] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none726machine # [ 0.775859] vgaarb: loaded727machine # [ 0.776998] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0728machine # [ 0.777855] hpet0: 3 comparators, 64-bit 100.000000 MHz counter729machine # [ 0.782951] clocksource: Switched to clocksource kvm-clock730machine # [ 0.787252] VFS: Disk quotas dquot_6.6.0731machine # [ 0.788539] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)732sshClient # [ 0.766924] pci 0000:00:01.0: vgaarb: setting as boot VGA device733machine # [ 0.790827] pnp: PnP ACPI init734sshClient # [ 0.766998] pci 0000:00:01.0: vgaarb: bridge control possible735machine # [ 0.792152] ACPI: IRQ 4 override to edge(!), high(!)736sshClient # [ 0.766998] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none737machine # [ 0.793868] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved738sshClient # [ 0.767007] vgaarb: loaded739machine # [ 0.796508] pnp: PnP ACPI: found 6 devices740sshClient # [ 0.768187] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0741sshClient # [ 0.769006] hpet0: 3 comparators, 64-bit 100.000000 MHz counter742sshClient # [ 0.774103] clocksource: Switched to clocksource kvm-clock743machine # [ 0.804753] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns744machine # [ 0.807401] clocksource: Switched to clocksource acpi_pm745sshClient # [ 0.778466] VFS: Disk quotas dquot_6.6.0746machine # [ 0.809116] NET: Registered PF_INET protocol family747sshClient # [ 0.779776] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)748machine # [ 0.810864] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)749sshClient # [ 0.782130] pnp: PnP ACPI init750sshClient # [ 0.783444] ACPI: IRQ 4 override to edge(!), high(!)751sshClient # [ 0.785170] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved752sshClient # [ 0.787880] pnp: PnP ACPI: found 6 devices753sshClient # [ 0.796184] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns754sshClient # [ 0.798840] clocksource: Switched to clocksource acpi_pm755machine # [ 0.829252] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)756sshClient # [ 0.800680] NET: Registered PF_INET protocol family757machine # [ 0.831918] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)758sshClient # [ 0.802497] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)759machine # [ 0.834375] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)760machine # [ 0.836744] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)761machine # [ 0.839055] TCP: Hash tables configured (established 8192 bind 8192)762machine # [ 0.841156] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)763machine # [ 0.843430] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)764machine # [ 0.845517] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)765machine # [ 0.847692] NET: Registered PF_UNIX/PF_LOCAL protocol family766machine # [ 0.849467] NET: Registered PF_XDP protocol family767machine # [ 0.851046] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]768sshClient # [ 0.821300] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)769machine # [ 0.852899] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]770sshClient # [ 0.823925] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)771machine # [ 0.854813] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]772machine # [ 0.856903] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]773sshClient # [ 0.826341] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)774machine # [ 0.858975] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]775sshClient # [ 0.828702] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)776machine # [ 0.861047] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]777sshClient # [ 0.830960] TCP: Hash tables configured (established 8192 bind 8192)778machine # [ 0.863945] ACPI: \_SB_.GSIA: Enabled at IRQ 16779sshClient # [ 0.833227] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)780sshClient # [ 0.835569] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)781machine # [ 0.866820] ACPI: \_SB_.GSIB: Enabled at IRQ 17782sshClient # [ 0.837599] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)783machine # [ 0.869614] ACPI: \_SB_.GSIC: Enabled at IRQ 18784sshClient # [ 0.839792] NET: Registered PF_UNIX/PF_LOCAL protocol family785sshClient # [ 0.841611] NET: Registered PF_XDP protocol family786machine # [ 0.872353] ACPI: \_SB_.GSID: Enabled at IRQ 19787sshClient # [ 0.843236] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]788machine # [ 0.874892] PCI: CLS 0 bytes, default 64789sshClient # [ 0.845136] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]790machine # [ 0.876502] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns791sshClient # [ 0.846992] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]792machine # [ 0.879577] Trying to unpack rootfs image as initramfs...793sshClient # [ 0.849084] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]794sshClient # [ 0.851141] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]795sshClient # [ 0.853237] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]796sshClient # [ 0.856127] ACPI: \_SB_.GSIA: Enabled at IRQ 16797sshClient # [ 0.858990] ACPI: \_SB_.GSIB: Enabled at IRQ 17798sshClient # [ 0.861821] ACPI: \_SB_.GSIC: Enabled at IRQ 18799sshClient # [ 0.864711] ACPI: \_SB_.GSID: Enabled at IRQ 19800sshClient # [ 0.867463] PCI: CLS 0 bytes, default 64801sshClient # [ 0.869007] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns802sshClient # [ 0.872199] Trying to unpack rootfs image as initramfs...803machine # [ 0.928592] Initialise system trusted keyrings804machine # [ 0.933094] workingset: timestamp_bits=40 max_order=18 bucket_order=0805sshClient # [ 0.921881] Initialise system trusted keyrings806sshClient # [ 0.926291] workingset: timestamp_bits=40 max_order=18 bucket_order=0807machine # [ 0.959458] Key type asymmetric registered808machine # [ 0.960811] Asymmetric key parser 'x509' registered809machine # [ 0.965112] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)810machine # [ 0.971084] io scheduler mq-deadline registered811machine # [ 0.972570] io scheduler kyber registered812machine # [ 0.976656] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled813machine # [ 0.978959] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A814sshClient # [ 0.952253] Key type asymmetric registered815machine # [ 0.988223] Linux agpgart interface v0.103816sshClient # [ 0.958108] Asymmetric key parser 'x509' registered817machine # [ 0.989614] ACPI: bus type drm_connector registered818sshClient # [ 0.959847] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)819machine # [ 0.995539] usbcore: registered new interface driver usbserial_generic820sshClient # [ 0.966258] io scheduler mq-deadline registered821machine # [ 0.997531] usbserial: USB Serial support registered for generic822sshClient # [ 0.971116] io scheduler kyber registered823machine # [ 1.002045] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.824machine # [ 1.002045] Please enable it if your BIOS has the CPPC option.825sshClient # [ 0.975673] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled826machine # [ 1.006142] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled827sshClient # [ 0.977988] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A828sshClient # [ 0.985301] Linux agpgart interface v0.103829machine # [ 1.015181] drop_monitor: Initializing network drop monitor service830sshClient # [ 0.986693] ACPI: bus type drm_connector registered831machine # [ 1.017237] NET: Registered PF_INET6 protocol family832machine # [ 1.023502] Segment Routing with IPv6833sshClient # [ 0.993256] usbcore: registered new interface driver usbserial_generic834sshClient # [ 0.995321] usbserial: USB Serial support registered for generic835machine # [ 1.028073] In-situ OAM (IOAM) with IPv6836machine # [ 1.029760] IPI shorthand broadcast: enabled837sshClient # [ 1.000089] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.838sshClient # [ 1.000089] Please enable it if your BIOS has the CPPC option.839sshClient # [ 1.004243] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled840machine # [ 1.038527] sched_clock: Marking stable (778029982, 259998627)->(1250848667, -212820058)841sshClient # [ 1.013275] drop_monitor: Initializing network drop monitor service842sshClient # [ 1.015346] NET: Registered PF_INET6 protocol family843machine # [ 1.046247] registered taskstats version 1844machine # [ 1.047830] Loading compiled-in X.509 certificates845sshClient # [ 1.021789] Segment Routing with IPv6846sshClient # [ 1.025125] In-situ OAM (IOAM) with IPv6847sshClient # [ 1.028414] IPI shorthand broadcast: enabled848sshClient # [ 1.037398] sched_clock: Marking stable (778029847, 259043030)->(1262088046, -225015169)849machine # [ 1.070332] Demotion targets for Node 0: null850machine # [ 1.074087] Key type .fscrypt registered851machine # [ 1.075384] Key type fscrypt-provisioning registered852sshClient # [ 1.045389] registered taskstats version 1853sshClient # [ 1.049191] Loading compiled-in X.509 certificates854machine # [ 1.079173] ima: No TPM chip found, activating TPM-bypass!855machine # [ 1.086046] ima: Allocated hash algorithm: sha1856machine # [ 1.087535] ima: No architecture policies found857machine # [ 1.091235] PM: Magic number: 10:737:712858machine # [ 1.095644] RAS: Correctable Errors collector initialized.859sshClient # [ 1.069262] Demotion targets for Node 0: null860sshClient # [ 1.073145] Key type .fscrypt registered861sshClient # [ 1.074440] Key type fscrypt-provisioning registered862machine # [ 1.107337] clk: Disabling unused clocks863machine # [ 1.110054] PM: genpd: Disabling unused power domains864sshClient # [ 1.080222] ima: No TPM chip found, activating TPM-bypass!865sshClient # [ 1.081922] ima: Allocated hash algorithm: sha1866sshClient # [ 1.085178] ima: No architecture policies found867sshClient # [ 1.090104] PM: Magic number: 10:737:712868sshClient # [ 1.094510] RAS: Correctable Errors collector initialized.869sshClient # [ 1.104255] clk: Disabling unused clocks870sshClient # [ 1.109114] PM: genpd: Disabling unused power domains871machine # [ 1.250312] Freeing initrd memory: 28332K872machine # [ 1.254241] Freeing unused decrypted memory: 2028K873machine # [ 1.257640] Freeing unused kernel image (initmem) memory: 3644K874machine # [ 1.259575] Write protecting the kernel read-only data: 32768k875machine # [ 1.262348] Freeing unused kernel image (text/rodata gap) memory: 1208K876machine # [ 1.264927] Freeing unused kernel image (rodata/data gap) memory: 752K877sshClient # [ 1.245214] Freeing initrd memory: 28328K878sshClient # [ 1.249149] Freeing unused decrypted memory: 2028K879sshClient # [ 1.252656] Freeing unused kernel image (initmem) memory: 3644K880sshClient # [ 1.254593] Write protecting the kernel read-only data: 32768k881sshClient # [ 1.257410] Freeing unused kernel image (text/rodata gap) memory: 1208K882sshClient # [ 1.259848] Freeing unused kernel image (rodata/data gap) memory: 752K883machine # [ 1.320824] x86/mm: Checked W+X mappings: passed, no W+X pages found.884machine # [ 1.322934] Run /init as init process885machine # [ 1.334535] systemd[1]: Inserted module 'autofs4'886sshClient # [ 1.313602] x86/mm: Checked W+X mappings: passed, no W+X pages found.887sshClient # [ 1.315590] Run /init as init process888machine # [ 1.352212] fuse: init (API version 7.45)889sshClient # [ 1.327114] systemd[1]: Inserted module 'autofs4'890machine # [ 1.359057] ACPI: \_SB_.GSIG: Enabled at IRQ 22891machine # [ 1.362904] ACPI: \_SB_.GSIH: Enabled at IRQ 23892machine # [ 1.367555] ACPI: \_SB_.GSIE: Enabled at IRQ 20893machine # [ 1.371316] ACPI: \_SB_.GSIF: Enabled at IRQ 21894sshClient # [ 1.345037] fuse: init (API version 7.45)895sshClient # [ 1.351796] ACPI: \_SB_.GSIG: Enabled at IRQ 22896sshClient # [ 1.355667] ACPI: \_SB_.GSIH: Enabled at IRQ 23897sshClient # [ 1.360311] ACPI: \_SB_.GSIE: Enabled at IRQ 20898sshClient # [ 1.365468] ACPI: \_SB_.GSIF: Enabled at IRQ 21899machine # [ 1.406958] systemd[1]: Successfully made /usr/ read-only.900sshClient # [ 1.402106] systemd[1]: Successfully made /usr/ read-only.901machine # [ 1.746479] systemd[1]: systemd 262-aaab1f1 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)902machine # [ 1.768987] systemd[1]: Detected virtualization kvm.903machine # [ 1.773187] systemd[1]: Detected architecture x86-64.904machine # [ 1.777190] systemd[1]: Running in initrd.905machine # [ 1.781514] systemd[1]: Initializing machine ID from random generator.906machine # [ 1.786981] systemd[1]: Hostname set to <machine>.907sshClient # [ 1.741620] systemd[1]: systemd 262-aaab1f1 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)908sshClient # [ 1.764623] systemd[1]: Detected virtualization kvm.909sshClient # [ 1.769243] systemd[1]: Detected architecture x86-64.910sshClient # [ 1.773839] systemd[1]: Running in initrd.911sshClient # [ 1.778745] systemd[1]: Initializing machine ID from random generator.912sshClient # [ 1.784651] systemd[1]: Hostname set to <sshClient>.913machine # [ 1.877422] systemd[1]: bpf-restrict-fs: LSM BPF program attached914sshClient # [ 1.875626] systemd[1]: bpf-restrict-fs: LSM BPF program attached915machine # [ 1.921063] systemd[1]: Queued start job for default target Initrd Default Target.916machine # [ 1.925694] systemd[1]: Created slice Slice /system/modprobe.917machine # [ 1.927831] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.918machine # [ 1.930396] systemd[1]: Expecting device /dev/disk/by-label/nixos...919machine # [ 1.932444] systemd[1]: Reached target Path Units.920machine # [ 1.934079] systemd[1]: Reached target Slice Units.921machine # [ 1.935721] systemd[1]: Reached target Swaps.922machine # [ 1.937260] systemd[1]: Reached target Timer Units.923machine # [ 1.939044] systemd[1]: Listening on D-Bus System Message Bus Socket.924machine # [ 1.941270] systemd[1]: Listening on Journal Socket (/dev/log).925machine # [ 1.943328] systemd[1]: Listening on Journal Sockets.926machine # [ 1.945201] systemd[1]: Listening on udev Kernel Socket.927machine # [ 1.946923] systemd[1]: Reached target Socket Units.928sshClient # [ 1.918586] systemd[1]: Queued start job for default target Initrd Default Target.929sshClient # [ 1.923821] systemd[1]: Created slice Slice /system/modprobe.930sshClient # [ 1.925947] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.931sshClient # [ 1.928510] systemd[1]: Expecting device /dev/disk/by-label/nixos...932sshClient # [ 1.930546] systemd[1]: Reached target Path Units.933sshClient # [ 1.932172] systemd[1]: Reached target Slice Units.934machine # [ 1.949730] systemd[1]: Starting Create List of Static Device Nodes...935sshClient # [ 1.933837] systemd[1]: Reached target Swaps.936sshClient # [ 1.935385] systemd[1]: Reached target Timer Units.937sshClient # [ 1.937162] systemd[1]: Listening on D-Bus System Message Bus Socket.938sshClient # [ 1.939370] systemd[1]: Listening on Journal Socket (/dev/log).939machine # [ 1.971289] systemd[1]: Starting Load Kernel Module 9pnet_virtio...940sshClient # [ 1.941461] systemd[1]: Listening on Journal Sockets.941sshClient # [ 1.943247] systemd[1]: Listening on udev Kernel Socket.942sshClient # [ 1.945000] systemd[1]: Reached target Socket Units.943machine # [ 1.982914] systemd[1]: Starting Load Kernel Module configfs...944sshClient # [ 1.947754] systemd[1]: Starting Create List of Static Device Nodes...945sshClient # [ 1.966321] systemd[1]: Starting Load Kernel Module 9pnet_virtio...946machine # [ 1.997871] systemd[1]: Starting Journal Service...947sshClient # [ 1.978875] systemd[1]: Starting Load Kernel Module configfs...948machine # [ 2.014148] systemd[1]: Starting Load Kernel Modules...949machine # [ 2.022591] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os950sshClient # [ 1.995223] systemd[1]: Starting Journal Service...951machine # [ 2.027159] netfs: FS-Cache loaded952sshClient # [ 2.009178] systemd[1]: Starting Load Kernel Modules...953machine # [ 2.040151] systemd[1]: Starting Coldplug All udev Devices...954machine # [ 2.044278] 9pnet: Installing 9P2000 support955sshClient # [ 2.019671] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os956sshClient # [ 2.023398] netfs: FS-Cache loaded957machine # [ 2.061116] systemd[1]: Finished Create List of Static Device Nodes.958sshClient # [ 2.035310] systemd[1]: Starting Coldplug All udev Devices...959machine # [ 2.067929] systemd-journald[67]: Collecting audit messages is disabled.960sshClient # [ 2.042155] 9pnet: Installing 9P2000 support961machine # [ 2.074925] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.962machine # [ 2.088728] systemd[1]: Finished Load Kernel Module 9pnet_virtio.963sshClient # [ 2.058379] systemd-journald[67]: Collecting audit messages is disabled.964sshClient # [ 2.062167] systemd[1]: Finished Create List of Static Device Nodes.965machine # [ 2.092553] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.966machine # [ 2.101733] systemd[1]: modprobe@configfs.service: Deactivated successfully.967sshClient # [ 2.072823] systemd[1]: modprobe@configfs.service: Deactivated successfully.968machine # [ 2.111183] systemd[1]: Finished Load Kernel Module configfs.969machine # [ 2.114199] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev970sshClient # [ 2.085215] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.971sshClient # [ 2.088931] systemd[1]: Finished Load Kernel Module configfs.972machine # [ 2.121876] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config973sshClient # [ 2.095803] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.974sshClient # [ 2.102117] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev975sshClient # [ 2.107839] systemd[1]: Finished Load Kernel Module 9pnet_virtio.976machine # [ 2.141310] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...977sshClient # [ 2.117928] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config978machine # [ 2.162216] systemd[1]: Finished Load Kernel Modules.979sshClient # [ 2.137702] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...980machine # [ 2.173498] systemd[1]: Starting Apply Kernel Variables...981sshClient # [ 2.159245] systemd[1]: Finished Load Kernel Modules.982machine # [ 2.194199] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.983sshClient # [ 2.170439] systemd[1]: Starting Apply Kernel Variables...984machine # [ 2.209253] systemd[1]: Starting Create Static Device Nodes in /dev...985sshClient # [ 2.189181] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.986machine # [ 2.228228] systemd[1]: Finished Apply Kernel Variables.987sshClient # [ 2.203325] systemd[1]: Starting Create Static Device Nodes in /dev...988machine # [ 2.252221] systemd[1]: Finished Create Static Device Nodes in /dev.989sshClient # [ 2.224652] systemd[1]: Finished Apply Kernel Variables.990machine # [ 2.259434] systemd[1]: Reached target Preparation for Local File Systems.991machine # [ 2.266157] systemd[1]: Reached target Local File Systems.992machine # [ 2.275436] systemd[1]: Starting Rule-based Manager for Device Events and Files...993sshClient # [ 2.246212] systemd[1]: Finished Create Static Device Nodes in /dev.994sshClient # [ 2.252536] systemd[1]: Reached target Preparation for Local File Systems.995machine # [ 2.020520] systemd-modules-load[68]: Inserted module 'dm_mod'996machine # [ 2.025523] systemd-modules-load[68]: Inserted module 'virtio_balloon'997machine # [ 2.027548] systemd-modules-load[68]: Inserted module 'virtio_gpu'998sshClient # [ 2.259231] systemd[1]: Reached target Local File Systems.999machine # [ 2.296397] systemd[1]: Started Journal Service.1000sshClient # [ 2.268561] systemd[1]: Starting Rule-based Manager for Device Events and Files...1001sshClient # [ 2.014663] systemd-modules-load[68]: Inserted module 'dm_mod'1002sshClient # [ 2.019481] systemd-modules-load[68]: Inserted module 'virtio_balloon'1003sshClient # [ 2.021510] systemd-modules-load[68]: Inserted module 'virtio_gpu'1004sshClient # [ 2.289455] systemd[1]: Started Journal Service.1005machine # [ 2.060230] systemd[1]: Starting Create System Files and Directories...1006sshClient # [ 2.055118] systemd[1]: Starting Create System Files and Directories...1007machine # [ 2.092798] systemd[1]: Finished Create System Files and Directories.1008machine # [ 2.097302] systemd-udevd[74]: Using default interface naming scheme 'v261'.1009sshClient # [ 2.086336] systemd[1]: Finished Create System Files and Directories.1010sshClient # [ 2.092489] systemd-udevd[74]: Using default interface naming scheme 'v261'.1011machine # [ 2.133110] systemd[1]: Started Rule-based Manager for Device Events and Files.1012sshClient # [ 2.128859] systemd[1]: Started Rule-based Manager for Device Events and Files.1013machine # [ 2.175291] systemd[1]: Finished Coldplug All udev Devices.1014machine # [ 2.179106] systemd[1]: Reached target System Initialization.1015machine # [ 2.180683] systemd[1]: Reached target Basic System.1016sshClient # [ 2.172176] systemd[1]: Finished Coldplug All udev Devices.1017sshClient # [ 2.173836] systemd[1]: Reached target System Initialization.1018sshClient # [ 2.176220] systemd[1]: Reached target Basic System.1019machine # [ 2.687480] virtio_blk virtio5: 1/0/0 default/read/poll queues1020machine # [ 2.709469] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1021machine # [ 2.740464] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022sshClient # [ 2.722978] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121023sshClient # [ 2.734186] virtio_blk virtio5: 1/0/0 default/read/poll queues1024machine # [ 2.778697] serio: i8042 KBD port at 0x60,0x64 irq 11025machine # [ 2.785149] serio: i8042 AUX port at 0x60,0x64 irq 121026sshClient # [ 2.762950] serio: i8042 KBD port at 0x60,0x64 irq 11027sshClient # [ 2.764573] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1028sshClient # [ 2.771097] serio: i8042 AUX port at 0x60,0x64 irq 121029machine # [ 2.804915] ehci-pci 0000:00:1d.7: EHCI Host Controller1030machine # [ 2.806263] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11031sshClient # [ 2.778090] ehci-pci 0000:00:1d.7: EHCI Host Controller1032sshClient # [ 2.779415] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11033machine # [ 2.810411] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001034sshClient # [ 2.783426] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001035machine # [ 2.819074] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001036machine # [ 2.822575] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181037sshClient # [ 2.793142] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001038machine # [ 2.826522] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11039sshClient # [ 2.797149] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181040sshClient # [ 2.799075] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11041machine # [ 2.830502] usb usb1: Product: EHCI Host Controller1042machine # [ 2.833438] usb usb1: Manufacturer: Linux 6.18.50 ehci_hcd1043sshClient # [ 2.804087] usb usb1: Product: EHCI Host Controller1044machine # [ 2.836206] usb usb1: SerialNumber: 0000:00:1d.71045sshClient # [ 2.806742] usb usb1: Manufacturer: Linux 6.18.50 ehci_hcd1046machine # [ 2.838966] hub 1-0:1.0: USB hub found1047sshClient # [ 2.810082] usb usb1: SerialNumber: 0000:00:1d.71048machine # [ 2.840792] hub 1-0:1.0: 6 ports detected1049sshClient # [ 2.814280] hub 1-0:1.0: USB hub found1050sshClient # [ 2.815689] hub 1-0:1.0: 6 ports detected1051machine # [ 2.846128] uhci_hcd 0000:00:1d.0: UHCI Host Controller1052machine # [ 2.847418] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21053sshClient # [ 2.820530] uhci_hcd 0000:00:1d.0: UHCI Host Controller1054sshClient # [ 2.821839] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21055sshClient # [ 2.824942] SCSI subsystem initialized1056machine # [ 2.865264] uhci_hcd 0000:00:1d.0: detected 2 ports1057sshClient # [ 2.837018] uhci_hcd 0000:00:1d.0: detected 2 ports1058sshClient # [ 2.844583] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001059machine # [ 2.876142] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001060sshClient # [ 2.859262] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181061sshClient # [ 2.861285] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11062machine # [ 2.891979] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181063machine # [ 2.893988] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11064machine # [ 2.897161] SCSI subsystem initialized1065machine # [ 2.645237] systemd[1]: Starting Virtual Console Setup...1066sshClient # [ 2.890162] usb usb2: Product: UHCI Host Controller1067machine # [ 2.667210] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1068sshClient # [ 2.901331] usb usb2: Manufacturer: Linux 6.18.50 uhci_hcd1069machine # [ 2.679754] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1070sshClient # [ 2.653709] systemd[1]: Starting Virtual Console Setup...1071machine # [ 2.684298] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1072sshClient # [ 2.660196] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1073sshClient # [ 2.922134] usb usb2: SerialNumber: 0000:00:1d.01074machine # [ 2.951872] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01075machine # [ 2.695741] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.1076machine # [ 2.702737] systemd[1]: Finished Virtual Console Setup.1077machine # [ 2.968058] usb usb2: Product: UHCI Host Controller1078machine # [ 2.977752] usb usb2: Manufacturer: Linux 6.18.50 uhci_hcd1079sshClient # [ 2.687982] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1080sshClient # [ 2.954137] hub 2-0:1.0: USB hub found1081machine # [ 2.988073] usb usb2: SerialNumber: 0000:00:1d.01082sshClient # [ 2.697985] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1083sshClient # [ 2.705867] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.1084machine # [ 2.997813] hub 2-0:1.0: USB hub found1085machine # [ 2.999742] hub 2-0:1.0: 2 ports detected1086sshClient # [ 2.969919] hub 2-0:1.0: 2 ports detected1087sshClient # [ 2.713714] systemd[1]: Finished Virtual Console Setup.1088machine # [ 3.006383] uhci_hcd 0000:00:1d.1: UHCI Host Controller1089machine # [ 2.749862] systemd[1]: Found device /dev/disk/by-label/nixos.1090machine # [ 2.751479] systemd[1]: Reached target Initrd Root Device.1091machine # [ 2.754109] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1092sshClient # [ 2.989107] uhci_hcd 0000:00:1d.1: UHCI Host Controller1093sshClient # [ 2.993322] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01094machine # [ 3.028053] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31095machine # [ 3.038071] uhci_hcd 0000:00:1d.1: detected 2 ports1096sshClient # [ 3.007889] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31097machine # [ 3.040260] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201098machine # [ 3.046868] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181099sshClient # [ 2.762123] systemd[1]: Found device /dev/disk/by-label/nixos.1100machine # [ 2.792748] systemd-fsck[106]: nixos: clean, 12/65536 files, 13019/262144 blocks1101sshClient # [ 2.764914] systemd[1]: Reached target Initrd Root Device.1102sshClient # [ 3.026180] uhci_hcd 0000:00:1d.1: detected 2 ports1103sshClient # [ 2.770433] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1104machine # [ 2.803319] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1105sshClient # [ 3.036152] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201106machine # [ 3.066492] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11107machine # [ 2.809257] systemd[1]: Mounting /sysroot...1108sshClient # [ 3.040761] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1109sshClient # [ 3.046338] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181110sshClient # [ 3.048320] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11111machine # [ 3.082057] usb usb3: Product: UHCI Host Controller1112machine # [ 3.084280] usb 1-1: new high-speed USB device number 2 using ehci-pci1113sshClient # [ 3.054357] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1114sshClient # [ 3.056566] usb usb3: Product: UHCI Host Controller1115sshClient # [ 3.058364] ahci 0000:00:1f.2: flags: 64bit ncq only1116sshClient # [ 3.060097] usb 1-1: new high-speed USB device number 2 using ehci-pci1117machine # [ 3.092656] usb usb3: Manufacturer: Linux 6.18.50 uhci_hcd1118sshClient # [ 3.062413] usb usb3: Manufacturer: Linux 6.18.50 uhci_hcd1119sshClient # [ 3.065146] usb usb3: SerialNumber: 0000:00:1d.11120machine # [ 3.100717] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1121sshClient # [ 3.072485] scsi host0: ahci1122machine # [ 3.104818] usb usb3: SerialNumber: 0000:00:1d.11123sshClient # [ 2.816093] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1124sshClient # [ 3.077834] hub 3-0:1.0: USB hub found1125machine # [ 3.112931] hub 3-0:1.0: USB hub found1126sshClient # [ 2.824415] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1127machine # [ 3.115504] hub 3-0:1.0: 2 ports detected1128sshClient # [ 3.086253] scsi host1: ahci1129sshClient # [ 3.087878] hub 3-0:1.0: 2 ports detected1130machine # [ 3.119092] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1131sshClient # [ 2.832108] systemd[1]: Mounting /sysroot...1132sshClient # [ 3.092513] scsi host2: ahci1133machine # [ 3.127110] ahci 0000:00:1f.2: flags: 64bit ncq only1134machine # [ 3.130177] uhci_hcd 0000:00:1d.2: UHCI Host Controller1135sshClient # [ 3.102246] scsi host3: ahci1136sshClient # [ 3.104156] uhci_hcd 0000:00:1d.2: UHCI Host Controller1137sshClient # [ 3.105452] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41138machine # [ 3.136135] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41139sshClient # [ 3.113473] scsi host4: ahci1140machine # [ 3.154146] uhci_hcd 0000:00:1d.2: detected 2 ports1141sshClient # [ 3.129449] scsi host5: ahci1142machine # [ 3.162081] scsi host0: ahci1143sshClient # [ 3.130480] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11144machine # [ 3.163387] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401145sshClient # [ 3.138657] uhci_hcd 0000:00:1d.2: detected 2 ports1146machine # [ 3.170948] scsi host1: ahci1147sshClient # [ 3.140030] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401148machine # [ 3.174540] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181149machine # [ 3.180794] scsi host2: ahci1150sshClient # [ 3.150696] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11151machine # [ 3.185808] scsi host3: ahci1152sshClient # [ 3.156570] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181153machine # [ 3.191039] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11154sshClient # [ 3.161300] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11155machine # [ 3.197274] usb usb4: Product: UHCI Host Controller1156machine # [ 3.199123] scsi host4: ahci1157sshClient # [ 3.168757] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11158sshClient # [ 3.173665] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11159machine # [ 3.205081] usb usb4: Manufacturer: Linux 6.18.50 uhci_hcd1160machine # [ 3.208125] scsi host5: ahci1161machine # [ 3.210122] usb usb4: SerialNumber: 0000:00:1d.21162sshClient # [ 3.180454] usb usb4: Product: UHCI Host Controller1163sshClient # [ 3.182153] usb usb4: Manufacturer: Linux 6.18.50 uhci_hcd1164machine # [ 3.213236] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11165machine # [ 3.217249] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001166sshClient # [ 3.187164] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11167machine # [ 3.219154] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101168sshClient # [ 3.191158] usb usb4: SerialNumber: 0000:00:1d.21169machine # [ 3.221894] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11170machine # [ 3.224146] usb 1-1: Product: QEMU USB Tablet1171sshClient # [ 3.192884] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11172machine # [ 3.225611] hub 4-0:1.0: USB hub found1173machine # [ 3.226686] usb 1-1: Manufacturer: QEMU1174machine # [ 3.228423] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11175sshClient # [ 3.198524] hub 4-0:1.0: USB hub found1176machine # [ 3.230602] hub 4-0:1.0: 2 ports detected1177sshClient # [ 3.200082] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001178sshClient # [ 3.202021] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101179machine # [ 3.235285] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11180sshClient # [ 3.206663] hub 4-0:1.0: 2 ports detected1181sshClient # [ 3.208168] usb 1-1: Product: QEMU USB Tablet1182machine # [ 3.239672] EXT4-fs (vda): mounted filesystem a14a70c9-7e91-4905-9fc6-c2e2cd9c68c8 r/w with ordered data mode. Quota mode: none.1183sshClient # [ 3.211911] usb 1-1: Manufacturer: QEMU1184sshClient # [ 3.213073] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11185machine # [ 2.987534] systemd[1]: Mounted /sysroot.1186machine # [ 2.990074] systemd[1]: Reached target Initrd Root File System.1187machine # [ 2.995625] systemd[1]: Mounting /sysroot/nix/.ro-store...1188machine # [ 3.261070] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11189machine # [ 3.005201] systemd[1]: Mounting /sysroot/nix/.rw-store...1190machine # [ 3.011236] systemd[1]: Mounting /sysroot/run...1191sshClient # [ 3.250704] hid: raw HID events driver (C) Jiri Kosina1192machine # [ 3.021421] systemd[1]: Mounting /sysroot/tmp/shared...1193machine # [ 3.034211] systemd[1]: Mounting /sysroot/tmp/xchg...1194machine # [ 3.296137] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11195machine # [ 3.313384] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11196machine # [ 3.058207] systemd[1]: Starting Mountpoints Configured in the Real Root...1197machine # [ 3.343875] 9p: Installing v9fs 9p2000 file system support1198machine # [ 3.358563] hid: raw HID events driver (C) Jiri Kosina1199machine # [ 3.107237] systemd[1]: Mounted /sysroot/nix/.rw-store.1200machine # [ 3.115773] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.1201machine # [ 3.119229] systemd[1]: Mounted /sysroot/run.1202machine # [ 3.123700] systemd[1]: Mounted /sysroot/tmp/shared.1203machine # [ 3.128176] systemd[1]: Mounted /sysroot/tmp/xchg.1204machine # [ 3.135258] systemd[1]: Starting rw-sysroot-nix-store.service...1205machine # [ 3.137736] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...1206machine # [ 3.141141] systemd[1]: Reloading...1207machine # [ 3.214955] systemd[1]: Reloading finished in 72 ms.1208machine # [ 3.224970] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...1209machine # [ 3.229181] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1210machine # [ 3.231884] systemd[1]: Finished rw-sysroot-nix-store.service.1211machine # [ 3.235638] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...1212machine # [ 3.239796] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1213machine # [ 3.243124] systemd[1]: Finished Mountpoints Configured in the Real Root.1214machine # [ 3.244952] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1215machine # [ 3.248761] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1216machine # [ 3.252527] systemd[1]: Starting rw-sysroot-nix-store.service...1217machine # [ 3.264850] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1218machine # [ 3.267802] systemd[1]: Finished rw-sysroot-nix-store.service.1219sshClient # [ 3.532896] ata6: SATA link down (SStatus 0 SControl 300)1220sshClient # [ 3.537007] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1221sshClient # [ 3.541821] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001222sshClient # [ 3.545666] ata3.00: applying bridge limits1223sshClient # [ 3.549377] ata5: SATA link down (SStatus 0 SControl 300)1224sshClient # [ 3.553704] ata4: SATA link down (SStatus 0 SControl 300)1225sshClient # [ 3.557773] ata1: SATA link down (SStatus 0 SControl 300)1226sshClient # [ 3.562417] ata2: SATA link down (SStatus 0 SControl 300)1227sshClient # [ 3.566761] ata3.00: configured for UDMA/1001228sshClient # [ 3.570967] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51229sshClient # [ 3.602988] EXT4-fs (vda): mounted filesystem 51872491-804b-47ff-9689-9e95a3f0563e r/w with ordered data mode. Quota mode: none.1230sshClient # [ 3.353116] systemd[1]: Mounted /sysroot.1231sshClient # [ 3.355815] systemd[1]: Reached target Initrd Root File System.1232machine # [ 3.643902] ata2: SATA link down (SStatus 0 SControl 300)1233machine # [ 3.647939] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1234sshClient # [ 3.361551] systemd[1]: Starting Mountpoints Configured in the Real Root...1235machine # [ 3.652783] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001236machine # [ 3.656543] ata3.00: applying bridge limits1237machine # [ 3.660301] ata4: SATA link down (SStatus 0 SControl 300)1238machine # [ 3.664643] ata1: SATA link down (SStatus 0 SControl 300)1239machine # [ 3.669089] ata5: SATA link down (SStatus 0 SControl 300)1240sshClient # [ 3.383559] systemd-sysroot-fstab-check[140]: /sysroot should be mounted in the initrd, will request daemon-reload.1241machine # [ 3.672969] ata6: SATA link down (SStatus 0 SControl 300)1242machine # [ 3.676821] ata3.00: configured for UDMA/1001243sshClient # [ 3.390639] systemd[1]: Reload requested from client PID 140 ('systemd-sysroot') (unit initrd-parse-etc.service)...1244sshClient # [ 3.393464] systemd[1]: Reloading...1245machine # [ 3.680357] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51246machine # [ 3.441284] systemd[1]: Mounted /sysroot/nix/.ro-store.1247sshClient # [ 3.676559] usbcore: registered new interface driver usbhid1248sshClient # [ 3.698095] usbhid: USB HID core driver1249machine # [ 3.730709] usbcore: registered new interface driver usbhid1250machine # [ 3.735456] usbhid: USB HID core driver1251machine # [ 3.743571] 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/input21252machine # [ 3.746595] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1253machine # [ 3.748402] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01254machine # [ 3.759246] cdrom: Uniform CD-ROM driver Revision: 3.201255sshClient # [ 3.731366] 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/input21256sshClient # [ 3.747156] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01257sshClient # [ 3.754894] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1258sshClient # [ 3.774287] cdrom: Uniform CD-ROM driver Revision: 3.201259sshClient # [ 3.533132] systemd[1]: Reloading finished in 143 ms.1260sshClient # [ 3.546691] systemd-sysroot-fstab-check[140]: Requesting initrd-fs.target/start/replace...1261sshClient # [ 3.555944] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1262sshClient # [ 3.558974] systemd-sysroot-fstab-check[140]: Requesting swap.target/start/replace...1263sshClient # [ 3.562652] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1264sshClient # [ 3.565254] systemd[1]: Finished Mountpoints Configured in the Real Root.1265sshClient # [ 3.568258] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1266machine # [ 3.799624] systemd[1]: Mounting /sysroot/nix/store...1267sshClient # [ 3.794600] systemd[1]: Mounting /sysroot/nix/.ro-store...1268sshClient # [ 3.799218] systemd[1]: Mounting /sysroot/nix/.rw-store...1269sshClient # [ 3.804974] systemd[1]: Mounting /sysroot/run...1270sshClient # [ 3.811118] systemd[1]: Mounting /sysroot/tmp/shared...1271machine # [ 3.851111] systemd[1]: Mounted /sysroot/nix/store.1272sshClient # [ 3.822121] systemd[1]: Mounting /sysroot/tmp/xchg...1273machine # [ 3.852571] systemd[1]: Reached target Initrd File Systems.1274machine # [ 3.856068] systemd[1]: Starting Find NixOS closure...1275machine # [ 3.860211] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1276sshClient # [ 4.107526] 9p: Installing v9fs 9p2000 file system support1277sshClient # [ 3.850951] systemd[1]: Mounted /sysroot/nix/.rw-store.1278machine # [ 3.881589] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1279machine # [ 3.885633] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1280sshClient # [ 3.862131] systemd[1]: Mounted /sysroot/run.1281machine # [ 3.895209] systemd[1]: Finished Find NixOS closure.1282sshClient # [ 3.866933] systemd[1]: Mounted /sysroot/nix/.ro-store.1283machine # [ 3.897544] systemd[1]: Reached target Initrd Default Target.1284sshClient # [ 3.870857] systemd[1]: Mounted /sysroot/tmp/shared.1285machine # [ 3.900411] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1286sshClient # [ 3.873378] systemd[1]: Mounted /sysroot/tmp/xchg.1287sshClient # [ 3.878956] systemd[1]: Starting rw-sysroot-nix-store.service...1288machine # [ 3.919265] systemd[1]: Stopped target Initrd Default Target.1289machine # [ 3.920849] systemd[1]: Stopped target Basic System.1290sshClient # [ 3.891441] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1291machine # [ 3.922316] systemd[1]: Stopped target Initrd Root Device.1292machine # [ 3.923844] systemd[1]: Stopped target Path Units.1293sshClient # [ 3.894793] systemd[1]: Finished rw-sysroot-nix-store.service.1294machine # [ 3.925565] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1295machine # [ 3.928244] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1296machine # [ 3.930671] systemd[1]: Stopped target Slice Units.1297machine # [ 3.933245] systemd[1]: Stopped target Socket Units.1298machine # [ 3.934674] systemd[1]: Stopped target System Initialization.1299machine # [ 3.936505] systemd[1]: Stopped target Swaps.1300machine # [ 3.938199] systemd[1]: Stopped target Timer Units.1301machine # [ 3.939931] systemd[1]: dbus.socket: Deactivated successfully.1302machine # [ 3.942395] systemd[1]: Closed D-Bus System Message Bus Socket.1303machine # [ 3.945227] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1304machine # [ 3.947339] systemd[1]: Stopped Find NixOS closure.1305machine # [ 3.948732] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1306machine # [ 3.952216] systemd[1]: Starting rw-sysroot-nix-store.service...1307machine # [ 3.953837] systemd[1]: systemd-sysctl.service: Deactivated successfully.1308machine # [ 3.955616] systemd[1]: Stopped Apply Kernel Variables.1309machine # [ 3.958198] systemd[1]: systemd-modules-load.service: Deactivated successfully.1310machine # [ 3.960105] systemd[1]: Stopped Load Kernel Modules.1311machine # [ 3.961546] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1312machine # [ 3.963902] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1313machine # [ 3.966874] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1314machine # [ 3.968894] systemd[1]: Stopped Create System Files and Directories.1315machine # [ 3.971255] systemd[1]: Stopped target Local File Systems.1316machine # [ 3.974238] systemd[1]: Stopped target Preparation for Local File Systems.1317machine # [ 3.976069] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1318machine # [ 3.978297] systemd[1]: Stopped Coldplug All udev Devices.1319machine # [ 3.981364] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1320machine # [ 3.983407] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1321machine # [ 3.985770] systemd[1]: Stopped Virtual Console Setup.1322machine # [ 3.998938] systemd[1]: initrd-cleanup.service: Deactivated successfully.1323machine # [ 4.003218] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1324machine # [ 4.006825] systemd[1]: systemd-udevd.service: Deactivated successfully.1325machine # [ 4.009511] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1326machine # [ 4.012296] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1327machine # [ 4.014868] systemd[1]: Finished rw-sysroot-nix-store.service.1328machine # [ 4.020739] systemd[1]: Starting Cleanup udev Database...1329machine # [ 4.023253] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1330machine # [ 4.025311] systemd[1]: Stopped Create Static Device Nodes in /dev.1331machine # [ 4.027053] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1332machine # [ 4.030186] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1333machine # [ 4.032074] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1334machine # [ 4.033957] systemd[1]: Stopped Create List of Static Device Nodes.1335machine # [ 4.050505] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1336machine # [ 4.053350] systemd[1]: Finished Cleanup udev Database.1337machine # [ 4.055681] systemd[1]: Reached target Switch Root.1338machine # [ 4.058475] systemd[1]: Starting NixOS Activation...1339machine # [ 4.240732] initrd-nixos-activation-start[195]: booting system configuration /nix/store/snf179hyv8fqssx2q1z1jg1hzbx0n949-nixos-system-machine-test1340machine # [ 4.311065] initrd-nixos-activation-start[195]: running activation script...1341machine # [ 4.774850] initrd-nixos-activation-start[218]: setting up /etc...1342sshClient # [ 4.796479] systemd[1]: Mounting /sysroot/nix/store...1343sshClient # [ 4.847901] systemd[1]: Mounted /sysroot/nix/store.1344sshClient # [ 4.850255] systemd[1]: Reached target Initrd File Systems.1345sshClient # [ 4.853400] systemd[1]: Starting Find NixOS closure...1346sshClient # [ 4.857585] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1347sshClient # [ 4.880081] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1348sshClient # [ 4.883618] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1349sshClient # [ 4.893968] systemd[1]: Finished Find NixOS closure.1350sshClient # [ 4.896375] systemd[1]: Reached target Initrd Default Target.1351sshClient # [ 4.899120] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1352sshClient # [ 4.916639] systemd[1]: Stopped target Initrd Default Target.1353sshClient # [ 4.918590] systemd[1]: Stopped target Basic System.1354sshClient # [ 4.921217] systemd[1]: Stopped target Initrd Root Device.1355sshClient # [ 4.922747] systemd[1]: Stopped target Path Units.1356sshClient # [ 4.924331] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1357sshClient # [ 4.926296] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1358sshClient # [ 4.928718] systemd[1]: Stopped target Slice Units.1359sshClient # [ 4.930578] systemd[1]: Stopped target Socket Units.1360sshClient # [ 4.932609] systemd[1]: Stopped target System Initialization.1361sshClient # [ 4.935247] systemd[1]: Stopped target Swaps.1362sshClient # [ 4.936649] systemd[1]: Stopped target Timer Units.1363sshClient # [ 4.938097] systemd[1]: dbus.socket: Deactivated successfully.1364sshClient # [ 4.940209] systemd[1]: Closed D-Bus System Message Bus Socket.1365sshClient # [ 4.942137] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1366sshClient # [ 4.944594] systemd[1]: Stopped Find NixOS closure.1367sshClient # [ 4.946285] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1368sshClient # [ 4.950253] systemd[1]: Starting rw-sysroot-nix-store.service...1369sshClient # [ 4.951883] systemd[1]: systemd-sysctl.service: Deactivated successfully.1370sshClient # [ 4.953772] systemd[1]: Stopped Apply Kernel Variables.1371sshClient # [ 4.955725] systemd[1]: systemd-modules-load.service: Deactivated successfully.1372sshClient # [ 4.957978] systemd[1]: Stopped Load Kernel Modules.1373sshClient # [ 4.960623] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1374sshClient # [ 4.962679] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1375sshClient # [ 4.966207] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1376sshClient # [ 4.968126] systemd[1]: Stopped Create System Files and Directories.1377sshClient # [ 4.969769] systemd[1]: Stopped target Local File Systems.1378sshClient # [ 4.971308] systemd[1]: Stopped target Preparation for Local File Systems.1379sshClient # [ 4.973423] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1380sshClient # [ 4.975720] systemd[1]: Stopped Coldplug All udev Devices.1381sshClient # [ 4.978244] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1382sshClient # [ 4.981500] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1383sshClient # [ 4.983462] systemd[1]: Stopped Virtual Console Setup.1384sshClient # [ 4.996362] systemd[1]: initrd-cleanup.service: Deactivated successfully.1385sshClient # [ 5.000262] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1386sshClient # [ 5.006116] systemd[1]: systemd-udevd.service: Deactivated successfully.1387sshClient # [ 5.009110] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1388sshClient # [ 5.011733] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1389sshClient # [ 5.014434] systemd[1]: Finished rw-sysroot-nix-store.service.1390sshClient # [ 5.019993] systemd[1]: Starting Cleanup udev Database...1391sshClient # [ 5.022479] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1392sshClient # [ 5.024581] systemd[1]: Stopped Create Static Device Nodes in /dev.1393sshClient # [ 5.026360] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1394sshClient # [ 5.029255] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1395sshClient # [ 5.031149] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1396sshClient # [ 5.034187] systemd[1]: Stopped Create List of Static Device Nodes.1397machine # [ 5.078156] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1398sshClient # [ 5.049528] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1399machine # [ 5.081130] systemd[1]: Finished NixOS Activation.1400sshClient # [ 5.053101] systemd[1]: Finished Cleanup udev Database.1401machine # [ 5.083986] systemd[1]: Starting Switch Root...1402sshClient # [ 5.054617] systemd[1]: Reached target Switch Root.1403sshClient # [ 5.057321] systemd[1]: Starting NixOS Activation...1404machine # [ 5.099474] systemd[1]: Switching root.1405machine # [ 5.494847] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1406sshClient # [ 5.215540] initrd-nixos-activation-start[195]: booting system configuration /nix/store/hxdxb8q25kfcw5jhacl5knylm0vmjzzv-nixos-system-sshClient-test1407sshClient # [ 5.284529] initrd-nixos-activation-start[195]: running activation script...1408machine # [ 5.654676] NET: Registered PF_VSOCK protocol family1409sshClient # [ 5.726936] initrd-nixos-activation-start[218]: setting up /etc...1410machine # [ 6.048425] systemd[1]: systemd 262-aaab1f1 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)1411machine # [ 6.065140] systemd[1]: Detected virtualization kvm.1412machine # [ 6.068285] systemd[1]: Detected architecture x86-64.1413machine # [ 6.071621] systemd[1]: Detected first boot.1414machine # [ 6.080246] systemd[1]: Initializing machine ID from random generator.1415machine # [ 6.206838] systemd[1]: bpf-restrict-fs: LSM BPF program attached1416sshClient # [ 6.022982] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1417sshClient # [ 6.025355] systemd[1]: Finished NixOS Activation.1418sshClient # [ 6.028354] systemd[1]: Starting Switch Root...1419sshClient # [ 6.044589] systemd[1]: Switching root.1420machine # [ 6.346474] systemd[1]: Applying preset policy.1421sshClient # [ 6.432184] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1422sshClient # [ 6.564434] NET: Registered PF_VSOCK protocol family1423machine # [ 6.929838] systemd[1]: Populated /etc with preset unit settings.1424sshClient # [ 6.953516] systemd[1]: systemd 262-aaab1f1 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)1425sshClient # [ 6.970219] systemd[1]: Detected virtualization kvm.1426sshClient # [ 6.973473] systemd[1]: Detected architecture x86-64.1427sshClient # [ 6.976880] systemd[1]: Detected first boot.1428sshClient # [ 6.985386] systemd[1]: Initializing machine ID from random generator.1429sshClient # [ 7.118689] systemd[1]: bpf-restrict-fs: LSM BPF program attached1430sshClient # [ 7.243138] systemd[1]: Applying preset policy.1431machine # [ 7.507615] systemd[1]: initrd-switch-root.service: Deactivated successfully.1432machine # [ 7.510218] systemd[1]: Stopped initrd-switch-root.service.1433machine # [ 7.513950] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1434machine # [ 7.517512] systemd[1]: Created slice Slice /system/getty.1435machine # [ 7.519668] systemd[1]: Created slice User and Session Slice.1436machine # [ 7.521413] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1437machine # [ 7.523506] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1438machine # [ 7.525405] systemd[1]: Expecting device /dev/hvc0...1439machine # [ 7.539136] systemd[1]: Expecting device /dev/ttyS0...1440machine # [ 7.540497] systemd[1]: Reached target Local Encrypted Volumes.1441machine # [ 7.542027] systemd[1]: Stopped target initrd-fs.target.1442machine # [ 7.543403] systemd[1]: Stopped target initrd-root-fs.target.1443machine # [ 7.544847] systemd[1]: Stopped target initrd-switch-root.target.1444machine # [ 7.546454] systemd[1]: Reached target Virtual Machines and Containers.1445machine # [ 7.548108] systemd[1]: Reached target Path Units.1446machine # [ 7.549430] systemd[1]: Reached target Remote File Systems.1447machine # [ 7.550869] systemd[1]: Reached target Slice Units.1448machine # [ 7.552205] systemd[1]: Reached target Swaps.1449machine # [ 7.556262] systemd[1]: Listening on Query the User Interactively for a Password.1450machine # [ 7.561267] systemd[1]: Listening on Process Core Dump Socket.1451machine # [ 7.565076] systemd[1]: Listening on Credential Encryption/Decryption.1452machine # [ 7.568636] systemd[1]: Listening on Factory Reset Management.1453machine # [ 7.570272] systemd[1]: Listening on Hostname Service Socket.1454machine # [ 7.575421] systemd[1]: Starting Journal Log Access Socket...1455machine # [ 7.577768] systemd[1]: Listening on Journal Audit Socket.1456machine # [ 7.581571] systemd[1]: Listening on Console Output Muting Service Socket.1457machine # [ 7.583542] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1458machine # [ 7.585875] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1459machine # [ 7.588185] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1460machine # [ 7.601370] systemd[1]: Listening on Disk Repartitioning Service Socket.1461machine # [ 7.603259] systemd[1]: Listening on udev Varlink Socket.1462machine # [ 7.604895] systemd[1]: Listening on User Database Manager Socket.1463machine # [ 7.610243] systemd[1]: Mounting Huge Pages File System...1464machine # [ 7.614771] systemd[1]: Mounting POSIX Message Queue File System...1465machine # [ 7.622482] systemd[1]: Mounting Kernel Debug File System...1466machine # [ 7.630448] systemd[1]: Mounting Kernel Trace File System...1467machine # [ 7.637392] systemd[1]: Starting Create List of Static Device Nodes...1468machine # [ 7.642602] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1469machine # [ 7.652453] systemd[1]: Starting Load Kernel Module configfs...1470machine # [ 7.654849] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1471machine # [ 7.657684] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1472machine # [ 7.660662] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1473machine # [ 7.673111] systemd[1]: Mounting FUSE Control File System...1474machine # [ 7.675371] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671475machine # [ 7.717331] systemd[1]: Starting Journal Service...1476machine # [ 7.740224] systemd[1]: Starting Load Kernel Modules...1477machine # [ 7.766713] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1478machine # [ 7.782224] systemd[1]: Starting Remount Root and Kernel File Systems...1479sshClient # [ 7.758451] systemd[1]: Populated /etc with preset unit settings.1480machine # [ 7.788160] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1481machine # [ 7.801551] systemd-journald[289]: Collecting audit messages is enabled.1482machine # [ 7.806541] systemd[1]: Starting Coldplug All udev Devices...1483machine # [ 7.832976] systemd[1]: Listening on Journal Log Access Socket.1484machine # [ 7.843483] systemd[1]: Mounted Huge Pages File System.1485machine # [ 7.853325] systemd[1]: Mounted POSIX Message Queue File System.1486machine # [ 7.595566] systemd[1]: Queued start job for default target Multi-User System.[ 7.859860] loop: module loaded1487machine # 1488machine # [ 7.603966] systemd[1]: systemd-journald.service: Deactivated successfully.1489machine # [ 7.868360] systemd[1]: Started Journal Service.1490machine # [ 7.611703] systemd-modules-load[290]: Inserted module 'loop'1491machine # [ 7.620824] systemd[1]: Mounted Kernel Debug File System.1492machine # [ 7.882264] EXT4-fs (vda): re-mounted a14a70c9-7e91-4905-9fc6-c2e2cd9c68c8.1493machine # [ 7.626753] systemd[1]: Mounted Kernel Trace File System.1494machine # [ 7.631805] systemd[1]: Finished Create List of Static Device Nodes.1495machine # [ 7.637500] systemd[1]: modprobe@configfs.service: Deactivated successfully.1496machine # [ 7.640910] systemd[1]: Finished Load Kernel Module configfs.1497machine # [ 7.644471] systemd[1]: Mounted FUSE Control File System.1498machine # [ 7.647608] systemd[1]: Finished Load Kernel Modules.1499machine # [ 7.654216] systemd[1]: Finished Remount Root and Kernel File Systems.1500machine # [ 7.677105] systemd[1]: Listening on Disk Image Download Service Socket.1501machine # [ 7.684346] systemd[1]: Mounting Kernel Configuration File System...1502machine # [ 7.689616] systemd[1]: Starting Firewall...1503machine # [ 7.698546] systemd-oomd[292]: No swap; memory pressure usage will be degraded1504machine # [ 7.706111] systemd[1]: Starting Flush Journal to Persistent Storage...1505machine # [ 7.707935] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1506machine # [ 7.729186] systemd[1]: Starting Load/Save OS Random Seed...1507machine # [ 7.737160] systemd[1]: Starting Apply Kernel Variables...1508machine # [ 7.754553] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1509machine # [ 7.759683] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1510machine # [ 7.766853] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1511machine # [ 8.047081] systemd-journald[289]: Received client request to flush runtime journal.1512machine # [ 8.056311] systemd[1]: Mounted Kernel Configuration File System.1513machine # [ 8.062961] systemd[1]: Finished Load/Save OS Random Seed.1514machine # [ 8.067485] systemd[1]: Finished Apply Kernel Variables.1515machine # [ 8.069471] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1516machine # [ 8.073888] systemd[1]: Starting Create Static Device Nodes in /dev...1517machine # [ 8.075941] systemd[1]: Finished Flush Journal to Persistent Storage.1518machine # [ 8.079328] systemd[1]: Finished Create Static Device Nodes in /dev.1519sshClient # [ 8.310113] systemd[1]: initrd-switch-root.service: Deactivated successfully.1520sshClient # [ 8.312624] systemd[1]: Stopped initrd-switch-root.service.1521machine # [ 8.086380] systemd[1]: Reached target Preparation for Local File Systems.1522sshClient # [ 8.316246] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1523sshClient # [ 8.319640] systemd[1]: Created slice Slice /system/getty.1524sshClient # [ 8.321724] systemd[1]: Created slice User and Session Slice.1525machine # [ 8.093874] systemd[1]: Starting Rule-based Manager for Device Events and Files...1526sshClient # [ 8.323545] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1527sshClient # [ 8.325567] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1528sshClient # [ 8.327411] systemd[1]: Expecting device /dev/hvc0...1529sshClient # [ 8.340983] systemd[1]: Expecting device /dev/ttyS0...1530sshClient # [ 8.342443] systemd[1]: Reached target Local Encrypted Volumes.1531sshClient # [ 8.344173] systemd[1]: Stopped target initrd-fs.target.1532sshClient # [ 8.345617] systemd[1]: Stopped target initrd-root-fs.target.1533sshClient # [ 8.347096] systemd[1]: Stopped target initrd-switch-root.target.1534sshClient # [ 8.348674] systemd[1]: Reached target Virtual Machines and Containers.1535sshClient # [ 8.350341] systemd[1]: Reached target Path Units.1536sshClient # [ 8.351662] systemd[1]: Reached target Remote File Systems.1537sshClient # [ 8.353161] systemd[1]: Reached target Slice Units.1538sshClient # [ 8.354504] systemd[1]: Reached target Swaps.1539sshClient # [ 8.358154] systemd[1]: Listening on Query the User Interactively for a Password.1540sshClient # [ 8.362859] systemd[1]: Listening on Process Core Dump Socket.1541sshClient # [ 8.366404] systemd[1]: Listening on Credential Encryption/Decryption.1542sshClient # [ 8.369745] systemd[1]: Listening on Factory Reset Management.1543sshClient # [ 8.371428] systemd[1]: Listening on Hostname Service Socket.1544sshClient # [ 8.376460] systemd[1]: Starting Journal Log Access Socket...1545sshClient # [ 8.378849] systemd[1]: Listening on Journal Audit Socket.1546sshClient # [ 8.384801] systemd[1]: Listening on Console Output Muting Service Socket.1547sshClient # [ 8.386886] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1548sshClient # [ 8.389283] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1549sshClient # [ 8.391706] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1550sshClient # [ 8.401236] systemd[1]: Listening on Disk Repartitioning Service Socket.1551sshClient # [ 8.403320] systemd[1]: Listening on udev Varlink Socket.1552sshClient # [ 8.405014] systemd[1]: Listening on User Database Manager Socket.1553sshClient # [ 8.409865] systemd[1]: Mounting Huge Pages File System...1554sshClient # [ 8.414294] systemd[1]: Mounting POSIX Message Queue File System...1555sshClient # [ 8.422614] systemd[1]: Mounting Kernel Debug File System...1556machine # [ 8.196365] systemd-udevd[333]: Using default interface naming scheme 'v261'.1557sshClient # [ 8.431339] systemd[1]: Mounting Kernel Trace File System...1558machine # [ 8.203551] systemd[1]: Finished Coldplug All udev Devices.1559sshClient # [ 8.437253] systemd[1]: Starting Create List of Static Device Nodes...1560sshClient # [ 8.441934] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1561sshClient # [ 8.453416] systemd[1]: Starting Load Kernel Module configfs...1562sshClient # [ 8.455732] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1563sshClient # [ 8.458598] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1564sshClient # [ 8.462017] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1565sshClient # [ 8.474164] systemd[1]: Mounting FUSE Control File System...1566sshClient # [ 8.476828] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671567machine # [ 8.252128] systemd[1]: Mounting /run/wrappers...1568machine # [ 8.268257] systemd[1]: Starting User Database Manager...1569machine # [ 8.292958] systemd[1]: Mounted /run/wrappers.1570machine # [ 8.295409] systemd[1]: Reached target Local File Systems.1571sshClient # [ 8.530666] systemd[1]: Starting Journal Service...1572machine # [ 8.302136] systemd[1]: Listening on Boot Loader Control Service Socket.1573machine # [ 8.308159] systemd[1]: Starting Create SUID/SGID Wrappers...1574machine # [ 8.309740] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1575machine # [ 8.315127] systemd[1]: Starting Create System Files and Directories...1576sshClient # [ 8.546333] systemd[1]: Starting Load Kernel Modules...1577sshClient # [ 8.561673] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1578sshClient # [ 8.575666] systemd[1]: Starting Remount Root and Kernel File Systems...1579sshClient # [ 8.584154] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1580machine # [ 8.371442] systemd[1]: Started User Database Manager.1581sshClient # [ 8.602227] systemd-journald[289]: Collecting audit messages is enabled.1582sshClient # [ 8.605483] systemd[1]: Starting Coldplug All udev Devices...1583sshClient # [ 8.636105] systemd[1]: Listening on Journal Log Access Socket.1584sshClient # [ 8.645568] systemd[1]: Mounted Huge Pages File System.1585sshClient # [ 8.652304] loop: module loaded1586sshClient # [ 8.653690] systemd[1]: Mounted POSIX Message Queue File System.1587sshClient # [ 8.399826] systemd[1]: Queued start job for default target Multi-User System.1588sshClient # [ 8.406412] systemd[1]: systemd-journald.service: Deactivated successfully.1589sshClient # [ 8.669335] systemd[1]: Started Journal Service.1590sshClient # [ 8.412630] systemd-modules-load[290]: Inserted module 'loop'[ 8.674179] EXT4-fs (vda): re-mounted 51872491-804b-47ff-9689-9e95a3f0563e.1591sshClient # 1592machine # [ 8.447357] systemd[1]: Finished Create System Files and Directories.1593sshClient # [ 8.420398] systemd[1]: Mounted Kernel Debug File System.1594sshClient # [ 8.427202] systemd[1]: Mounted Kernel Trace File System.1595machine # [ 8.458532] systemd[1]: Starting Rebuild Journal Catalog...1596sshClient # [ 8.434179] systemd[1]: Finished Create List of Static Device Nodes.1597sshClient # [ 8.436583] systemd[1]: modprobe@configfs.service: Deactivated successfully.1598machine # [ 8.467489] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1599sshClient # [ 8.443516] systemd[1]: Finished Load Kernel Module configfs.1600sshClient # [ 8.445451] systemd[1]: Mounted FUSE Control File System.1601sshClient # [ 8.448672] systemd[1]: Finished Load Kernel Modules.1602sshClient # [ 8.454135] systemd[1]: Finished Remount Root and Kernel File Systems.1603sshClient # [ 8.475775] systemd[1]: Listening on Disk Image Download Service Socket.1604sshClient # [ 8.483418] systemd[1]: Mounting Kernel Configuration File System...1605sshClient # [ 8.492110] systemd[1]: Starting Firewall...1606machine # [ 8.520939] systemd[1]: Started Rule-based Manager for Device Events and Files.1607sshClient # [ 8.497567] systemd-oomd[292]: No swap; memory pressure usage will be degraded1608sshClient # [ 8.511602] systemd[1]: Starting Flush Journal to Persistent Storage...1609sshClient # [ 8.514106] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1610machine # [ 8.548141] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1611sshClient # [ 8.529524] systemd[1]: Starting Load/Save OS Random Seed...1612sshClient # [ 8.544552] systemd[1]: Starting Apply Kernel Variables...1613machine # [ 8.592246] systemd[1]: Finished Rebuild Journal Catalog.1614sshClient # [ 8.571163] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1615machine # [ 8.601624] systemd[1]: Starting Update is Completed...1616sshClient # [ 8.576377] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1617sshClient # [ 8.587210] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1618sshClient # [ 8.859668] systemd-journald[289]: Received client request to flush runtime journal.1619machine # [ 8.658694] systemd[1]: Finished Update is Completed.1620machine # [ 8.858673] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1621sshClient # [ 8.883397] systemd[1]: Finished Load/Save OS Random Seed.1622sshClient # [ 8.887342] systemd[1]: Mounted Kernel Configuration File System.1623sshClient # [ 8.892293] systemd[1]: Finished Apply Kernel Variables.1624sshClient # [ 8.895500] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1625sshClient # [ 8.899351] systemd[1]: Starting Create Static Device Nodes in /dev...1626sshClient # [ 8.902334] systemd[1]: Finished Flush Journal to Persistent Storage.1627sshClient # [ 8.905622] systemd[1]: Finished Create Static Device Nodes in /dev.1628sshClient # [ 8.911777] systemd[1]: Reached target Preparation for Local File Systems.1629sshClient # [ 8.918653] systemd[1]: Starting Rule-based Manager for Device Events and Files...1630machine # [ 8.999338] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1631machine # [ 9.013510] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1632machine # [ 9.016330] systemd[1]: Finished Create SUID/SGID Wrappers.1633machine # [ 9.020124] systemd[1]: Reached target System Initialization.1634machine # [ 9.024079] systemd[1]: Started Discard unused filesystem blocks once a week.1635machine # [ 9.027067] systemd[1]: Started Daily Cleanup of Temporary Directories.1636machine # [ 9.029784] systemd[1]: Reached target Timer Units.1637machine # [ 9.031700] systemd[1]: Listening on D-Bus System Message Bus Socket.1638machine # [ 9.036276] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1639machine # [ 9.040107] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1640machine # [ 9.042285] systemd[1]: Reached target Socket Units.1641machine # [ 9.044786] systemd[1]: Reached target Basic System.1642sshClient # [ 9.019778] systemd[1]: Finished Coldplug All udev Devices.1643machine # [ 9.049718] systemd[1]: Starting Import lastlog data into lastlog2 database...1644sshClient # [ 9.029622] systemd-udevd[333]: Using default interface naming scheme 'v261'.1645machine # [ 9.059728] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1646machine # [ 9.075085] systemd[1]: Starting Post-Boot Actions...1647sshClient # [ 9.056273] systemd[1]: Mounting /run/wrappers...1648machine # [ 9.089396] systemd[1]: Started Reset console on configuration changes.1649machine # [ 9.116402] systemd[1]: Starting resolvconf update...1650sshClient # [ 9.096399] systemd[1]: Mounted /run/wrappers.1651sshClient # [ 9.099967] systemd[1]: Reached target Local File Systems.1652sshClient # [ 9.105162] systemd[1]: Listening on Boot Loader Control Service Socket.1653sshClient # [ 9.108981] systemd[1]: Starting Create SUID/SGID Wrappers...1654machine # [ 9.141830] systemd[1]: Starting SSH Host Keys Generation...1655sshClient # [ 9.112082] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1656sshClient # [ 9.115828] systemd[1]: Starting Create System Files and Directories...1657sshClient # [ 9.128355] systemd[1]: Starting User Database Manager...1658machine # [ 9.184826] systemd[1]: Starting Home Area Manager...1659machine # [ 9.203197] (udev-worker)[428]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1660machine # [ 9.213421] (udev-worker)[433]: Network interface NamePolicy= disabled on kernel command line.1661machine # [ 9.217358] (udev-worker)[428]: Network interface NamePolicy= disabled on kernel command line.1662machine # [ 9.230950] systemd[1]: Finished Post-Boot Actions.1663machine # [ 9.245476] nsncd[486]: Sep 11 02:43:31.591 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1664machine # [ 9.252522] systemd[1]: Started Name Service Cache Daemon (nsncd).1665sshClient # [ 9.229788] systemd[1]: Started User Database Manager.1666sshClient # [ 9.235932] systemd[1]: Finished Create System Files and Directories.1667sshClient # [ 9.249645] systemd[1]: Starting Rebuild Journal Catalog...1668sshClient # [ 9.256780] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1669machine # [ 9.296908] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1670machine # [ 9.304406] systemd[1]: Reached target Host and Network Name Lookups.1671machine # [ 9.307384] systemd[1]: Reached target User and Group Name Lookups.1672machine # [ 9.319620] systemd[1]: Started backdoor.service.1673machine # [ 9.336489] systemd[1]: Starting D-Bus System Message Bus...1674sshClient # [ 9.341260] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1675machine # [ 9.373478] systemd-homed[500]: Watching /home.1676machine # [ 9.388128] systemd[1]: Starting User Login Management...1677machine # [ 9.407200] systemd[1]: Finished Import lastlog data into lastlog2 database.1678sshClient # [ 9.391725] systemd[1]: Finished Rebuild Journal Catalog.1679sshClient # [ 9.398939] systemd[1]: Starting Update is Completed...1680sshClient # [ 9.422151] systemd[1]: Started Rule-based Manager for Device Events and Files.1681sshClient # [ 9.459510] systemd[1]: Finished Update is Completed.1682machine # connecting to host...1683machine # [ 9.545336] systemd[1]: Finished Firewall.1684machine: Guest shell says: b'Spawning backdoor root shell...\n'1685machine # [ 9.579298] systemd[1]: Stopped target Host and Network Name Lookups.1686machine # [ 9.580951] systemd[1]: Stopping Host and Network Name Lookups...1687machine # [ 9.582502] systemd[1]: Stopped target User and Group Name Lookups.1688machine: connected to guest root shell1689machine # [ 9.587576] systemd[1]: Stopping User and Group Name Lookups...1690machine: (connecting took 10.60 seconds)1691machine # [ 9.594645] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1692machine: (finished: waiting for the VM to finish booting, in 10.60 seconds)1693machine # [ 9.596274] systemd[1]: nscd.service: Deactivated successfully.1694machine # [ 9.603541] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1695machine # [ 9.613795] dbus-broker-launch[532]: Looking up NSS user entry for 'systemd-timesync'...1696machine # [ 9.637516] dbus-broker-launch[532]: NSS returned no entry for 'systemd-timesync'1697machine # [ 9.639466] dbus-broker-launch[532]: Invalid user-name in /nix/store/q8qwqdnxcwxffczxzr90ylxrb9csvabg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1698machine # [ 9.650996] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1699machine # [ 9.686994] systemd[1]: Started D-Bus System Message Bus.1700machine # [ 9.702388] systemd-logind[543]: New seat seat0.1701machine # [ 9.706829] systemd[1]: Condition check resulted in Virtio network device being skipped.1702machine # [ 9.714138] systemd[1]: Started User Login Management.1703machine # [ 9.730175] systemd[1]: Starting linger-users.service...1704machine # [ 9.769216] dbus-broker-launch[532]: Ready1705sshClient # [ 9.740403] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1706machine # [ 9.782153] nsncd[599]: Sep 11 02:43:32.132 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1707machine # [ 9.806108] systemd[1]: Started Name Service Cache Daemon (nsncd).1708sshClient # [ 9.777639] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1709sshClient # [ 9.783193] systemd[1]: Finished Create SUID/SGID Wrappers.1710sshClient # [ 9.787270] systemd[1]: Reached target System Initialization.1711sshClient # [ 9.789985] systemd[1]: Started Discard unused filesystem blocks once a week.1712sshClient # [ 9.792612] systemd[1]: Started Daily Cleanup of Temporary Directories.1713sshClient # [ 9.796138] systemd[1]: Reached target Timer Units.1714sshClient # [ 9.798259] systemd[1]: Listening on D-Bus System Message Bus Socket.1715sshClient # [ 9.800539] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1716sshClient # [ 9.803409] systemd[1]: Reached target Socket Units.1717sshClient # [ 9.806295] systemd[1]: Reached target Basic System.1718machine # [ 9.841325] systemd[1]: linger-users.service: Deactivated successfully.1719sshClient # [ 9.812605] systemd[1]: Starting Import lastlog data into lastlog2 database...1720machine # [ 9.848929] systemd[1]: Finished linger-users.service.1721sshClient # [ 9.820198] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1722machine # [ 9.856130] systemd[1]: Started Home Area Manager.1723sshClient # [ 9.835503] systemd[1]: Starting Post-Boot Actions...1724machine # [ 9.866624] systemd[1]: Reached target Host and Network Name Lookups.1725machine # [ 9.868383] systemd[1]: Reached target User and Group Name Lookups.1726machine # [ 9.872169] systemd[1]: Finished Home Area Activation.1727machine # [ 9.880992] systemd[1]: Starting First Boot Home Area Wizard...1728sshClient # [ 9.856776] systemd[1]: Started Reset console on configuration changes.1729machine # [ 9.887097] systemd[1]: Finished resolvconf update.1730machine # [ 9.897179] systemd[1]: Reached target Preparation for Network.1731sshClient # [ 9.870917] systemd[1]: Starting resolvconf update...1732machine # [ 9.914468] systemd[1]: Starting DHCP Client...1733machine # [ 9.925189] systemd[1]: Starting Address configuration of eth1...1734machine # [ 9.943992] systemd[1]: Starting Extra networking commands....1735sshClient # [ 9.915445] systemd[1]: Starting Home Area Manager...1736sshClient # [ 9.966633] nsncd[475]: Sep 11 02:43:32.334 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1737sshClient # [ 9.973133] systemd[1]: Started Name Service Cache Daemon (nsncd).1738sshClient # [ 9.986780] systemd[1]: Finished Post-Boot Actions.1739machine # [ 10.019283] systemd[1]: Created slice Slice /system/systemd-mute-console.1740machine # [ 10.033306] systemd[1]: Started Console Output Muting Service (PID 629/UID 0).1741sshClient # [ 10.030984] systemd[1]: Reached target Host and Network Name Lookups.1742sshClient # [ 10.034522] systemd[1]: Reached target User and Group Name Lookups.1743sshClient # [ 10.049546] systemd[1]: Starting D-Bus System Message Bus...1744sshClient # [ 10.075245] systemd[1]: Starting User Login Management...1745sshClient # [ 10.087568] systemd[1]: Finished Import lastlog data into lastlog2 database.1746sshClient # [ 10.099435] systemd-homed[485]: Watching /home.1747sshClient # [ 10.108388] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1748machine # [ 10.145822] network-addresses-eth1-start[632]: adding address 192.168.1.1/24... done1749machine # [ 10.188078] network-addresses-eth1-start[632]: adding address 2001:db8:1::1/64... done1750sshClient # [ 10.194939] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1751machine # [ 10.235224] systemd[1]: Finished Address configuration of eth1.1752sshClient # [ 10.210539] systemd[1]: Started backdoor.service.1753sshClient # [ 10.268340] (udev-worker)[435]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1754sshClient # [ 10.281386] (udev-worker)[440]: Network interface NamePolicy= disabled on kernel command line.1755sshClient # [ 10.288059] (udev-worker)[435]: Network interface NamePolicy= disabled on kernel command line.1756sshClient # [ 10.291179] systemd[1]: Stopped target Host and Network Name Lookups.1757sshClient # [ 10.296463] dbus-broker-launch[509]: Looking up NSS user entry for 'systemd-timesync'...1758sshClient # [ 10.302951] systemd[1]: Stopping Host and Network Name Lookups...1759sshClient # [ 10.305458] systemd[1]: Stopped target User and Group Name Lookups.1760sshClient # [ 10.308545] systemd[1]: Stopping User and Group Name Lookups...1761sshClient # [ 10.314186] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1762sshClient # [ 10.319635] systemd[1]: nscd.service: Deactivated successfully.1763sshClient # [ 10.322355] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1764sshClient # [ 10.326393] dbus-broker-launch[509]: NSS returned no entry for 'systemd-timesync'1765machine # [ 10.361782] dhcpcd[643]: dhcpcd-10.3.2 starting1766sshClient # [ 10.330676] dbus-broker-launch[509]: Invalid user-name in /nix/store/czb5a9cc8yywl0092fqqahcm7h5lc6wq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1767machine # [ 10.378136] dhcpcd[696]: dev: loaded udev1768sshClient # [ 10.345693] systemd-logind[514]: New seat seat0.1769sshClient # [ 10.359327] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1770sshClient # [ 10.361151] systemd[1]: Started User Login Management.1771machine # [ 10.398683] systemd[1]: Finished Extra networking commands..1772machine # [ 10.403606] systemd[1]: Reached target Network.1773sshClient # [ 10.380631] systemd[1]: Finished Firewall.1774sshClient # connecting to host...1775sshClient # [ 10.390297] systemd[1]: Started D-Bus System Message Bus.1776sshClient # [ 10.415909] systemd[1]: Starting linger-users.service...1777sshClient # [ 10.437130] dbus-broker-launch[509]: Ready1778sshClient # [ 10.459080] systemd[1]: Started Home Area Manager.1779sshClient # [ 10.472422] systemd[1]: Finished Home Area Activation.1780sshClient # [ 10.482095] systemd[1]: Starting First Boot Home Area Wizard...1781sshClient # [ 10.483784] systemd[1]: Started Name Service Cache Daemon (nsncd).1782sshClient # [ 10.488375] nsncd[577]: Sep 11 02:43:32.858 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1783sshClient # [ 10.493443] systemd[1]: Reached target Host and Network Name Lookups.1784sshClient # [ 10.498650] systemd[1]: Reached target User and Group Name Lookups.1785sshClient # [ 10.526115] systemd[1]: linger-users.service: Deactivated successfully.1786sshClient # [ 10.531124] systemd[1]: Finished linger-users.service.1787sshClient # [ 10.537241] systemd[1]: Finished resolvconf update.1788sshClient # [ 10.546285] systemd[1]: Reached target Preparation for Network.1789sshClient # [ 10.557190] systemd[1]: Starting DHCP Client...1790sshClient # [ 10.565240] systemd[1]: Starting Extra networking commands....1791sshClient # [ 10.594115] systemd[1]: Condition check resulted in Virtio network device being skipped.1792sshClient # [ 10.609106] systemd[1]: Starting Address configuration of eth1...1793sshClient # [ 10.613658] systemd[1]: Finished First Boot Home Area Wizard.1794sshClient # [ 10.629816] systemd[1]: Reached target First Boot Complete.1795sshClient # [ 10.641245] systemd[1]: Starting Save Transient machine-id to Disk...1796sshClient # [ 10.734185] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1797sshClient # [ 10.747373] systemd[1]: Finished Save Transient machine-id to Disk.1798machine # [ 10.786686] dhcpcd[696]: eth0: waiting for carrier1799machine # [ 10.790056] dhcpcd[696]: libudev: received NULL device1800machine # [ 10.793380] dhcpcd[696]: libudev: received NULL device1801machine # [ 10.795628] dhcpcd[696]: eth0: carrier acquired1802machine # [ 10.815868] dhcpcd[696]: DUID 00:01:00:01:32:36:27:54:52:54:00:12:34:561803machine # [ 10.817623] dhcpcd[696]: eth0: IAID 00:12:34:561804machine # [ 10.820818] dhcpcd[696]: eth0: adding address fe80::5054:ff:fe12:34561805sshClient # [ 10.793436] network-addresses-eth1-start[616]: adding address 192.168.1.2/24... done1806sshClient # [ 10.818118] network-addresses-eth1-start[616]: adding address 2001:db8:1::2/64... done1807sshClient # [ 10.856813] systemd[1]: Finished Address configuration of eth1.1808machine: (finished: waiting for unit systemd-homed.service, in 11.90 seconds)1809machine: waiting for Please enter user name to create to appear on tty 11810sshClient # [ 10.922920] systemd[1]: Finished Extra networking commands..1811sshClient # [ 10.929116] systemd[1]: Reached target Network.1812sshClient # [ 10.936900] systemd[1]: Starting Permit User Sessions...1813sshClient # [ 10.940853] dhcpcd[628]: dhcpcd-10.3.2 starting1814sshClient # [ 10.952983] dhcpcd[683]: dev: loaded udev1815machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 0.10 seconds)1816machine: sending keys 'test-homed-user\n'1817sshClient # [ 11.241732] 8021q: 802.1Q VLAN Support v1.81818sshClient # [ 11.248736] 8021q: adding VLAN 0 to HW filter on device eth11819sshClient # [ 10.993081] systemd[1]: Finished Permit User Sessions.1820sshClient # [ 10.999890] systemd[1]: Started Getty on tty1.1821sshClient # [ 11.003621] systemd[1]: Reached target Login Prompts.1822sshClient # [ 11.279508] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31823sshClient # [ 11.309677] mousedev: PS/2 mouse device common for all mice1824sshClient # [ 11.326135] ACPI: button: Power Button [PWRF]1825machine # [ 11.098258] systemd[1]: Starting Virtual Console Setup...1826machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)1827machine: waiting for Please enter new password for user test-homed-user: to appear on tty 11828sshClient # [ 11.407431] cfg80211: Loading compiled-in X.509 certificates for regulatory database1829sshClient # [ 11.410313] rtc_cmos 00:04: RTC can wake from S41830sshClient # [ 11.429732] parport_pc 00:02: reported by Plug and Play ACPI1831sshClient # [ 11.433925] rtc_cmos 00:04: registered as rtc01832sshClient # [ 11.438872] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1833sshClient # [ 11.446965] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1834machine # [ 11.220281] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1835sshClient # [ 11.451654] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1836sshClient # [ 11.453724] rtc_cmos 00:04: setting system clock to 2026-09-11T02:43:33 UTC (1789094613)1837machine # [ 11.225401] systemd[1]: Stopped Virtual Console Setup.1838sshClient # [ 11.455937] systemd-journald[289]: Time jumped backwards, rotating.1839sshClient # [ 11.460087] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21840sshClient # [ 11.462180] cfg80211: failed to load regulatory.db1841machine # [ 11.233780] systemd-logind[543]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1842sshClient # [ 11.465272] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1843machine # [ 11.251108] systemd-logind[543]: Watching system buttons on /dev/input/event2 (Power Button)1844machine # [ 11.258205] systemd[1]: Starting Virtual Console Setup...1845sshClient # [ 11.304512] dhcpcd[683]: eth0: waiting for carrier1846sshClient # [ 11.307519] dhcpcd[683]: libudev: received NULL device1847sshClient # [ 11.309256] dhcpcd[683]: libudev: received NULL device1848sshClient # [ 11.483577] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41849sshClient # [ 11.499683] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1850sshClient # [ 11.543861] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1851sshClient # [ 11.563147] 8021q: adding VLAN 0 to HW filter on device eth01852sshClient # [ 11.588180] Console: switching to colour dummy device 80x251853sshClient # [ 11.619470] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1854sshClient # [ 11.619602] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1855sshClient # [ 11.654086] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61856sshClient # [ 11.654485] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51857sshClient # [ 11.688543] [drm] Found bochs VGA, ID 0xb0c5.1858sshClient # [ 11.688546] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1859sshClient # [ 11.691440] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1860sshClient # [ 11.692789] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01861sshClient # [ 11.459598] systemd[1]: Starting Virtual Console Setup...1862sshClient # [ 11.512156] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1863sshClient # [ 11.555088] systemd-logind[514]: Watching system buttons on /dev/input/event2 (Power Button)1864sshClient # [ 11.559125] systemd-logind[514]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1865machine # [ 11.605447] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1866sshClient # [ 11.859846] Console: switching to colour frame buffer device 160x501867sshClient # [ 11.894211] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1868sshClient # [ 11.641488] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1869sshClient # [ 11.645116] systemd[1]: Stopped Virtual Console Setup.1870sshClient # [ 11.913822] ppdev: user-space parallel port driver1871sshClient # [ 11.657344] systemd[1]: Starting Virtual Console Setup...1872sshClient # [ 11.715400] systemd-logind[514]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1873sshClient # [ 11.985753] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1874sshClient # [ 11.755559] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1875sshClient # [ 12.017635] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1876sshClient # [ 11.761235] systemd[1]: Stopped Virtual Console Setup.1877machine # [ 11.792599] systemd-logind[543]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1878sshClient # [ 11.768396] dhcpcd[683]: eth0: carrier acquired1879machine # [ 11.798934] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1880sshClient # [ 11.772634] systemd[1]: Starting Virtual Console Setup...1881machine # [ 11.806138] systemd[1]: Stopped Virtual Console Setup.1882sshClient # [ 11.792674] dhcpcd[683]: DUID 00:01:00:01:32:36:27:56:52:54:00:12:34:561883sshClient # [ 11.794543] dhcpcd[683]: eth0: IAID 00:12:34:561884machine # [ 11.824716] systemd[1]: Starting Virtual Console Setup...1885sshClient # [ 11.795922] dhcpcd[683]: eth0: adding address fe80::5054:ff:fe12:34561886machine # [ 11.889258] sshd-keygen-start[539]: Generating public/private rsa key pair.1887machine # [ 11.891532] sshd-keygen-start[539]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1888machine # [ 11.894761] sshd-keygen-start[539]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1889machine # [ 11.897164] sshd-keygen-start[539]: The key fingerprint is:1890machine # [ 11.898914] sshd-keygen-start[539]: SHA256:VG+XwEGWMzLA+dl4M2QlC9dVLPEXXtpJUhiT3uZw6UE root@machine1891sshClient # [ 12.130552] kvm_amd: TSC scaling supported1892sshClient # [ 12.131473] kvm_amd: Nested Virtualization enabled1893machine # [ 11.902172] sshd-keygen-start[539]: The key's randomart image is:1894sshClient # [ 12.132898] kvm_amd: Nested Paging enabled1895machine # [ 11.903967] sshd-keygen-start[539]: +---[RSA 4096]----+1896sshClient # [ 12.134131] kvm_amd: LBR virtualization supported1897sshClient # [ 12.135313] kvm_amd: Virtual VMLOAD VMSAVE supported1898machine # [ 11.905759] sshd-keygen-start[539]: | ..oooBOBB=|1899sshClient # [ 12.136568] kvm_amd: Virtual GIF supported1900sshClient # [ 12.137658] kvm_amd: Virtual NMI enabled1901machine # [ 11.907571] sshd-keygen-start[539]: | o.o=B*BE=|1902machine # [ 11.909403] sshd-keygen-start[539]: | .. O=o*+=|1903machine # [ 11.911152] sshd-keygen-start[539]: | . +.=+ *.|1904machine # [ 11.913563] sshd-keygen-start[539]: | S . o* .|1905machine # [ 11.915512] sshd-keygen-start[539]: | o |1906machine # [ 11.917394] sshd-keygen-start[539]: | |1907machine # [ 11.919227] sshd-keygen-start[539]: | |1908machine # [ 11.921371] sshd-keygen-start[539]: | |1909machine # [ 11.923371] sshd-keygen-start[539]: +----[SHA256]-----+1910sshClient # [ 12.180944] EDAC MC: Ver: 3.0.01911machine # [ 11.966133] sshd-keygen-start[761]: Generating public/private ed25519 key pair.1912machine # [ 11.968434] sshd-keygen-start[761]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1913machine # [ 11.970880] sshd-keygen-start[761]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1914machine # [ 11.973276] sshd-keygen-start[761]: The key fingerprint is:1915machine # [ 11.974814] sshd-keygen-start[761]: SHA256:QSWtuVvRz3CDiVSaIffeovtYShpQZotwZRYOciUbLcY root@machine1916machine # [ 11.977720] sshd-keygen-start[761]: The key's randomart image is:1917machine # [ 11.979722] sshd-keygen-start[761]: +--[ED25519 256]--+1918machine # [ 11.981556] sshd-keygen-start[761]: | ..=oX++.. |1919machine # [ 11.983304] sshd-keygen-start[761]: | oE@.+o= |1920machine # [ 11.985187] sshd-keygen-start[761]: | ..o.*+oo.o |1921machine # [ 11.986824] sshd-keygen-start[761]: | o =ooo.=.o |1922machine # [ 11.988862] sshd-keygen-start[761]: | o S. .o=.. |1923machine # [ 11.990379] sshd-keygen-start[761]: | .. .. .o |1924machine # [ 11.992259] sshd-keygen-start[761]: | .oo . |1925machine # [ 11.994481] sshd-keygen-start[761]: | .+ = |1926machine # [ 11.996479] sshd-keygen-start[761]: | . +.. |1927machine # [ 11.998510] sshd-keygen-start[761]: +----[SHA256]-----+1928machine # [ 12.001113] systemd[1]: sshd-keygen.service: Deactivated successfully.1929machine # [ 12.002833] systemd[1]: Finished SSH Host Keys Generation.1930machine # [ 12.006588] systemd[1]: Starting SSH Daemon...1931machine # [ 12.060951] sshd[763]: Server listening on 0.0.0.0 port 22.1932machine # [ 12.062631] sshd[763]: Server listening on :: port 22.1933machine # [ 12.065188] systemd[1]: Started SSH Daemon.1934machine # [ 12.212245] dhcpcd[696]: eth0: soliciting an IPv6 router1935machine # [ 12.214413] dhcpcd[696]: eth0: Router Advertisement from fe80::21936machine # [ 12.216128] dhcpcd[696]: eth0: adding address fec0::5054:ff:fe12:3456/641937machine # [ 12.217952] dhcpcd[696]: eth0: adding route to fec0::/641938machine # [ 12.219477] dhcpcd[696]: eth0: adding default route via fe80::21939machine # [ 12.301757] systemd-vconsole-setup[754]: Configuration of first virtual console was skipped, ignoring remaining ones.1940machine # [ 12.305996] dhcpcd[696]: eth0: soliciting a DHCP lease1941machine # [ 12.310231] systemd[1]: Finished Virtual Console Setup.1942sshClient # [ 12.291184] systemd-vconsole-setup[711]: Configuration of first virtual console was skipped, ignoring remaining ones.1943sshClient # [ 12.296681] systemd[1]: Finished Virtual Console Setup.1944machine # [ 12.336514] dhcpcd[696]: eth0: offered 10.0.2.15 from 10.0.2.21945machine # [ 12.339222] dhcpcd[696]: eth0: probing address 10.0.2.15/241946machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.19 seconds)1947machine: sending keys 'foobarfoo\n'1948machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1949machine: waiting for (repeat) to appear on tty 11950sshClient # [ 12.885625] dhcpcd[683]: eth0: soliciting an IPv6 router1951sshClient # [ 12.890724] dhcpcd[683]: eth0: Router Advertisement from fe80::21952sshClient # [ 12.894842] dhcpcd[683]: eth0: adding address fec0::5054:ff:fe12:3456/641953sshClient # [ 12.899123] dhcpcd[683]: eth0: adding route to fec0::/641954sshClient # [ 12.902702] dhcpcd[683]: eth0: adding default route via fe80::21955sshClient # [ 12.975484] dhcpcd[683]: eth0: soliciting a DHCP lease1956sshClient # [ 13.267561] NET: Registered PF_PACKET protocol family1957sshClient # [ 13.016712] dhcpcd[683]: eth0: offered 10.0.2.15 from 10.0.2.21958sshClient # [ 13.023590] dhcpcd[683]: eth0: probing address 10.0.2.15/241959machine: (finished: waiting for (repeat) to appear on tty 1, in 1.14 seconds)1960machine: sending keys 'foobarfoo\n'1961machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1962machine: waiting for unit systemd-homed-firstboot.service1963machine # [ 17.402677] dhcpcd[696]: eth0: leased 10.0.2.15 for 86400 seconds1964machine # [ 17.407506] dhcpcd[696]: eth0: adding route to 10.0.2.0/241965machine # [ 17.411484] dhcpcd[696]: eth0: adding default route via 10.0.2.21966machine # [ 17.553168] systemd[1]: Started DHCP Client.1967sshClient # [ 18.436749] dhcpcd[683]: eth0: leased 10.0.2.15 for 86400 seconds1968sshClient # [ 18.442391] dhcpcd[683]: eth0: adding route to 10.0.2.0/241969sshClient # [ 18.446760] dhcpcd[683]: eth0: adding default route via 10.0.2.21970sshClient # [ 18.583344] systemd[1]: Started DHCP Client.1971sshClient # [ 18.587326] systemd[1]: Reached target Multi-User System.1972sshClient # [ 18.589280] systemd[1]: Startup finished in 1.060s (kernel) + 5.177s (initrd) + 12.350s (userspace) = 18.588s.1973machine # [ 23.861519] systemd-homed[500]: Generating key pair for signing local user identity records.1974machine # [ 23.863776] systemd-homed[500]: Successfully created Ed25519 key pair.1975machine # [ 23.879710] systemd-homed[500]: test-homed-user: changing state absent → creating1976machine # [ 23.950328] systemd-homework[887]: Using automatic default storage of 'luks'.1977machine # [ 23.956923] systemd-homework[887]: Sizing home to 83% of available disk space, which is 743M.1978machine # [ 23.959752] systemd-homework[887]: Allocating image file completed.1979machine # [ 23.980876] systemd-homework[887]: Writing of partition table completed.1980machine # [ 23.985106] systemd-homework[887]: Setting up loopback device /dev/loop0 completed.1981machine # [ 25.359281] systemd-homework[887]: LUKS formatting completed.1982machine # [ 27.084702] systemd-homework[887]: Writing password to LUKS keyslot 0 completed.1983machine # [ 27.380907] systemd-homework[887]: LUKS activation by volume key succeeded.1984machine # [ 27.397678] systemd-homework[887]: Writing user record as LUKS token completed.1985machine # [ 27.400096] systemd-homework[887]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.1986machine # [ 27.402416] systemd-homework[887]: Formatting /dev/mapper/home-test-homed-user as btrfs1987machine # [ 27.795888] systemd-homework[887]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid 0a1736b6-6fb5-4b16-a31c-29fecaa60769)1988machine # [ 27.799498] systemd-homework[887]: Formatting file system completed.1989machine # [ 27.802823] systemd[1]: proc-923-mounts.mount: Deactivated successfully.1990machine # [ 27.847265] systemd-homework[887]: Mounting file system completed.1991machine # [ 27.850955] systemd-homework[887]: Skeleton directory /etc/skel missing, ignoring.1992machine # [ 27.852961] systemd-homework[887]: Wrote embedded .identity file.1993machine # [ 27.855511] systemd-homework[887]: Replaced embedded blob dir with contents of system blob dir.1994machine # [ 27.857882] systemd-homework[887]: Recursive changing of ownership completed.1995machine # [ 27.859941] systemd-homework[887]: Changed top-level directory access mode to 0700.1996machine # [ 27.865463] systemd-homework[887]: Synchronized disk.1997machine # [ 27.868176] systemd-homework[887]: Discarded unused 651.8M.1998machine # [ 27.881374] systemd-homed[500]: block device /sys/devices/virtual/block/dm-0 has been removed.1999machine # [ 27.893085] systemd-homed[500]: block device /sys/devices/virtual/block/dm-0 has been removed.2000machine # [ 27.926763] systemd-homed[500]: block device /sys/devices/virtual/block/loop0 has been removed.2001machine # [ 27.964197] systemd-homework[887]: Moved image file into place.2002machine # [ 27.966155] systemd-homework[887]: Creation completed.2003machine # [ 27.969529] systemd-homework[887]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M.2004machine # [ 27.979845] systemd-homed[500]: test-homed-user: changing state creating → inactive2005machine # [ 27.987610] systemd[1]: Finished First Boot Home Area Wizard.2006machine # [ 27.991617] systemd[1]: systemd-mute-console@0-1-629_630-0.service: Deactivated successfully.2007machine # [ 27.998681] systemd[1]: Reached target First Boot Complete.2008machine # [ 28.003240] systemd[1]: Starting Save Transient machine-id to Disk...2009machine # [ 28.008577] systemd[1]: Starting Permit User Sessions...2010machine # [ 28.044395] systemd[1]: Finished Permit User Sessions.2011machine # [ 28.051409] systemd[1]: Started Getty on tty1.2012machine # [ 28.054340] systemd[1]: Reached target Login Prompts.2013machine # [ 28.056549] systemd[1]: Reached target Multi-User System.2014machine # [ 28.061334] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2015machine # [ 28.065835] systemd[1]: Finished Save Transient machine-id to Disk.2016machine # [ 28.070123] systemd[1]: Startup finished in 1.067s (kernel) + 4.259s (initrd) + 22.741s (userspace) = 28.069s.2017machine: (finished: waiting for unit systemd-homed-firstboot.service, in 15.07 seconds)2018(finished: subtest: create systemd-homed user on first boot prompt, in 29.77 seconds)2019machine: must succeed: homectl update test-homed-user --offline -G wheel2020machine # [ 28.808937] systemd-homed[500]: test-homed-user: changing state inactive → updating2021machine # [ 28.815966] systemd-homework[969]: Offline update requested. Not touching embedded records.2022machine # [ 28.818636] systemd-homed[500]: Home test-homed-user is signed exclusively by our key, accepting.2023machine # [ 28.825223] systemd-homed[500]: test-homed-user: changing state updating → inactive2024machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.06 seconds)2025subtest: login as homed user2026machine: waiting for login: to appear on tty 12027machine: (finished: waiting for login: to appear on tty 1, in 0.05 seconds)2028machine: sending keys 'test-homed-user\n'2029machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)2030machine: waiting for Password: to appear on tty 12031machine # [ 29.258296] systemd-homed[500]: test-homed-user: changing state inactive → activating-for-acquire2032machine # [ 29.265671] systemd-homework[984]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2033machine # [ 29.272354] systemd-homed[500]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2034machine # [ 29.275694] systemd-homed[500]: test-homed-user: changing state activating-for-acquire → inactive2035machine # [ 29.277913] systemd-homed[500]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2036machine # [ 29.280635] systemd-homed[500]: Home test-homed-user already deactivated, no automatic deactivation needed.2037machine: (finished: waiting for Password: to appear on tty 1, in 1.15 seconds)2038machine: sending keys 'foobarfoo\n'2039machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2040machine: waiting for success: pgrep -u test-homed-user -t tty1 bash2041machine # [ 30.390331] systemd-homed[500]: test-homed-user: changing state inactive → activating-for-acquire2042machine # [ 30.421870] systemd-homework[996]: Provided password unlocks user record.2043machine # [ 30.432947] systemd-homework[996]: Successfully locked image file '/home/test-homed-user.home'.2044machine # [ 30.440095] systemd-homework[996]: Allocated additional 651.8M.2045machine # [ 30.704041] loop1: detected capacity change from 0 to 15175682046machine # [ 30.445744] systemd-homework[996]: Setting up loopback device /dev/loop1 completed.2047machine # [ 31.333127] systemd-homework[996]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2048machine # [ 31.361991] systemd-homework[996]: Provided password unlocks user record.2049machine # [ 31.368514] systemd-homework[996]: Probing file system completed (found btrfs).2050machine # [ 31.374549] systemd-homework[996]: No fsck for file system btrfs installed, ignoring.2051machine # [ 31.637743] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (996)2052machine # [ 31.640944] BTRFS info (device dm-0): first mount of filesystem 0a1736b6-6fb5-4b16-a31c-29fecaa607692053machine # [ 31.643713] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2054machine # [ 31.648383] BTRFS info (device dm-0): enabling free space tree2055machine # [ 31.649560] BTRFS info (device dm-0): use zstd compression, level 12056machine # [ 31.391239] systemd-homework[996]: Mounting file system completed.2057machine # [ 31.394143] systemd-homework[996]: Discovered used loopback device /dev/loop1.2058machine # [ 31.396045] systemd-homework[996]: offset = 1048576, size = 776994816, image = 7790919682059machine # [ 31.408482] systemd-homework[996]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M.2060machine # [ 31.411760] systemd-homework[996]: Growing of image file from 743M to 896M completed.2061machine # [ 31.678026] loop1: detected capacity change from 1517568 to 18309122062machine # [ 31.421377] systemd-homework[996]: Refreshing loop device size completed.2063machine # [ 31.438937] systemd-homework[996]: Growing of partition completed.2064machine # [ 31.734300] async_tx: api initialized (async)2065machine # [ 31.520228] systemd-homework[996]: LUKS device growing completed.2066machine # [ 31.785898] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 9206497282067machine # [ 31.529253] systemd-homework[996]: File system resizing from 725M to 878M completed.2068machine # [ 31.534101] systemd-homework[996]: Synchronized disk.2069machine # [ 31.535578] systemd-homework[996]: Synchronized disk.2070machine # [ 31.538081] systemd-homework[996]: Resizing completed.2071machine # [ 31.539646] systemd-homework[996]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2072machine # [ 31.542727] systemd-homework[996]: Read embedded .identity file.2073machine # [ 31.563869] systemd-homework[996]: Provided password unlocks user record.2074machine # [ 31.566289] systemd-homework[996]: Reconciling header user identity completed (host version was newer).2075machine # [ 31.568568] systemd-homework[996]: Reconciling embedded user identity completed (host version was newer).2076machine # [ 31.586609] systemd-homework[996]: Wrote LUKS header user record.2077machine # [ 31.589126] systemd-homework[996]: Wrote embedded .identity file.2078machine # [ 31.590906] systemd-homework[996]: Replaced embedded blob dir with contents of system blob dir.2079machine # [ 31.593319] systemd-homework[996]: Recursive changing of ownership not necessary, skipped.2080machine # [ 31.598575] systemd-homework[996]: Synchronized disk.2081machine # [ 31.599961] systemd-homework[996]: Moving to final mount point /home/test-homed-user completed.2082machine # [ 31.620376] systemd-homework[996]: Activation completed.2083machine # [ 31.621883] systemd-homework[996]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2084machine # [ 31.635719] systemd-homed[500]: Home test-homed-user is signed exclusively by our key, accepting.2085machine # [ 31.642342] login[960]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired.2086machine # [ 31.645121] systemd-homed[500]: test-homed-user: changing state activating-for-acquire → active2087machine # [ 31.654341] systemd-homed[500]: test-homed-user: changing state active → resizing-while-active2088machine # [ 31.668502] systemd-homework[1041]: Successfully acquired home volume key from kernel keyring.2089machine # [ 31.672506] systemd-homework[1041]: LUKS volume key from keyring unlocks user record.2090machine # [ 31.765345] login[960]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0)2091machine # [ 31.793480] systemd-homework[1041]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2092machine # [ 31.828358] systemd[1]: Created slice Slice /user/60388.2093machine # [ 31.834836] systemd[1]: Starting User Runtime Directory /run/user/60388...2094machine # [ 31.854832] systemd-logind[543]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'.2095machine # [ 31.913233] systemd[1]: Finished User Runtime Directory /run/user/60388.2096machine # [ 31.936136] systemd[1]: Starting User Manager for UID 60388...2097machine # [ 31.990189] (systemd)[1046]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2098machine # [ 32.079455] (systemd)[1046]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2099machine # [ 32.095446] systemd-logind[543]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2100machine # [ 32.140465] systemd[1046]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2101machine # [ 32.161341] systemd-homework[1041]: Successfully re-activated LUKS device.2102machine # [ 32.165856] systemd-homework[1041]: LUKS volume key from keyring unlocks user record.2103machine # [ 32.168938] systemd-homework[1041]: Discovered used loopback device /dev/loop1.2104machine # [ 32.171214] systemd-homework[1041]: Read embedded .identity file.2105machine # [ 32.173733] systemd-homework[1041]: LUKS volume key from keyring unlocks user record.2106machine # [ 32.178375] systemd-homework[1041]: Reconciling header user identity completed (host version was newer).2107machine # [ 32.180694] systemd-homework[1041]: Reconciling embedded user identity completed (host version was newer).2108machine # [ 32.183221] systemd-homework[1041]: offset = 1048576, size = 937426944, image = 9395240962109machine # [ 32.197152] systemd-homework[1041]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M.2110machine # [ 32.201735] systemd-homework[1041]: Wrote embedded .identity file.2111machine # [ 32.204195] systemd-homework[1041]: Replaced embedded blob dir with contents of system blob dir.2112machine # [ 32.206408] systemd-homework[1041]: Backing file is fully allocated already.2113machine # [ 32.471324] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 7822376962114machine # [ 32.216313] systemd-homework[1041]: File system resizing from 878M to 746M completed.2115machine # [ 32.218860] systemd-homework[1041]: Synchronized disk.2116machine # [ 32.268700] systemd-homework[1041]: LUKS device shrinking completed.2117machine # [ 32.532412] loop1: detected capacity change from 1830912 to 15605762118machine # [ 32.277143] systemd-homework[1041]: Refreshing loop device size completed.2119machine # [ 32.279923] systemd-homework[1041]: Shrinking of image file completed.2120machine # [ 32.303635] systemd-homework[1041]: Shrinking of partition completed.2121machine # [ 32.323531] systemd-homework[1041]: Wrote LUKS header user record.2122machine # [ 32.327796] systemd-homework[1041]: Synchronized disk.2123machine # [ 32.332631] systemd-homework[1041]: Resizing completed.2124machine # [ 32.334477] systemd-homework[1041]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2125machine # [ 32.346187] systemd-homed[500]: Home test-homed-user is signed exclusively by our key, accepting.2126machine # [ 32.356804] systemd-homed[500]: test-homed-user: changing state resizing-while-active → active2127machine # [ 32.361315] systemd-homed[500]: Rebalancing complete.2128machine # [ 32.459857] systemd[1046]: Queued start job for default target Main User Target.2129machine # [ 32.464424] systemd[1046]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2130machine # [ 32.475158] systemd[1046]: Created slice User Application Slice.2131machine # [ 32.478320] systemd[1046]: Started Daily Cleanup of User's Temporary Directories.2132machine # [ 32.480340] systemd[1046]: Reached target Paths.2133machine # [ 32.481879] systemd[1046]: Reached target Timers.2134machine # [ 32.486731] systemd[1046]: Starting D-Bus User Message Bus Socket...2135machine # [ 32.491363] systemd[1046]: Starting Create User Files and Directories...2136machine # [ 32.540170] systemd[1046]: Finished Create User Files and Directories.2137machine # [ 32.587813] systemd[1046]: Listening on D-Bus User Message Bus Socket.2138machine # [ 32.590091] systemd[1046]: Reached target Sockets.2139machine # [ 32.593199] systemd[1046]: Reached target Basic System.2140machine # [ 32.595548] systemd[1]: Started User Manager for UID 60388.2141machine # [ 32.600528] systemd[1]: Started Session 1 of User test-homed-user.2142machine # [ 32.604158] systemd[1046]: Starting Run user-specific NixOS activation...2143machine # [ 32.659416] systemd[1046]: Finished Run user-specific NixOS activation.2144machine # [ 32.662935] systemd[1046]: Reached target Main User Target.2145machine # [ 32.664649] systemd[1046]: Startup finished in 537ms.2146machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 3.34 seconds)2147machine: sending keys 'whoami > /tmp/2\n'2148machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.17 seconds)2149machine: waiting for file '/tmp/2'2150machine: (finished: waiting for file '/tmp/2', in 1.10 seconds)2151machine: must succeed: cat /tmp/22152machine: (finished: must succeed: cat /tmp/2, in 0.04 seconds)2153(finished: subtest: login as homed user, in 6.12 seconds)2154subtest: login as regular user2155sshClient: waiting for login: to appear on tty 12156sshClient: waiting for the VM to finish booting2157sshClient: Guest shell says: b'Spawning backdoor root shell...\n'2158sshClient: connected to guest root shell2159sshClient: (connecting took 0.00 seconds)2160sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds)2161sshClient: (finished: waiting for login: to appear on tty 1, in 0.09 seconds)2162sshClient: sending keys 'test-normal-user\n'2163sshClient: (finished: sending keys 'test-normal-user\n', in 0.18 seconds)2164sshClient: waiting for Password: to appear on tty 12165sshClient: (finished: waiting for Password: to appear on tty 1, in 1.13 seconds)2166sshClient: sending keys 'foobarfoo\n'2167sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2168sshClient: waiting for success: pgrep -u test-normal-user bash2169sshClient # [ 36.523816] login[686]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0)2170sshClient # [ 36.566354] systemd[1]: Created slice Slice /user/1000.2171sshClient # [ 36.570744] systemd[1]: Starting User Runtime Directory /run/user/1000...2172sshClient # [ 36.584604] systemd-logind[514]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'.2173sshClient # [ 36.624184] systemd[1]: Finished User Runtime Directory /run/user/1000.2174sshClient # [ 36.634326] systemd[1]: Starting User Manager for UID 1000...2175sshClient # [ 36.693795] (systemd)[814]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0)2176sshClient # [ 36.704579] systemd-logind[514]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'.2177sshClient # [ 36.747107] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2178sshClient # [ 36.975884] systemd[814]: Queued start job for default target Main User Target.2179sshClient # [ 36.980926] systemd[814]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2180sshClient # [ 36.993636] systemd[814]: Created slice User Application Slice.2181sshClient # [ 36.995671] systemd[814]: Started Daily Cleanup of User's Temporary Directories.2182sshClient # [ 36.998915] systemd[814]: Reached target Paths.2183sshClient # [ 37.000594] systemd[814]: Reached target Timers.2184sshClient # [ 37.004117] systemd[814]: Starting D-Bus User Message Bus Socket...2185sshClient # [ 37.008652] systemd[814]: Starting Create User Files and Directories...2186sshClient # [ 37.048383] systemd[814]: Finished Create User Files and Directories.2187sshClient # [ 37.090848] systemd[814]: Listening on D-Bus User Message Bus Socket.2188sshClient # [ 37.093182] systemd[814]: Reached target Sockets.2189sshClient # [ 37.094849] systemd[814]: Reached target Basic System.2190sshClient # [ 37.098166] systemd[1]: Started User Manager for UID 1000.2191sshClient # [ 37.103710] systemd[814]: Starting Run user-specific NixOS activation...2192sshClient # [ 37.106302] systemd[1]: Started Session 1 of User test-normal-user.2193sshClient # [ 37.155902] systemd[814]: Finished Run user-specific NixOS activation.2194sshClient # [ 37.158354] systemd[814]: Reached target Main User Target.2195sshClient # [ 37.160590] systemd[814]: Startup finished in 428ms.2196sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.16 seconds)2197sshClient: sending keys 'whoami > /tmp/1\n'2198sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds)2199sshClient: waiting for file '/tmp/1'2200sshClient: (finished: waiting for file '/tmp/1', in 1.07 seconds)2201sshClient: must succeed: cat /tmp/12202sshClient: (finished: must succeed: cat /tmp/1, in 0.04 seconds)2203(finished: subtest: login as regular user, in 3.95 seconds)2204subtest: add homed ssh authorized key2205sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n'2206sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds)2207sshClient: waiting for file '/tmp/id_ed25519.pub'2208sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.08 seconds)2209sshClient: must succeed: cat /tmp/id_ed25519.pub2210sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.02 seconds)2211machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILPZXhy2Agbee7GNtZYag2Mw5z/6Um9dgV44Z8ThCD1d test-normal-user@sshClient'2212machine # [ 40.549320] systemd-homed[500]: test-homed-user: changing state active → updating-while-active2213machine # [ 40.560990] systemd-homework[1100]: Offline update requested. Not touching embedded records.2214machine # [ 40.568910] systemd-homed[500]: test-homed-user: changing state updating-while-active → active2215machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAILPZXhy2Agbee7GNtZYag2Mw5z/6Um9dgV44Z8ThCD1d test-normal-user@sshClient', in 0.09 seconds)2216machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed255192217machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.03 seconds)2218(finished: subtest: add homed ssh authorized key, in 1.71 seconds)2219subtest: change homed user password2220machine: sending keys 'passwd; echo $? > /tmp/3\n'2221machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds)2222machine: waiting for New password: to appear on tty 12223machine: (finished: waiting for New password: to appear on tty 1, in 1.17 seconds)2224machine: sending keys 'barfoobar\n'2225machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2226machine: waiting for Retype new password: to appear on tty 12227machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.16 seconds)2228machine: sending keys 'barfoobar\n'2229machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2230??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead.2231 File "/nix/store/3gycnalwgpix76jjky7ljgh88gwgdb0l-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 5732232machine: must succeed: sleep 4.02233machine # [ 43.576392] systemd-homed[500]: test-homed-user: changing state active → passwd-while-active2234machine # [ 44.290401] systemd-homework[1139]: No valid password for LUKS superblock.2235machine # [ 46.592530] systemd-homed[500]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2236machine # [ 46.595800] systemd-homed[500]: test-homed-user: changing state passwd-while-active → active2237machine: (finished: must succeed: sleep 4.0, in 4.05 seconds)2238machine: sending keys 'foobarfoo\n'2239machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2240machine: waiting for file '/tmp/3'2241machine # [ 47.698098] systemd-homed[500]: test-homed-user: changing state active → passwd-while-active2242machine # [ 49.053076] systemd-homework[1144]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2243machine # [ 49.190362] systemd-homework[1144]: Successfully re-activated LUKS device.2244machine # [ 49.234615] systemd-homework[1144]: Provided password unlocks user record.2245machine # [ 49.236923] systemd-homework[1144]: Discovered used loopback device /dev/loop1.2246machine # [ 49.238936] systemd-homework[1144]: Read embedded .identity file.2247machine # [ 49.281138] systemd-homework[1144]: Provided password unlocks user record.2248machine # [ 49.283076] systemd-homework[1144]: Reconciling header user identity completed (host version was newer).2249machine # [ 49.285340] systemd-homework[1144]: Reconciling embedded user identity completed (host version was newer).2250machine # [ 52.338071] systemd-homework[1144]: Added LUKS key slot 1.2251machine # [ 52.363907] systemd-homework[1144]: Destroyed LUKS key slot 0.2252machine # [ 52.375887] systemd-homework[1144]: Wrote LUKS header user record.2253machine # [ 52.377887] systemd-homework[1144]: Wrote embedded .identity file.2254machine # [ 52.379757] systemd-homework[1144]: Replaced embedded blob dir with contents of system blob dir.2255machine # [ 52.386699] systemd-homework[1144]: Synchronized disk.2256machine # [ 52.391115] systemd-homework[1144]: Everything completed.2257machine # [ 52.403400] systemd-homed[500]: test-homed-user: changing state passwd-while-active → active2258machine # [ 52.405784] passwd[1113]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user.2259machine: (finished: waiting for file '/tmp/3', in 5.21 seconds)2260machine: must succeed: cat /tmp/32261machine: (finished: must succeed: cat /tmp/3, in 0.04 seconds)2262(finished: subtest: change homed user password, in 12.21 seconds)2263subtest: escalate to root from homed user2264machine: sending keys 'sudo id | tee /tmp/4\n'2265machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds)2266machine: waiting for password for test-homed-user to appear on tty 12267machine # [ 53.317209] systemd-homed[500]: test-homed-user: changing state active → authenticating-for-acquire2268machine # [ 53.324338] systemd-homework[1180]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2269machine # [ 53.367626] systemd-homed[500]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2270machine # [ 53.371427] systemd-homed[500]: test-homed-user: changing state authenticating-for-acquire → active2271machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.16 seconds)2272machine: sending keys 'barfoobar\n'2273machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2274machine: waiting for file '/tmp/4'2275machine: (finished: waiting for file '/tmp/4', in 0.05 seconds)2276machine: waiting for success: grep uid=0 /tmp/42277machine # [ 54.383714] systemd-homed[500]: test-homed-user: changing state active → authenticating-for-acquire2278machine # [ 54.415847] systemd-homework[1196]: Provided password unlocks user record.2279machine # [ 55.036919] systemd-homework[1196]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2280machine # [ 55.169616] systemd-homework[1196]: Successfully re-activated LUKS device.2281machine # [ 55.193435] systemd-homework[1196]: Provided password unlocks user record.2282machine # [ 55.195720] systemd-homework[1196]: Discovered used loopback device /dev/loop1.2283machine # [ 55.197646] systemd-homework[1196]: Read embedded .identity file.2284machine # [ 55.218813] systemd-homework[1196]: Provided password unlocks user record.2285machine # [ 55.221388] systemd-homework[1196]: Reconciling user identities completed (host and header version were identical).2286machine # [ 55.224219] systemd-homework[1196]: Reconciling embedded user identity completed (host and embedded version were identical).2287machine # [ 55.234934] systemd-homework[1196]: Everything completed.2288machine # [ 55.241148] systemd-homed[500]: Home test-homed-user is signed exclusively by our key, accepting.2289machine # [ 55.249094] systemd-homed[500]: test-homed-user: changing state authenticating-for-acquire → active2290machine # [ 55.252052] sudo[1178]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired.2291machine # [ 55.261521] sudo[1178]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id2292machine # [ 55.281068] sudo[1178]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388)2293machine # [ 55.297622] sudo[1178]: pam_unix(sudo:session): session closed for user root2294machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.09 seconds)2295(finished: subtest: escalate to root from homed user, in 2.62 seconds)2296subtest: log out and deactivate homed user's home area2297machine: sending keys 'exit\n'2298machine: (finished: sending keys 'exit\n', in 0.05 seconds)2299machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive'2300machine # [ 55.533641] login[960]: pam_unix(login:session): session closed for user test-homed-user2301machine # [ 55.540103] login[960]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used.2302machine # [ 55.551481] systemd[1]: getty@tty1.service: Deactivated successfully.2303machine # [ 55.562186] systemd[1]: session-1.scope: Deactivated successfully.2304machine # [ 55.571110] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2305machine # [ 55.573572] systemd-logind[543]: Session 1 logged out. Waiting for processes to exit.2306machine # [ 55.580832] systemd[1]: Started Getty on tty1.2307machine # [ 55.584601] systemd-logind[543]: Removed session 1.2308machine # [ 65.659350] systemd[1]: Stopping User Manager for UID 60388...2309machine # [ 65.676731] systemd[1046]: Activating special unit Exit the Session...2310machine # [ 65.683992] systemd[1046]: Stopped target Main User Target.2311machine # [ 65.692532] systemd[1046]: Stopped Run user-specific NixOS activation.2312machine # [ 65.701595] systemd[1046]: Stopped target Basic System.2313machine # [ 65.705872] systemd[1046]: Stopped target Paths.2314machine # [ 65.711703] systemd[1046]: Stopped target Sockets.2315machine # [ 65.716509] systemd[1046]: Stopped target Timers.2316machine # [ 65.720593] systemd[1046]: Stopped Daily Cleanup of User's Temporary Directories.2317machine # [ 65.727227] systemd[1046]: Closed D-Bus User Message Bus Socket.2318machine # [ 65.729111] systemd[1046]: Stopped Create User Files and Directories.2319machine # [ 65.730864] systemd[1046]: Removed slice User Application Slice.2320machine # [ 65.732570] systemd[1046]: Reached target Shutdown.2321machine # [ 65.734175] systemd[1046]: Finished Exit the Session.2322machine # [ 65.735706] systemd[1046]: Reached target Exit the Session.2323machine # [ 65.741470] systemd-logind[543]: Removed session 2.2324machine # [ 65.744534] systemd-homed[500]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2325machine # [ 65.748558] systemd-homed[500]: test-homed-user: changing state active → deactivating2326machine # [ 65.750717] systemd[1]: user@60388.service: Deactivated successfully.2327machine # [ 65.753445] systemd[1]: Stopped User Manager for UID 60388.2328machine # [ 65.760742] systemd-homework[1276]: Successfully acquired home volume key from kernel keyring.2329machine # [ 65.765227] systemd-homework[1276]: Discarded unused 673.3M.2330machine # [ 65.773411] systemd-homework[1276]: Syncing completed.2331machine # [ 65.781623] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully.2332machine # [ 65.793483] systemd[1]: Stopping User Runtime Directory /run/user/60388...2333machine # [ 65.844158] systemd[1]: run-user-60388.mount: Deactivated successfully.2334machine # [ 65.847094] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully.2335machine # [ 65.852271] systemd[1]: Stopped User Runtime Directory /run/user/60388.2336machine # [ 65.856806] systemd-homework[1276]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2337machine # [ 65.992397] systemd-homework[1276]: Successfully re-activated LUKS device.2338machine # [ 65.994389] systemd-homework[1276]: Discovered used loopback device /dev/loop1.2339machine # [ 65.996870] systemd-homework[1276]: offset = 1048576, size = 799014912, image = 8011120642340machine # [ 66.008322] systemd-homework[1276]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M.2341machine # [ 66.012041] systemd-homework[1276]: Allocated additional 673.3M.2342machine # [ 66.277270] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 2684354562343machine # [ 66.019510] systemd-homework[1276]: File system resizing from 746M to 256M completed.2344machine # [ 66.021626] systemd-homework[1276]: Synchronized disk.2345machine # [ 66.198411] systemd-homework[1276]: LUKS device shrinking completed.2346machine # [ 66.460963] loop1: detected capacity change from 1560576 to 5570562347machine # [ 66.203673] systemd-homework[1276]: Refreshing loop device size completed.2348machine # [ 66.206700] systemd-homework[1276]: Shrinking of image file completed.2349machine # [ 66.225265] systemd-homework[1276]: Shrinking of partition completed.2350machine # [ 66.487086] BTRFS info (device dm-0): last unmount of filesystem 0a1736b6-6fb5-4b16-a31c-29fecaa607692351machine # [ 66.229136] systemd-homework[1276]: Synchronized disk.2352machine # [ 66.230503] systemd-homework[1276]: Resizing completed.2353machine # [ 66.232088] systemd-homework[1276]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M.2354machine # [ 66.239360] systemd-homework[1276]: Unmounting completed.2355machine # [ 66.240892] systemd-homework[1276]: Discovered used LUKS device /dev/mapper/home-test-homed-user.2356machine # [ 66.244284] systemd-homework[1276]: Device home-test-homed-user is not active.2357machine # [ 66.257548] systemd-homed[500]: block device /sys/devices/virtual/block/dm-0 has been removed.2358machine # [ 66.264494] systemd-homework[1276]: Everything completed.2359machine # [ 66.274309] systemd-homed[500]: test-homed-user: changing state deactivating → inactive2360machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 10.80 seconds)2361(finished: subtest: log out and deactivate homed user's home area, in 10.85 seconds)2362subtest: ssh as homed user2363sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n'2364sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.78 seconds)2365sshClient: waiting for Please enter password for user to appear on tty 12366machine # [ 68.195321] systemd-homed[500]: test-homed-user: changing state inactive → activating-for-acquire2367machine # [ 68.203173] systemd-homework[1304]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2368machine # [ 68.210859] systemd-homed[500]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2369machine # [ 68.214580] systemd-homed[500]: test-homed-user: changing state activating-for-acquire → inactive2370machine # [ 68.217289] systemd-homed[500]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2371machine # [ 68.220806] sshd-session[1300]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error2372machine # [ 68.223816] systemd-homed[500]: Home test-homed-user already deactivated, no automatic deactivation needed.2373machine # [ 68.227252] sshd-session[1300]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation.2374machine # [ 68.231195] sshd-session[1300]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 50030 ssh2: ED25519 SHA256:PQCSrI0rEsRXexZ+2pOUpAdwBIm3BUfrhH4R2nJUI+w2375machine # [ 68.305184] sshd-session[1300]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0)2376machine # [ 68.327382] systemd[1]: Starting User Runtime Directory /run/user/60388...2377machine # [ 68.332471] systemd-logind[543]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'.2378machine # [ 68.373268] systemd[1]: Finished User Runtime Directory /run/user/60388.2379machine # [ 68.380868] systemd[1]: Started Session 3 of User test-homed-user.2380machine # [ 68.414116] sshd-session[1300]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2381machine # [ 68.419907] sshd-session[1300]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2382machine # [ 68.444201] systemd-homed[500]: test-homed-user: changing state inactive → activating2383machine # [ 68.452751] systemd-homework[1309]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2384machine # [ 68.460114] systemd-homed[500]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2385machine # [ 68.463827] systemd-homed[500]: test-homed-user: changing state activating → inactive2386sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.24 seconds)2387sshClient: sending keys 'barfoobar\n'2388sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2389machine: waiting for success: pgrep -u test-homed-user bash2390machine # [ 69.505462] systemd-homed[500]: test-homed-user: changing state inactive → activating2391machine # [ 69.534262] systemd-homework[1314]: Provided password unlocks user record.2392machine # [ 69.544606] systemd-homework[1314]: Successfully locked image file '/home/test-homed-user.home'.2393machine # [ 69.551911] systemd-homework[1314]: Backing file is fully allocated already.2394machine # [ 69.816278] loop1: detected capacity change from 0 to 5570562395machine # [ 69.557667] systemd-homework[1314]: Setting up loopback device /dev/loop1 completed.2396machine # [ 70.443127] systemd-homework[1314]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2397machine # [ 70.471904] systemd-homework[1314]: Provided password unlocks user record.2398machine # [ 70.478305] systemd-homework[1314]: Probing file system completed (found btrfs).2399machine # [ 70.480856] systemd-homework[1314]: No fsck for file system btrfs installed, ignoring.2400machine # [ 70.744329] BTRFS: device label test-homed-user devid 1 transid 17 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1314)2401machine # [ 70.747816] BTRFS info (device dm-0): first mount of filesystem 0a1736b6-6fb5-4b16-a31c-29fecaa607692402machine # [ 70.750682] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2403machine # [ 70.755835] BTRFS info (device dm-0): enabling free space tree2404machine # [ 70.757005] BTRFS info (device dm-0): use zstd compression, level 12405machine # [ 70.498696] systemd-homework[1314]: Mounting file system completed.2406machine # [ 70.501617] systemd-homework[1314]: Discovered used loopback device /dev/loop1.2407machine # [ 70.504119] systemd-homework[1314]: offset = 1048576, size = 285212672, image = 2873098242408machine # [ 70.513763] systemd-homework[1314]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M.2409machine # [ 70.516742] systemd-homework[1314]: Growing of image file from 274M to 764M completed.2410machine # [ 70.779961] loop1: detected capacity change from 557056 to 15605762411machine # [ 70.525107] systemd-homework[1314]: Refreshing loop device size completed.2412machine # [ 70.542445] systemd-homework[1314]: Growing of partition completed.2413machine # [ 70.607841] systemd-homework[1314]: LUKS device growing completed.2414machine # [ 70.876139] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 7822376962415machine # [ 70.618442] systemd-homework[1314]: File system resizing from 256M to 746M completed.2416machine # [ 70.621212] systemd-homework[1314]: Synchronized disk.2417machine # [ 70.622741] systemd-homework[1314]: Synchronized disk.2418machine # [ 70.625183] systemd-homework[1314]: Resizing completed.2419machine # [ 70.626620] systemd-homework[1314]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2420machine # [ 70.629599] systemd-homework[1314]: Read embedded .identity file.2421machine # [ 70.650369] systemd-homework[1314]: Provided password unlocks user record.2422machine # [ 70.652841] systemd-homework[1314]: Reconciling user identities completed (host and header version were identical).2423machine # [ 70.655366] systemd-homework[1314]: Reconciling embedded user identity completed (host and embedded version were identical).2424machine # [ 70.658352] systemd-homework[1314]: Recursive changing of ownership not necessary, skipped.2425machine # [ 70.660799] systemd-homework[1314]: Synchronized disk.2426machine # [ 70.663683] systemd-homework[1314]: Moving to final mount point /home/test-homed-user completed.2427machine # [ 70.685882] systemd-homework[1314]: Activation completed.2428machine # [ 70.687555] systemd-homework[1314]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2429machine # [ 70.700308] systemd-homed[500]: Home test-homed-user is signed exclusively by our key, accepting.2430machine # [ 70.708213] systemd-homed[500]: test-homed-user: changing state activating → active2431machine # [ 70.726385] systemd[1]: Starting User Manager for UID 60388...2432machine # [ 70.765732] (systemd)[1359]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2433machine # [ 70.834604] (systemd)[1359]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2434machine # [ 70.842927] systemd-logind[543]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2435machine # [ 70.881681] systemd[1359]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2436machine # [ 71.062706] systemd[1359]: Queued start job for default target Main User Target.2437machine # [ 71.067056] systemd[1359]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2438machine # [ 71.071609] systemd[1359]: Created slice User Application Slice.2439machine # [ 71.073529] systemd[1359]: Started Daily Cleanup of User's Temporary Directories.2440machine # [ 71.075612] systemd[1359]: Reached target Paths.2441machine # [ 71.078281] systemd[1359]: Reached target Timers.2442machine # [ 71.083103] systemd[1359]: Starting D-Bus User Message Bus Socket...2443machine # [ 71.086867] systemd[1359]: Starting Create User Files and Directories...2444machine # [ 71.131043] systemd[1359]: Finished Create User Files and Directories.2445machine # [ 71.135555] systemd[1359]: Listening on D-Bus User Message Bus Socket.2446machine # [ 71.137714] systemd[1359]: Reached target Sockets.2447machine # [ 71.139305] systemd[1359]: Reached target Basic System.2448machine # [ 71.142803] systemd[1]: Started User Manager for UID 60388.2449machine # [ 71.148211] systemd[1359]: Starting Run user-specific NixOS activation...2450machine # [ 71.196405] systemd[1359]: Finished Run user-specific NixOS activation.2451machine # [ 71.198930] systemd[1359]: Reached target Main User Target.2452machine # [ 71.201503] systemd[1359]: Startup finished in 329ms.2453machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.26 seconds)2454sshClient: sending keys 'whoami > /tmp/5\n'2455sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.17 seconds)2456machine: waiting for file '/tmp/5'2457machine: (finished: waiting for file '/tmp/5', in 1.06 seconds)2458machine: must succeed: cat /tmp/52459machine: (finished: must succeed: cat /tmp/5, in 0.03 seconds)2460sshClient: sending keys 'exit\n'2461sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2462sshClient: sending keys 'exit\n'2463machine # [ 73.035850] sshd-session[1307]: Received disconnect from 2001:db8:1::2 port 50030:11: disconnected by user2464sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2465(finished: subtest: ssh as homed user, in 6.75 seconds)2466(finished: run the VM test script, in 74.37 seconds)2467machine # [ 73.046747] sshd-session[1307]: Disconnected from user test-homed-user 2001:db8:1::2 port 500302468machine # [ 73.052862] sshd-session[1300]: pam_unix(sshd:session): session closed for user test-homed-user2469machine # [ 73.057179] sshd-session[1300]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used.2470machine # [ 73.064882] systemd[1]: session-3.scope: Deactivated successfully.2471machine # [ 73.070290] systemd-logind[543]: Session 3 logged out. Waiting for processes to exit.2472machine # [ 73.074169] systemd-logind[543]: Removed session 3.2473sshClient # [ 73.104795] login[686]: pam_unix(login:session): session closed for user test-normal-user2474sshClient # [ 73.121692] systemd[1]: getty@tty1.service: Deactivated successfully.2475sshClient # [ 73.141213] systemd[1]: session-1.scope: Deactivated successfully.2476sshClient # [ 73.146314] systemd[1]: session-1.scope: Consumed 205ms CPU time over 36.034s wall clock time, 7.5M memory peak, 4K written to disk, 26.6K incoming IP traffic, 25.5K outgoing IP traffic.2477sshClient # [ 73.152280] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2478sshClient # [ 73.156361] systemd-logind[514]: Session 1 logged out. Waiting for processes to exit.2479sshClient # [ 73.160427] systemd[1]: Started Getty on tty1.2480sshClient # [ 73.163276] systemd-logind[514]: Removed session 1.2481test script finished in 74.54s2482cleanup2483kill QemuMachine (pid 47)2484machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2485kill QemuMachine (pid 48)2486sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2487(finished: cleanup, in 0.29 seconds)2488additionally exposed symbols:2489 machine, sshClient,2490 vlan1,2491 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