vm-test-run-systemd-homed
checks.x86_64-linux.systemd-homed
· build #64
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7start all VMs8machine: starting vm9sshClient: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 47)12sshClient # Disk image does not exist, creating the virtualisation disk image...13sshClient: QEMU running (pid 48)14sshClient # Formatting '/build/vm-state-sshClient/tmp.fDq9YRUEEY', fmt=raw size=107374182415machine # Formatting '/build/vm-state-machine/tmp.IrtfbMmgZP', fmt=raw size=107374182416sshClient # mke2fs 1.47.4 (6-Mar-2025)17machine # mke2fs 1.47.4 (6-Mar-2025)18sshClient # Discarding device blocks: 0/262144 done19machine # Discarding device blocks: 0/262144 done20sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes21machine # Creating filesystem with 262144 4k blocks and 65536 inodes22sshClient # Filesystem UUID: b7059297-a5ff-439c-8f84-1858122c801723(finished: start all VMs, in 0.64 seconds)24sshClient # Superblock backups stored on blocks:25subtest: create systemd-homed user on first boot prompt26sshClient # 32768, 98304, 163840, 22937627machine: waiting for unit systemd-homed.service28sshClient # 29machine: waiting for the VM to finish booting30sshClient # Allocating group tables: 0/8 done31machine # Filesystem UUID: 7c51f664-6b92-46e8-988a-d9be9058db8132sshClient # Writing inode tables: 0/8 done33machine # Superblock backups stored on blocks:34sshClient # Creating journal (8192 blocks): done35machine # 32768, 98304, 163840, 22937636sshClient # Writing superblocks and filesystem accounting information: 0/8 done37machine # 38sshClient # 39machine # Allocating group tables: 0/8 done40sshClient # Virtualisation disk image created.41machine # Writing inode tables: 0/8 done42sshClient # Starting virtiofs daemons...43machine # Creating journal (8192 blocks): done44sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)45machine # Writing superblocks and filesystem accounting information: 0/8 done46sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether47machine # 48sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...49machine # Virtualisation disk image created.50sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests51machine # Starting virtiofs daemons...52sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)53machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)54sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether55machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether56sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...57machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)58sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests59machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether60sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)61machine # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...62sshClient # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether63machine # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests64sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...65machine # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...66sshClient # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests67machine # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests68machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)69machine # [2026-10-22T03:07:07Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether70machine # [2026-10-22T03:07:07Z INFO virtiofsd] Waiting for vhost-user socket connection...71machine # [2026-10-22T03:07:07Z INFO virtiofsd] Client connected, servicing requests72machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)73sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)74sshClient # 75sshClient # 76machine # 77machine # 78sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0079machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0080sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)...81sshClient # 82sshClient # 83sshClient # 84sshClient # 85machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...86machine # 87machine # 88machine # 89machine # 90sshClient # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0091machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0092machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...93machine # 94machine # 95sshClient # Press Ctrl-B to configure iPXE (PCI 00:05.0)...96sshClient # 97sshClient # 98machine # Booting from ROM...99sshClient # Booting from ROM...100machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1792058300101machine # [ 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/70g6p2yffrnb6lxqrk2zjwr15phylwr7-nixos-system-machine-test/init regInfo=/nix/.ro-store/gh1cysx8aa94cgszsxi5678crvnvd8rm-closure-info/registration console=ttyS0,115200n8 console=tty0102machine # [ 0.000000] BIOS-provided physical RAM map:103machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable104machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved105machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved106machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable107machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved108machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved109machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved110machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved111machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved112machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved113machine # [ 0.000000] NX (Execute Disable) protection: active114machine # [ 0.000000] APIC: Static calls initialized115machine # [ 0.000000] SMBIOS 2.8 present.116machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014117machine # [ 0.000000] DMI: Memory slots populated: 1/1118machine # [ 0.000000] Hypervisor detected: KVM119machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000120machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00121machine # [ 0.000001] kvm-clock: using sched offset of 492923448 cycles122machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns123machine # [ 0.000006] tsc: Detected 2400.008 MHz processor124machine # [ 0.000766] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000125machine # [ 0.000794] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs126machine # [ 0.000796] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT127machine # [ 0.002705] found SMP MP-table at [mem 0x000f5450-0x000f545f]128machine # [ 0.002717] Using GB pages for direct mapping129machine # [ 0.002828] RAMDISK: [mem 0x3e335000-0x3ffcffff]130machine # [ 0.002836] ACPI: Early table checksum verification disabled131machine # [ 0.002839] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )132machine # [ 0.002843] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)133machine # [ 0.002847] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)134machine # [ 0.002855] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)135machine # [ 0.002857] ACPI: FACS 0x000000003FFE0000 000040136machine # [ 0.002858] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)137machine # [ 0.002860] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)138machine # [ 0.002862] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)139machine # [ 0.002863] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)140machine # [ 0.002864] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]141machine # [ 0.002865] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]142machine # [ 0.002866] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]143machine # [ 0.002866] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]144machine # [ 0.002867] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]145machine # [ 0.002867] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]146machine # [ 0.002868] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]147machine # [ 0.003092] No NUMA configuration found148machine # [ 0.003093] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]149machine # [ 0.003095] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]150machine # [ 0.005254] Zone ranges:151machine # [ 0.005256] DMA [mem 0x0000000000001000-0x0000000000ffffff]152machine # [ 0.005257] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]153machine # [ 0.005258] Normal empty154machine # [ 0.005259] Device empty155machine # [ 0.005260] Movable zone start for each node156machine # [ 0.005261] Early memory node ranges157machine # [ 0.005261] node 0: [mem 0x0000000000001000-0x000000000009efff]158machine # [ 0.005262] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]159machine # [ 0.005263] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]160machine # [ 0.005282] On node 0, zone DMA: 1 pages in unavailable ranges161machine # [ 0.005539] On node 0, zone DMA: 97 pages in unavailable ranges162machine # [ 0.022426] On node 0, zone DMA32: 40 pages in unavailable ranges163machine # [ 0.022882] ACPI: PM-Timer IO Port: 0x608164machine # [ 0.022894] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])165machine # [ 0.022921] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23166machine # [ 0.022924] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)167machine # [ 0.022925] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)168machine # [ 0.022926] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)169machine # [ 0.022927] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)170machine # [ 0.022928] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)171machine # [ 0.022931] ACPI: Using ACPI (MADT) for SMP configuration information172machine # [ 0.022932] ACPI: HPET id: 0x8086a201 base: 0xfed00000173machine # [ 0.022936] TSC deadline timer available174machine # [ 0.022940] CPU topo: Max. logical packages: 1175machine # [ 0.022941] CPU topo: Max. logical dies: 1176machine # [ 0.022941] CPU topo: Max. dies per package: 1177sshClient # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @1792058300178machine # [ 0.022944] CPU topo: Max. threads per core: 1179machine # [ 0.022945] CPU topo: Num. cores per package: 1180machine # [ 0.022945] CPU topo: Num. threads per package: 1181machine # [ 0.022946] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs182machine # [ 0.022965] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()183machine # [ 0.022994] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]184sshClient # [ 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/fi5wi6w23z4hxhp8w9s2li85rkv09p73-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/2wmdzz5iby1v7ryvk7yk9nvqczcaw3v4-closure-info/registration console=ttyS0,115200n8 console=tty0185sshClient # [ 0.000000] BIOS-provided physical RAM map:186machine # [ 0.022996] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]187machine # [ 0.022997] [mem 0x40000000-0xafffffff] available for PCI devices188sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable189machine # [ 0.022998] Booting paravirtualized kernel on KVM190sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved191sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved192machine # [ 0.023001] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns193sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable194machine # [ 0.027657] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1195sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved196machine # [ 0.029748] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152197machine # [ 0.029792] kvm-guest: PV spinlocks disabled, single CPU198sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved199sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved200sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved201sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved202sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved203machine # [ 0.029793] 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/70g6p2yffrnb6lxqrk2zjwr15phylwr7-nixos-system-machine-test/init regInfo=/nix/.ro-store/gh1cysx8aa94cgszsxi5678crvnvd8rm-closure-info/registration console=ttyS0,115200n8 console=tty0204sshClient # [ 0.000000] NX (Execute Disable) protection: active205sshClient # [ 0.000000] APIC: Static calls initialized206sshClient # [ 0.000000] SMBIOS 2.8 present.207machine # [ 0.029886] Unknown kernel command line parameters "regInfo=/nix/.ro-store/gh1cysx8aa94cgszsxi5678crvnvd8rm-closure-info/registration", will be passed to user space.208machine # [ 0.029899] random: crng init done209sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014210sshClient # [ 0.000000] DMI: Memory slots populated: 1/1211machine # [ 0.029899] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes212sshClient # [ 0.000000] Hypervisor detected: KVM213machine # [ 0.030936] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)214sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000215sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00216machine # [ 0.030950] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)217sshClient # [ 0.000001] kvm-clock: using sched offset of 553252053 cycles218machine # [ 0.030980] Fallback order for Node 0: 0219machine # [ 0.030983] Built 1 zonelists, mobility grouping on. Total pages: 262006220machine # [ 0.030984] Policy zone: DMA32221sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns222sshClient # [ 0.000005] tsc: Detected 2400.008 MHz processor223machine # [ 0.033048] mem auto-init: stack:all(zero), heap alloc:on, heap free:off224sshClient # [ 0.000766] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000225machine # [ 0.035619] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1226machine # [ 0.037762] allocated 2097152 bytes of page_ext227sshClient # [ 0.000793] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs228machine # [ 0.047523] ftrace: allocating 48987 entries in 192 pages229sshClient # [ 0.000795] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT230machine # [ 0.047525] ftrace: allocated 192 pages with 2 groups231machine # [ 0.048366] Dynamic Preempt: lazy232sshClient # [ 0.002783] found SMP MP-table at [mem 0x000f5450-0x000f545f]233sshClient # [ 0.002796] Using GB pages for direct mapping234machine # [ 0.048525] rcu: Preemptible hierarchical RCU implementation.235sshClient # [ 0.002881] RAMDISK: [mem 0x3e335000-0x3ffcffff]236machine # [ 0.048526] rcu: RCU event tracing is enabled.237sshClient # [ 0.002894] ACPI: Early table checksum verification disabled238machine # [ 0.048526] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.239sshClient # [ 0.002898] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )240machine # [ 0.048528] Trampoline variant of Tasks RCU enabled.241machine # [ 0.048528] Rude variant of Tasks RCU enabled.242sshClient # [ 0.002903] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)243machine # [ 0.048529] Tracing variant of Tasks RCU enabled.244sshClient # [ 0.002908] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)245machine # [ 0.048529] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.246machine # [ 0.048530] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1247sshClient # [ 0.002917] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)248sshClient # [ 0.002919] ACPI: FACS 0x000000003FFE0000 000040249machine # [ 0.048540] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.250sshClient # [ 0.002921] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)251machine # [ 0.048541] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.252sshClient # [ 0.002923] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)253machine # [ 0.048542] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.254sshClient # [ 0.002925] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)255machine # [ 0.052779] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16256sshClient # [ 0.002927] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)257machine # [ 0.053048] rcu: srcu_init: Setting srcu_struct sizes based on contention.258sshClient # [ 0.002928] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]259machine # [ 0.053055] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns260sshClient # [ 0.002929] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]261machine # [ 0.053160] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)262sshClient # [ 0.002930] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]263machine # [ 0.056666] Console: colour VGA+ 80x25264sshClient # [ 0.002930] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]265machine # [ 0.056669] printk: legacy console [tty0] enabled266machine # [ 0.087546] printk: legacy console [ttyS0] enabled267sshClient # [ 0.002931] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]268machine # [ 0.184714] ACPI: Core revision 20250807269sshClient # [ 0.002931] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]270sshClient # [ 0.002932] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]271sshClient # [ 0.003244] No NUMA configuration found272machine # [ 0.185573] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns273sshClient # [ 0.003245] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]274machine # [ 0.187079] APIC: Switch to symmetric I/O mode setup275sshClient # [ 0.003248] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]276machine # [ 0.188019] x2apic enabled277sshClient # [ 0.005754] Zone ranges:278sshClient # [ 0.005755] DMA [mem 0x0000000000001000-0x0000000000ffffff]279machine # [ 0.188760] APIC: Switched APIC routing to: physical x2apic280sshClient # [ 0.005757] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]281sshClient # [ 0.005758] Normal empty282sshClient # [ 0.005759] Device empty283sshClient # [ 0.005760] Movable zone start for each node284machine # [ 0.190580] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1285sshClient # [ 0.005760] Early memory node ranges286sshClient # [ 0.005761] node 0: [mem 0x0000000000001000-0x000000000009efff]287machine # [ 0.191560] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns288sshClient # [ 0.005762] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]289sshClient # [ 0.005763] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]290machine # [ 0.193211] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)291sshClient # [ 0.005789] On node 0, zone DMA: 1 pages in unavailable ranges292sshClient # [ 0.006135] On node 0, zone DMA: 97 pages in unavailable ranges293machine # [ 0.194295] x86/cpu: User Mode Instruction Prevention (UMIP) activated294sshClient # [ 0.023348] On node 0, zone DMA32: 40 pages in unavailable ranges295sshClient # [ 0.023819] ACPI: PM-Timer IO Port: 0x608296machine # [ 0.195335] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127297sshClient # [ 0.023831] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])298machine # [ 0.196208] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0299sshClient # [ 0.023862] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23300sshClient # [ 0.023865] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)301machine # [ 0.197211] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto302sshClient # [ 0.023866] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)303sshClient # [ 0.023868] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)304machine # [ 0.199208] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl305sshClient # [ 0.023869] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)306machine # [ 0.200209] Transient Scheduler Attacks: Vulnerable: No microcode307sshClient # [ 0.023869] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)308machine # [ 0.201208] Spectre V2 : Mitigation: Enhanced / Automatic IBRS309sshClient # [ 0.023872] ACPI: Using ACPI (MADT) for SMP configuration information310sshClient # [ 0.023873] ACPI: HPET id: 0x8086a201 base: 0xfed00000311machine # [ 0.202208] Speculative Return Stack Overflow: Mitigation: Safe RET312sshClient # [ 0.023877] TSC deadline timer available313sshClient # [ 0.023881] CPU topo: Max. logical packages: 1314sshClient # [ 0.023882] CPU topo: Max. logical dies: 1315sshClient # [ 0.023882] CPU topo: Max. dies per package: 1316sshClient # [ 0.023886] CPU topo: Max. threads per core: 1317sshClient # [ 0.023887] CPU topo: Num. cores per package: 1318sshClient # [ 0.023887] CPU topo: Num. threads per package: 1319machine # [ 0.203208] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization320sshClient # [ 0.023887] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs321machine # [ 0.205214] Spectre V2 : Enabling IBPB for BPF322sshClient # [ 0.023908] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()323sshClient # [ 0.023939] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]324machine # [ 0.206209] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier325sshClient # [ 0.023941] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]326machine # [ 0.207208] active return thunk: srso_alias_return_thunk327sshClient # [ 0.023942] [mem 0x40000000-0xafffffff] available for PCI devices328sshClient # [ 0.023944] Booting paravirtualized kernel on KVM329machine # [ 0.208229] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'330machine # [ 0.209208] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'331sshClient # [ 0.023947] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns332machine # [ 0.210208] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'333sshClient # [ 0.028648] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1334sshClient # [ 0.031064] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152335machine # [ 0.211208] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'336sshClient # [ 0.031119] kvm-guest: PV spinlocks disabled, single CPU337machine # [ 0.212208] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'338machine # [ 0.213208] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'339machine # [ 0.214208] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'340sshClient # [ 0.031121] 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/fi5wi6w23z4hxhp8w9s2li85rkv09p73-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/2wmdzz5iby1v7ryvk7yk9nvqczcaw3v4-closure-info/registration console=ttyS0,115200n8 console=tty0341machine # [ 0.216208] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256342machine # [ 0.217135] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64343sshClient # [ 0.031216] Unknown kernel command line parameters "regInfo=/nix/.ro-store/2wmdzz5iby1v7ryvk7yk9nvqczcaw3v4-closure-info/registration", will be passed to user space.344machine # [ 0.217929] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512345sshClient # [ 0.031230] random: crng init done346machine # [ 0.218941] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024347sshClient # [ 0.031230] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes348machine # [ 0.219928] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8349sshClient # [ 0.032459] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)350sshClient # [ 0.032477] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)351sshClient # [ 0.032514] Fallback order for Node 0: 0352machine # [ 0.220924] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.353sshClient # [ 0.032517] Built 1 zonelists, mobility grouping on. Total pages: 262006354sshClient # [ 0.032518] Policy zone: DMA32355sshClient # [ 0.034862] mem auto-init: stack:all(zero), heap alloc:on, heap free:off356sshClient # [ 0.037343] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1357sshClient # [ 0.039496] allocated 2097152 bytes of page_ext358sshClient # [ 0.049108] ftrace: allocating 48987 entries in 192 pages359sshClient # [ 0.049110] ftrace: allocated 192 pages with 2 groups360sshClient # [ 0.050030] Dynamic Preempt: lazy361sshClient # [ 0.050211] rcu: Preemptible hierarchical RCU implementation.362sshClient # [ 0.050212] rcu: RCU event tracing is enabled.363sshClient # [ 0.050213] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.364sshClient # [ 0.050214] Trampoline variant of Tasks RCU enabled.365sshClient # [ 0.050215] Rude variant of Tasks RCU enabled.366sshClient # [ 0.050215] Tracing variant of Tasks RCU enabled.367sshClient # [ 0.050216] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.368sshClient # [ 0.050217] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1369sshClient # [ 0.050226] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.370sshClient # [ 0.050228] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.371sshClient # [ 0.050229] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.372sshClient # [ 0.055646] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16373sshClient # [ 0.055943] rcu: srcu_init: Setting srcu_struct sizes based on contention.374sshClient # [ 0.055951] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns375sshClient # [ 0.056057] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)376sshClient # [ 0.059955] Console: colour VGA+ 80x25377sshClient # [ 0.059959] printk: legacy console [tty0] enabled378sshClient # [ 0.090304] printk: legacy console [ttyS0] enabled379sshClient # [ 0.187807] ACPI: Core revision 20250807380sshClient # [ 0.188710] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns381sshClient # [ 0.190223] APIC: Switch to symmetric I/O mode setup382sshClient # [ 0.191165] x2apic enabled383sshClient # [ 0.191902] APIC: Switched APIC routing to: physical x2apic384sshClient # [ 0.193717] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1385sshClient # [ 0.194692] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns386sshClient # [ 0.196330] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)387sshClient # [ 0.197418] x86/cpu: User Mode Instruction Prevention (UMIP) activated388sshClient # [ 0.198435] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127389sshClient # [ 0.199327] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0390machine # [ 0.255057] Freeing SMP alternatives memory: 48K391sshClient # [ 0.200330] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto392machine # [ 0.255759] pid_max: default: 32768 minimum: 301393sshClient # [ 0.202326] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl394machine # [ 0.256337] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima395sshClient # [ 0.203327] Transient Scheduler Attacks: Vulnerable: No microcode396machine # [ 0.257305] landlock: Up and running.397machine # [ 0.258209] Yama: becoming mindful.398sshClient # [ 0.204326] Spectre V2 : Mitigation: Enhanced / Automatic IBRS399machine # [ 0.259404] LSM support for eBPF active400sshClient # [ 0.205326] Speculative Return Stack Overflow: Mitigation: Safe RET401machine # [ 0.260127] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)402machine # [ 0.261228] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)403sshClient # [ 0.206326] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization404sshClient # [ 0.208334] Spectre V2 : Enabling IBPB for BPF405machine # [ 0.263609] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)406sshClient # [ 0.209327] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier407machine # [ 0.264764] Performance Events: Fam17h+ core perfctr, AMD PMU driver.408sshClient # [ 0.210327] active return thunk: srso_alias_return_thunk409machine # [ 0.265217] ... version: 2410machine # [ 0.265900] ... bit width: 48411sshClient # [ 0.211348] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'412machine # [ 0.266210] ... generic counters: 6413sshClient # [ 0.212326] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'414machine # [ 0.266916] ... generic bitmap: 000000000000003f415sshClient # [ 0.213327] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'416machine # [ 0.267210] ... fixed-purpose counters: 0417machine # [ 0.267921] ... fixed-purpose bitmap: 0000000000000000418sshClient # [ 0.214326] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'419machine # [ 0.268210] ... value mask: 0000ffffffffffff420sshClient # [ 0.215326] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'421machine # [ 0.269056] ... max period: 00007fffffffffff422sshClient # [ 0.216326] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'423machine # [ 0.269865] ... global_ctrl mask: 000000000000003f424machine # [ 0.270329] signal: max sigframe size: 3376425sshClient # [ 0.217326] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'426machine # [ 0.271124] rcu: Hierarchical SRCU implementation.427sshClient # [ 0.219287] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256428machine # [ 0.271805] rcu: Max phase no-delay instances is 400.429sshClient # [ 0.220326] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64430sshClient # [ 0.221326] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512431sshClient # [ 0.222326] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024432sshClient # [ 0.223326] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8433sshClient # [ 0.224326] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.434machine # [ 0.276886] smp: Bringing up secondary CPUs ...435machine # [ 0.277225] smp: Brought up 1 node, 1 CPU436machine # [ 0.277913] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)437machine # [ 0.278395] Memory: 934704K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105956K reserved, 0K cma-reserved)438machine # [ 0.279481] devtmpfs: initialized439machine # [ 0.280296] x86/mm: Memory block size: 128MB440machine # [ 0.281952] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)441machine # [ 0.283120] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).442machine # [ 0.284293] pinctrl core: initialized pinctrl subsystem443machine # [ 0.285453] PM: RTC time: 03:07:07, date: 2026-10-22444machine # [ 0.289064] NET: Registered PF_NETLINK/PF_ROUTE protocol family445machine # [ 0.290279] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations446machine # [ 0.291227] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations447machine # [ 0.292349] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations448machine # [ 0.293220] audit: initializing netlink subsys (disabled)449machine # [ 0.294350] thermal_sys: Registered thermal governor 'fair_share'450machine # [ 0.294352] thermal_sys: Registered thermal governor 'bang_bang'451machine # [ 0.295211] thermal_sys: Registered thermal governor 'step_wise'452machine # [ 0.296146] thermal_sys: Registered thermal governor 'user_space'453machine # [ 0.296909] audit: type=2000 audit(1792638428.541:1): state=initialized audit_enabled=0 res=1454machine # [ 0.298213] thermal_sys: Registered thermal governor 'power_allocator'455machine # [ 0.298241] cpuidle: using governor menu456machine # [ 0.300446] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5457machine # [ 0.301442] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]458machine # [ 0.302214] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry459machine # [ 0.303223] PCI: Using configuration type 1 for base access460sshClient # [ 0.258251] Freeing SMP alternatives memory: 48K461sshClient # [ 0.258907] pid_max: default: 32768 minimum: 301462machine # [ 0.304283] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.463sshClient # [ 0.259425] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima464sshClient # [ 0.260409] landlock: Up and running.465sshClient # [ 0.261790] Yama: becoming mindful.466sshClient # [ 0.262559] LSM support for eBPF active467sshClient # [ 0.263422] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)468machine # [ 0.309339] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages469sshClient # [ 0.264345] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)470machine # [ 0.310211] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page471sshClient # [ 0.267227] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)472sshClient # [ 0.267865] Performance Events: Fam17h+ core perfctr, AMD PMU driver.473sshClient # [ 0.268332] ... version: 2474machine # [ 0.315213] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages475sshClient # [ 0.269044] ... bit width: 48476machine # [ 0.316210] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page477sshClient # [ 0.269329] ... generic counters: 6478sshClient # [ 0.270068] ... generic bitmap: 000000000000003f479sshClient # [ 0.270374] ... fixed-purpose counters: 0480sshClient # [ 0.271134] ... fixed-purpose bitmap: 0000000000000000481sshClient # [ 0.272054] ... value mask: 0000ffffffffffff482sshClient # [ 0.272329] ... max period: 00007fffffffffff483sshClient # [ 0.273257] ... global_ctrl mask: 000000000000003f484sshClient # [ 0.274137] signal: max sigframe size: 3376485sshClient # [ 0.274944] rcu: Hierarchical SRCU implementation.486sshClient # [ 0.275333] rcu: Max phase no-delay instances is 400.487machine # [ 0.326595] ACPI: Added _OSI(Module Device)488machine # [ 0.327212] ACPI: Added _OSI(Processor Device)489machine # [ 0.327923] ACPI: Added _OSI(Processor Aggregator Device)490sshClient # [ 0.281397] smp: Bringing up secondary CPUs ...491sshClient # [ 0.282251] smp: Brought up 1 node, 1 CPU492sshClient # [ 0.282892] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)493sshClient # [ 0.283521] Memory: 934692K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105956K reserved, 0K cma-reserved)494sshClient # [ 0.284572] devtmpfs: initialized495sshClient # [ 0.285397] x86/mm: Memory block size: 128MB496machine # [ 0.336781] ACPI: 1 ACPI AML tables successfully acquired and loaded497sshClient # [ 0.287084] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)498sshClient # [ 0.288296] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).499sshClient # [ 0.289417] pinctrl core: initialized pinctrl subsystem500machine # [ 0.340622] ACPI: Interpreter enabled501sshClient # [ 0.290591] PM: RTC time: 03:07:07, date: 2026-10-22502machine # [ 0.341228] ACPI: PM: (supports S0 S3 S4 S5)503machine # [ 0.341910] ACPI: Using IOAPIC for interrupt routing504machine # [ 0.342289] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug505machine # [ 0.343211] PCI: Using E820 reservations for host bridge windows506sshClient # [ 0.293993] NET: Registered PF_NETLINK/PF_ROUTE protocol family507sshClient # [ 0.294670] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations508machine # [ 0.346289] ACPI: Enabled 2 GPEs in block 00 to 3F509sshClient # [ 0.295345] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations510sshClient # [ 0.296477] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations511sshClient # [ 0.297340] audit: initializing netlink subsys (disabled)512sshClient # [ 0.298574] thermal_sys: Registered thermal governor 'fair_share'513sshClient # [ 0.298576] thermal_sys: Registered thermal governor 'bang_bang'514sshClient # [ 0.299332] audit: type=2000 audit(1792638428.601:1): state=initialized audit_enabled=0 res=1515sshClient # [ 0.301330] thermal_sys: Registered thermal governor 'step_wise'516machine # [ 0.354017] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])517sshClient # [ 0.301331] thermal_sys: Registered thermal governor 'user_space'518machine # [ 0.354967] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]519sshClient # [ 0.302328] thermal_sys: Registered thermal governor 'power_allocator'520sshClient # [ 0.303347] cpuidle: using governor menu521machine # [ 0.356290] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]522sshClient # [ 0.305566] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5523machine # [ 0.357333] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]524machine # [ 0.358576] PCI host bridge to bus 0000:00525sshClient # [ 0.306540] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]526machine # [ 0.359215] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]527sshClient # [ 0.307332] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry528machine # [ 0.360211] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]529sshClient # [ 0.308341] PCI: Using configuration type 1 for base access530machine # [ 0.361210] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]531sshClient # [ 0.309468] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.532machine # [ 0.362210] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]533machine # [ 0.363210] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]534machine # [ 0.364210] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]535machine # [ 0.365216] pci_bus 0000:00: root bus resource [bus 00-ff]536machine # [ 0.366199] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint537sshClient # [ 0.314605] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages538sshClient # [ 0.315330] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page539machine # [ 0.367733] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint540sshClient # [ 0.320330] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages541sshClient # [ 0.321328] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page542machine # [ 0.370240] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]543machine # [ 0.371223] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]544machine # [ 0.372154] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]545machine # [ 0.373121] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]546machine # [ 0.374959] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint547machine # [ 0.377230] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]548sshClient # [ 0.331664] ACPI: Added _OSI(Module Device)549sshClient # [ 0.332331] ACPI: Added _OSI(Processor Device)550machine # [ 0.378056] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]551sshClient # [ 0.333084] ACPI: Added _OSI(Processor Aggregator Device)552machine # [ 0.378922] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]553machine # [ 0.379217] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]554machine # [ 0.380737] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555machine # [ 0.383230] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]556machine # [ 0.384218] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]557machine # [ 0.385138] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]558sshClient # [ 0.340877] ACPI: 1 ACPI AML tables successfully acquired and loaded559machine # [ 0.386612] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint560sshClient # [ 0.344747] ACPI: Interpreter enabled561sshClient # [ 0.345344] ACPI: PM: (supports S0 S3 S4 S5)562machine # [ 0.389252] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]563sshClient # [ 0.346059] ACPI: Using IOAPIC for interrupt routing564machine # [ 0.390117] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]565machine # [ 0.390918] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]566sshClient # [ 0.348364] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug567machine # [ 0.391771] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint568sshClient # [ 0.349329] PCI: Using E820 reservations for host bridge windows569machine # [ 0.393218] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]570machine # [ 0.394091] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]571sshClient # [ 0.352425] ACPI: Enabled 2 GPEs in block 00 to 3F572machine # [ 0.394955] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]573machine # [ 0.395217] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]574machine # [ 0.396760] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint575machine # [ 0.398551] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]576machine # [ 0.399248] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]577sshClient # [ 0.359090] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])578sshClient # [ 0.359335] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]579machine # [ 0.400768] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint580sshClient # [ 0.360408] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]581machine # [ 0.402172] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]582sshClient # [ 0.361454] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]583machine # [ 0.402927] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]584sshClient # [ 0.362683] PCI host bridge to bus 0000:00585sshClient # [ 0.363333] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]586machine # [ 0.403830] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint587sshClient # [ 0.364329] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]588sshClient # [ 0.365329] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]589sshClient # [ 0.366329] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]590machine # [ 0.405223] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]591machine # [ 0.406233] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]592sshClient # [ 0.367329] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]593sshClient # [ 0.368329] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]594machine # [ 0.407757] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint595sshClient # [ 0.369329] pci_bus 0000:00: root bus resource [bus 00-ff]596machine # [ 0.409014] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]597sshClient # [ 0.370322] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint598machine # [ 0.409936] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]599sshClient # [ 0.371834] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint600machine # [ 0.410806] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint601machine # [ 0.412219] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]602machine # [ 0.413217] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]603machine # [ 0.414188] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]604sshClient # [ 0.374375] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]605machine # [ 0.415588] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint606sshClient # [ 0.375341] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]607sshClient # [ 0.376266] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]608machine # [ 0.417254] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]609sshClient # [ 0.377305] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]610machine # [ 0.418111] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]611machine # [ 0.418961] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]612sshClient # [ 0.379330] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint613machine # [ 0.419768] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint614machine # [ 0.420750] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]615sshClient # [ 0.381350] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]616sshClient # [ 0.382192] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]617machine # [ 0.421423] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint618sshClient # [ 0.383054] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]619machine # [ 0.422746] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]620sshClient # [ 0.383335] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]621machine # [ 0.423434] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint622sshClient # [ 0.384855] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint623machine # [ 0.424750] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]624sshClient # [ 0.386354] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]625sshClient # [ 0.387163] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]626sshClient # [ 0.388035] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]627sshClient # [ 0.388892] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint628sshClient # [ 0.391348] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]629sshClient # [ 0.392192] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]630sshClient # [ 0.393350] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]631machine # [ 0.425439] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint632sshClient # [ 0.394919] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint633machine # [ 0.427895] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]634sshClient # [ 0.396336] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]635machine # [ 0.428500] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint636sshClient # [ 0.397183] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]637machine # [ 0.429501] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO638sshClient # [ 0.398102] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]639sshClient # [ 0.399177] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]640machine # [ 0.430460] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint641machine # [ 0.432041] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]642sshClient # [ 0.400626] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint643machine # [ 0.432842] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]644sshClient # [ 0.402172] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]645machine # [ 0.433534] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint646sshClient # [ 0.403037] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]647machine # [ 0.435024] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]648sshClient # [ 0.403882] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint649sshClient # [ 0.405330] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]650sshClient # [ 0.406286] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]651machine # [ 0.438916] ACPI: PCI: Interrupt link LNKA configured for IRQ 10652machine # [ 0.439317] ACPI: PCI: Interrupt link LNKB configured for IRQ 10653machine # [ 0.440307] ACPI: PCI: Interrupt link LNKC configured for IRQ 11654sshClient # [ 0.407771] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint655machine # [ 0.441309] ACPI: PCI: Interrupt link LNKD configured for IRQ 11656sshClient # [ 0.409258] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]657machine # [ 0.442309] ACPI: PCI: Interrupt link LNKE configured for IRQ 10658sshClient # [ 0.410090] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]659machine # [ 0.443307] ACPI: PCI: Interrupt link LNKF configured for IRQ 10660machine # [ 0.444314] ACPI: PCI: Interrupt link LNKG configured for IRQ 11661sshClient # [ 0.410865] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint662machine # [ 0.445321] ACPI: PCI: Interrupt link LNKH configured for IRQ 11663machine # [ 0.446247] ACPI: PCI: Interrupt link GSIA configured for IRQ 16664sshClient # [ 0.412282] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]665machine # [ 0.447166] ACPI: PCI: Interrupt link GSIB configured for IRQ 17666sshClient # [ 0.413047] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]667machine # [ 0.447924] ACPI: PCI: Interrupt link GSIC configured for IRQ 18668machine # [ 0.448222] ACPI: PCI: Interrupt link GSID configured for IRQ 19669sshClient # [ 0.413874] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint670machine # [ 0.449148] ACPI: PCI: Interrupt link GSIE configured for IRQ 20671machine # [ 0.449916] ACPI: PCI: Interrupt link GSIF configured for IRQ 21672machine # [ 0.450224] ACPI: PCI: Interrupt link GSIG configured for IRQ 22673sshClient # [ 0.416259] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]674machine # [ 0.451180] ACPI: PCI: Interrupt link GSIH configured for IRQ 23675sshClient # [ 0.416940] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]676sshClient # [ 0.417350] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]677machine # [ 0.453224] iommu: Default domain type: Translated678machine # [ 0.453993] iommu: DMA domain TLB invalidation policy: lazy mode679sshClient # [ 0.418898] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint680machine # [ 0.455212] ACPI: bus type USB registered681machine # [ 0.455937] usbcore: registered new interface driver usbfs682machine # [ 0.456227] usbcore: registered new interface driver hub683sshClient # [ 0.420349] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]684machine # [ 0.457064] usbcore: registered new device driver usb685sshClient # [ 0.421201] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]686machine # [ 0.458658] NetLabel: Initializing687sshClient # [ 0.422058] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]688machine # [ 0.459211] NetLabel: domain hash size = 128689machine # [ 0.459914] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO690sshClient # [ 0.423199] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint691machine # [ 0.460262] NetLabel: unlabeled traffic allowed by default692machine # [ 0.461224] PCI: Using ACPI for IRQ routing693sshClient # [ 0.424836] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]694sshClient # [ 0.425545] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint695sshClient # [ 0.426830] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]696sshClient # [ 0.427526] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint697sshClient # [ 0.430357] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]698sshClient # [ 0.431482] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint699sshClient # [ 0.433995] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]700sshClient # [ 0.434610] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint701sshClient # [ 0.435630] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO702sshClient # [ 0.436591] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint703sshClient # [ 0.438368] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]704sshClient # [ 0.439203] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]705sshClient # [ 0.440386] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint706sshClient # [ 0.441977] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]707sshClient # [ 0.445539] ACPI: PCI: Interrupt link LNKA configured for IRQ 10708sshClient # [ 0.446438] ACPI: PCI: Interrupt link LNKB configured for IRQ 10709sshClient # [ 0.447430] ACPI: PCI: Interrupt link LNKC configured for IRQ 11710sshClient # [ 0.448430] ACPI: PCI: Interrupt link LNKD configured for IRQ 11711sshClient # [ 0.449428] ACPI: PCI: Interrupt link LNKE configured for IRQ 10712sshClient # [ 0.450426] ACPI: PCI: Interrupt link LNKF configured for IRQ 10713sshClient # [ 0.451433] ACPI: PCI: Interrupt link LNKG configured for IRQ 11714machine # [ 0.505796] pci 0000:00:01.0: vgaarb: setting as boot VGA device715sshClient # [ 0.452429] ACPI: PCI: Interrupt link LNKH configured for IRQ 11716machine # [ 0.506207] pci 0000:00:01.0: vgaarb: bridge control possible717sshClient # [ 0.453364] ACPI: PCI: Interrupt link GSIA configured for IRQ 16718sshClient # [ 0.454292] ACPI: PCI: Interrupt link GSIB configured for IRQ 17719machine # [ 0.506207] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none720machine # [ 0.506215] vgaarb: loaded721sshClient # [ 0.455040] ACPI: PCI: Interrupt link GSIC configured for IRQ 18722machine # [ 0.506924] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0723sshClient # [ 0.455343] ACPI: PCI: Interrupt link GSID configured for IRQ 19724machine # [ 0.507212] hpet0: 3 comparators, 64-bit 100.000000 MHz counter725sshClient # [ 0.456342] ACPI: PCI: Interrupt link GSIE configured for IRQ 20726sshClient # [ 0.457289] ACPI: PCI: Interrupt link GSIF configured for IRQ 21727sshClient # [ 0.458067] ACPI: PCI: Interrupt link GSIG configured for IRQ 22728sshClient # [ 0.458342] ACPI: PCI: Interrupt link GSIH configured for IRQ 23729machine # [ 0.510307] clocksource: Switched to clocksource kvm-clock730sshClient # [ 0.460429] iommu: Default domain type: Translated731machine # [ 0.511951] VFS: Disk quotas dquot_6.6.0732sshClient # [ 0.461319] iommu: DMA domain TLB invalidation policy: lazy mode733sshClient # [ 0.462627] ACPI: bus type USB registered734sshClient # [ 0.463348] usbcore: registered new interface driver usbfs735machine # [ 0.514446] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)736sshClient # [ 0.464225] usbcore: registered new interface driver hub737machine # [ 0.515810] pnp: PnP ACPI init738sshClient # [ 0.465024] usbcore: registered new device driver usb739machine # [ 0.516674] ACPI: IRQ 4 override to edge(!), high(!)740machine # [ 0.517634] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved741sshClient # [ 0.466395] NetLabel: Initializing742sshClient # [ 0.467005] NetLabel: domain hash size = 128743machine # [ 0.519136] pnp: PnP ACPI: found 5 devices744sshClient # [ 0.467330] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO745sshClient # [ 0.468220] NetLabel: unlabeled traffic allowed by default746sshClient # [ 0.468982] PCI: Using ACPI for IRQ routing747machine # [ 0.526676] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns748machine # [ 0.528089] clocksource: Switched to clocksource acpi_pm749machine # [ 0.529053] NET: Registered PF_INET protocol family750machine # [ 0.530041] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)751machine # [ 0.547497] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)752machine # [ 0.549012] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)753machine # [ 0.550295] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)754machine # [ 0.551565] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)755machine # [ 0.552746] TCP: Hash tables configured (established 8192 bind 8192)756machine # [ 0.553806] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)757machine # [ 0.555013] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)758machine # [ 0.556070] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)759machine # [ 0.557230] NET: Registered PF_UNIX/PF_LOCAL protocol family760machine # [ 0.558131] NET: Registered PF_XDP protocol family761machine # [ 0.558951] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]762machine # [ 0.559930] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]763machine # [ 0.560914] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]764machine # [ 0.561981] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]765machine # [ 0.563038] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]766machine # [ 0.564083] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]767sshClient # [ 0.511995] pci 0000:00:01.0: vgaarb: setting as boot VGA device768machine # [ 0.565737] ACPI: \_SB_.GSIA: Enabled at IRQ 16769sshClient # [ 0.512325] pci 0000:00:01.0: vgaarb: bridge control possible770sshClient # [ 0.512325] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none771sshClient # [ 0.512335] vgaarb: loaded772machine # [ 0.568456] ACPI: \_SB_.GSIB: Enabled at IRQ 17773sshClient # [ 0.513064] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0774sshClient # [ 0.513329] hpet0: 3 comparators, 64-bit 100.000000 MHz counter775machine # [ 0.570383] ACPI: \_SB_.GSIC: Enabled at IRQ 18776machine # [ 0.572340] ACPI: \_SB_.GSID: Enabled at IRQ 19777machine # [ 0.573992] PCI: CLS 0 bytes, default 64778sshClient # [ 0.517421] clocksource: Switched to clocksource kvm-clock779machine # [ 0.574847] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns780sshClient # [ 0.519156] VFS: Disk quotas dquot_6.6.0781machine # [ 0.576590] Trying to unpack rootfs image as initramfs...782sshClient # [ 0.521671] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)783sshClient # [ 0.523138] pnp: PnP ACPI init784sshClient # [ 0.523949] ACPI: IRQ 4 override to edge(!), high(!)785sshClient # [ 0.524909] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved786sshClient # [ 0.526545] pnp: PnP ACPI: found 5 devices787sshClient # [ 0.534184] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns788sshClient # [ 0.535679] clocksource: Switched to clocksource acpi_pm789sshClient # [ 0.536718] NET: Registered PF_INET protocol family790sshClient # [ 0.537809] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)791sshClient # [ 0.555666] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)792sshClient # [ 0.557281] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)793sshClient # [ 0.558670] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)794sshClient # [ 0.560038] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)795sshClient # [ 0.561288] TCP: Hash tables configured (established 8192 bind 8192)796sshClient # [ 0.562515] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)797sshClient # [ 0.563879] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)798machine # [ 0.622242] Initialise system trusted keyrings799machine # [ 0.623074] Key type blacklist registered800sshClient # [ 0.565076] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)801sshClient # [ 0.566257] NET: Registered PF_UNIX/PF_LOCAL protocol family802sshClient # [ 0.567265] NET: Registered PF_XDP protocol family803machine # [ 0.625346] workingset: timestamp_bits=40 max_order=18 bucket_order=0804sshClient # [ 0.568172] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]805sshClient # [ 0.569206] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]806sshClient # [ 0.570261] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]807machine # [ 0.628353] integrity: Platform Keyring initialized808machine # [ 0.629177] integrity: Machine keyring initialized809sshClient # [ 0.571431] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]810sshClient # [ 0.572556] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]811sshClient # [ 0.573728] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]812sshClient # [ 0.575580] ACPI: \_SB_.GSIA: Enabled at IRQ 16813sshClient # [ 0.577882] ACPI: \_SB_.GSIB: Enabled at IRQ 17814sshClient # [ 0.579900] ACPI: \_SB_.GSIC: Enabled at IRQ 18815sshClient # [ 0.581867] ACPI: \_SB_.GSID: Enabled at IRQ 19816sshClient # [ 0.583582] PCI: CLS 0 bytes, default 64817sshClient # [ 0.584560] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns818sshClient # [ 0.586528] Trying to unpack rootfs image as initramfs...819machine # [ 0.649599] Key type asymmetric registered820machine # [ 0.652191] Asymmetric key parser 'x509' registered821machine # [ 0.653011] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)822machine # [ 0.656302] io scheduler mq-deadline registered823machine # [ 0.657043] io scheduler kyber registered824machine # [ 0.660837] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled825machine # [ 0.662287] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A826machine # [ 0.667328] Linux agpgart interface v0.103827machine # [ 0.668065] ACPI: bus type drm_connector registered828machine # [ 0.671321] usbcore: registered new interface driver usbserial_generic829machine # [ 0.672373] usbserial: USB Serial support registered for generic830machine # [ 0.675180] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.831machine # [ 0.675180] Please enable it if your BIOS has the CPPC option.832machine # [ 0.677332] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled833machine # [ 0.680329] drop_monitor: Initializing network drop monitor service834machine # [ 0.681527] NET: Registered PF_INET6 protocol family835machine # [ 0.684695] Segment Routing with IPv6836machine # [ 0.687205] In-situ OAM (IOAM) with IPv6837machine # [ 0.688275] IPI shorthand broadcast: enabled838sshClient # [ 0.633822] Initialise system trusted keyrings839sshClient # [ 0.634731] Key type blacklist registered840sshClient # [ 0.637567] workingset: timestamp_bits=40 max_order=18 bucket_order=0841machine # [ 0.698430] sched_clock: Marking stable (562015878, 136152695)->(767032374, -68863801)842sshClient # [ 0.641673] integrity: Platform Keyring initialized843machine # [ 0.699940] registered taskstats version 1844sshClient # [ 0.642536] integrity: Machine keyring initialized845machine # [ 0.700949] Loading compiled-in X.509 certificates846sshClient # [ 0.660992] Key type asymmetric registered847machine # [ 0.721184] Demotion targets for Node 0: null848machine # [ 0.722097] Key type .fscrypt registered849machine # [ 0.722773] Key type fscrypt-provisioning registered850machine # [ 0.723742] ima: No TPM chip found, activating TPM-bypass!851sshClient # [ 0.666410] Asymmetric key parser 'x509' registered852sshClient # [ 0.667301] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)853sshClient # [ 0.670515] io scheduler mq-deadline registered854machine # [ 0.728181] ima: Allocated hash algorithm: sha1855sshClient # [ 0.671290] io scheduler kyber registered856machine # [ 0.728977] ima: No architecture policies found857machine # [ 0.729919] PM: Magic number: 14:59:109858sshClient # [ 0.674951] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled859machine # [ 0.733616] RAS: Correctable Errors collector initialized.860sshClient # [ 0.676325] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A861sshClient # [ 0.680187] Linux agpgart interface v0.103862sshClient # [ 0.680983] ACPI: bus type drm_connector registered863machine # [ 0.742429] clk: Disabling unused clocks864machine # [ 0.743138] PM: genpd: Disabling unused power domains865sshClient # [ 0.685841] usbcore: registered new interface driver usbserial_generic866sshClient # [ 0.687038] usbserial: USB Serial support registered for generic867sshClient # [ 0.689486] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.868sshClient # [ 0.689486] Please enable it if your BIOS has the CPPC option.869sshClient # [ 0.691842] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled870sshClient # [ 0.696546] drop_monitor: Initializing network drop monitor service871sshClient # [ 0.697828] NET: Registered PF_INET6 protocol family872sshClient # [ 0.701942] Segment Routing with IPv6873sshClient # [ 0.704440] In-situ OAM (IOAM) with IPv6874sshClient # [ 0.705522] IPI shorthand broadcast: enabled875sshClient # [ 0.713979] sched_clock: Marking stable (577015518, 136375214)->(784513238, -71122506)876sshClient # [ 0.719669] registered taskstats version 1877sshClient # [ 0.720624] Loading compiled-in X.509 certificates878sshClient # [ 0.737085] Demotion targets for Node 0: null879sshClient # [ 0.739452] Key type .fscrypt registered880sshClient # [ 0.740160] Key type fscrypt-provisioning registered881sshClient # [ 0.741091] ima: No TPM chip found, activating TPM-bypass!882sshClient # [ 0.745419] ima: Allocated hash algorithm: sha1883sshClient # [ 0.746232] ima: No architecture policies found884sshClient # [ 0.748405] PM: Magic number: 14:59:109885sshClient # [ 0.750178] RAS: Correctable Errors collector initialized.886sshClient # [ 0.761412] clk: Disabling unused clocks887sshClient # [ 0.762131] PM: genpd: Disabling unused power domains888machine # [ 0.917018] Freeing initrd memory: 29292K889machine # [ 0.920449] Freeing unused decrypted memory: 2028K890machine # [ 0.924953] Freeing unused kernel image (initmem) memory: 6720K891machine # [ 0.926035] Write protecting the kernel read-only data: 32768k892machine # [ 0.927300] Freeing unused kernel image (text/rodata gap) memory: 244K893machine # [ 0.928696] Freeing unused kernel image (rodata/data gap) memory: 620K894machine # [ 0.979183] x86/mm: Checked W+X mappings: passed, no W+X pages found.895machine # [ 0.980272] Run /init as init process896sshClient # [ 0.932933] Freeing initrd memory: 29292K897machine # [ 0.990244] autofs4: module verification failed: signature and/or required key missing - tainting kernel898machine # [ 0.992779] systemd[1]: Inserted module 'autofs4'899sshClient # [ 0.936198] Freeing unused decrypted memory: 2028K900sshClient # [ 0.940517] Freeing unused kernel image (initmem) memory: 6720K901sshClient # [ 0.941587] Write protecting the kernel read-only data: 32768k902sshClient # [ 0.942844] Freeing unused kernel image (text/rodata gap) memory: 244K903sshClient # [ 0.944310] Freeing unused kernel image (rodata/data gap) memory: 620K904machine # [ 1.012600] fuse: init (API version 7.45)905machine # [ 1.019926] ACPI: \_SB_.GSIG: Enabled at IRQ 22906machine # [ 1.022584] ACPI: \_SB_.GSIH: Enabled at IRQ 23907machine # [ 1.025746] ACPI: \_SB_.GSIE: Enabled at IRQ 20908machine # [ 1.027956] ACPI: \_SB_.GSIF: Enabled at IRQ 21909machine # [ 1.033370] virtiofs virtio5: discovered new tag: nix-store910machine # [ 1.034934] virtiofs virtio5: virtio_fs_setup_dax: No cache capability911machine # [ 1.041769] virtiofs virtio6: discovered new tag: shared912machine # [ 1.043374] virtiofs virtio6: virtio_fs_setup_dax: No cache capability913machine # [ 1.046703] virtiofs virtio7: discovered new tag: xchg914machine # [ 1.048179] virtiofs virtio7: virtio_fs_setup_dax: No cache capability915sshClient # [ 0.994976] x86/mm: Checked W+X mappings: passed, no W+X pages found.916sshClient # [ 0.996010] Run /init as init process917sshClient # [ 1.006691] autofs4: module verification failed: signature and/or required key missing - tainting kernel918sshClient # [ 1.009259] systemd[1]: Inserted module 'autofs4'919machine # [ 1.069999] systemd[1]: Successfully made /usr/ read-only.920machine # [ 1.071827] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)921machine # [ 1.076946] systemd[1]: Detected virtualization kvm.922machine # [ 1.077805] systemd[1]: Detected architecture x86-64.923machine # [ 1.078704] systemd[1]: Running in initrd.924machine # [ 1.079697] systemd[1]: Initializing machine ID from random generator.925machine # [ 1.080873] systemd[1]: Hostname set to <machine>.926sshClient # [ 1.029393] fuse: init (API version 7.45)927sshClient # [ 1.036657] ACPI: \_SB_.GSIG: Enabled at IRQ 22928sshClient # [ 1.039297] ACPI: \_SB_.GSIH: Enabled at IRQ 23929sshClient # [ 1.042461] ACPI: \_SB_.GSIE: Enabled at IRQ 20930sshClient # [ 1.044647] ACPI: \_SB_.GSIF: Enabled at IRQ 21931sshClient # [ 1.049931] virtiofs virtio5: discovered new tag: nix-store932sshClient # [ 1.051502] virtiofs virtio5: virtio_fs_setup_dax: No cache capability933sshClient # [ 1.059067] virtiofs virtio6: discovered new tag: shared934sshClient # [ 1.060575] virtiofs virtio6: virtio_fs_setup_dax: No cache capability935sshClient # [ 1.063840] virtiofs virtio7: discovered new tag: xchg936sshClient # [ 1.065305] virtiofs virtio7: virtio_fs_setup_dax: No cache capability937sshClient # [ 1.085173] systemd[1]: Successfully made /usr/ read-only.938sshClient # [ 1.086975] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)939sshClient # [ 1.092499] systemd[1]: Detected virtualization kvm.940sshClient # [ 1.093524] systemd[1]: Detected architecture x86-64.941sshClient # [ 1.094537] systemd[1]: Running in initrd.942sshClient # [ 1.095614] systemd[1]: Initializing machine ID from random generator.943sshClient # [ 1.096755] systemd[1]: Hostname set to <sshClient>.944machine # [ 1.154465] systemd[1]: bpf-restrict-fs: LSM BPF program attached945machine # [ 1.191586] systemd[1]: Queued start job for default target Initrd Default Target.946machine # [ 1.195455] systemd[1]: Created slice Slice /system/modprobe.947machine # [ 1.196664] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.948machine # [ 1.198035] systemd[1]: Expecting device /dev/disk/by-label/nixos...949machine # [ 1.199131] systemd[1]: Reached target Path Units.950machine # [ 1.199975] systemd[1]: Reached target Slice Units.951machine # [ 1.200811] systemd[1]: Reached target Swaps.952machine # [ 1.201596] systemd[1]: Reached target Timer Units.953machine # [ 1.202544] systemd[1]: Listening on D-Bus System Message Bus Socket.954machine # [ 1.203763] systemd[1]: Listening on Journal Socket (/dev/log).955machine # [ 1.204872] systemd[1]: Listening on Journal Sockets.956machine # [ 1.205819] systemd[1]: Listening on udev Kernel Socket.957machine # [ 1.218072] systemd[1]: Listening on udev Varlink Socket.958machine # [ 1.219008] systemd[1]: Reached target Socket Units.959machine # [ 1.220799] systemd[1]: Starting Create List of Static Device Nodes...960machine # [ 1.225240] systemd[1]: Starting Load Kernel Module configfs...961sshClient # [ 1.172646] systemd[1]: bpf-restrict-fs: LSM BPF program attached962machine # [ 1.231837] systemd[1]: Starting Journal Service...963machine # [ 1.244275] systemd[1]: Starting Load Kernel Modules...964machine # [ 1.247262] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os965machine # [ 1.254391] systemd[1]: Starting Coldplug All udev Devices...966sshClient # [ 1.209250] systemd[1]: Queued start job for default target Initrd Default Target.967machine # [ 1.269279] systemd[1]: Finished Create List of Static Device Nodes.968sshClient # [ 1.213697] systemd[1]: Created slice Slice /system/modprobe.969sshClient # [ 1.215116] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.970sshClient # [ 1.216652] systemd[1]: Expecting device /dev/disk/by-label/nixos...971machine # [ 1.274851] systemd[1]: modprobe@configfs.service: Deactivated successfully.972sshClient # [ 1.217928] systemd[1]: Reached target Path Units.973sshClient # [ 1.218847] systemd[1]: Reached target Slice Units.974sshClient # [ 1.219768] systemd[1]: Reached target Swaps.975sshClient # [ 1.220650] systemd[1]: Reached target Timer Units.976sshClient # [ 1.221659] systemd[1]: Listening on D-Bus System Message Bus Socket.977sshClient # [ 1.222946] systemd[1]: Listening on Journal Socket (/dev/log).978sshClient # [ 1.224118] systemd[1]: Listening on Journal Sockets.979machine # [ 1.282573] systemd[1]: Finished Load Kernel Module configfs.980machine # [ 1.287643] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config981machine # [ 1.293185] systemd-journald[65]: Collecting audit messages is disabled.982sshClient # [ 1.225142] systemd[1]: Listening on udev Kernel Socket.983sshClient # [ 1.237529] systemd[1]: Listening on udev Varlink Socket.984sshClient # [ 1.238543] systemd[1]: Reached target Socket Units.985sshClient # [ 1.240461] systemd[1]: Starting Create List of Static Device Nodes...986machine # [ 1.301243] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...987sshClient # [ 1.244251] systemd[1]: Starting Load Kernel Module configfs...988machine # [ 1.308413] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.989sshClient # [ 1.254005] systemd[1]: Starting Journal Service...990machine # [ 1.317216] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev991sshClient # [ 1.264501] systemd[1]: Starting Load Kernel Modules...992sshClient # [ 1.267481] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993sshClient # [ 1.272458] systemd[1]: Starting Coldplug All udev Devices...994sshClient # [ 1.288493] systemd[1]: Finished Create List of Static Device Nodes.995machine # [ 1.346788] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.996sshClient # [ 1.294111] systemd[1]: modprobe@configfs.service: Deactivated successfully.997machine # [ 1.355385] systemd[1]: Starting Create Static Device Nodes in /dev...998sshClient # [ 1.301820] systemd[1]: Finished Load Kernel Module configfs.999machine # [ 1.365727] systemd[1]: Finished Load Kernel Modules.1000sshClient # [ 1.307881] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1001sshClient # [ 1.311309] systemd-journald[65]: Collecting audit messages is disabled.1002machine # [ 1.374898] systemd[1]: Starting Apply Kernel Variables...1003sshClient # [ 1.319048] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1004sshClient # [ 1.327306] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1005sshClient # [ 1.338544] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1006machine # [ 1.397312] systemd[1]: Finished Create Static Device Nodes in /dev.1007machine # [ 1.403401] systemd[1]: Reached target Preparation for Local File Systems.1008machine # [ 1.408252] systemd[1]: Reached target Local File Systems.1009machine # [ 1.273557] systemd-modules-load[66]: Inserted module 'dm_mod'1010machine # [ 1.277417] systemd-modules-load[66]: Inserted module 'virtio_balloon'1011machine # [ 1.278489] systemd-modules-load[66]: Inserted module 'virtio_gpu'1012machine # [ 1.418571] systemd[1]: Starting Rule-based Manager for Device Events and Files...1013sshClient # [ 1.360981] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1014machine # [ 1.425464] systemd[1]: Started Journal Service.1015sshClient # [ 1.370600] systemd[1]: Starting Create Static Device Nodes in /dev...1016machine # [ 1.297117] systemd[1]: Finished Apply Kernel Variables.1017sshClient # [ 1.380950] systemd[1]: Finished Load Kernel Modules.1018machine # [ 1.314074] systemd[1]: Starting Create System Files and Directories...1019sshClient # [ 1.393707] systemd[1]: Starting Apply Kernel Variables...1020sshClient # [ 1.418987] systemd[1]: Finished Create Static Device Nodes in /dev.1021machine # [ 1.343478] systemd[1]: Finished Create System Files and Directories.1022sshClient # [ 1.423668] systemd[1]: Reached target Preparation for Local File Systems.1023machine # [ 1.347240] systemd-udevd[73]: Using default interface naming scheme 'v261'.1024sshClient # [ 1.429492] systemd[1]: Reached target Local File Systems.1025sshClient # [ 1.294467] systemd-modules-load[66]: Inserted module 'dm_mod'1026sshClient # [ 1.295991] systemd-modules-load[66]: Inserted module 'virtio_balloon'1027sshClient # [ 1.298085] systemd-modules-load[66]: Inserted module 'virtio_gpu'1028sshClient # [ 1.437593] systemd[1]: Starting Rule-based Manager for Device Events and Files...1029sshClient # [ 1.444660] systemd[1]: Started Journal Service.1030sshClient # [ 1.312995] systemd[1]: Finished Apply Kernel Variables.1031machine # [ 1.371552] systemd[1]: Started Rule-based Manager for Device Events and Files.1032sshClient # [ 1.325170] systemd[1]: Starting Create System Files and Directories...1033sshClient # [ 1.357624] systemd[1]: Finished Create System Files and Directories.1034machine # [ 1.421079] systemd[1]: Finished Coldplug All udev Devices.1035machine # [ 1.423701] systemd[1]: Reached target System Initialization.1036sshClient # [ 1.367270] systemd-udevd[73]: Using default interface naming scheme 'v261'.1037machine # [ 1.425872] systemd[1]: Reached target Basic System.1038sshClient # [ 1.390537] systemd[1]: Started Rule-based Manager for Device Events and Files.1039sshClient # [ 1.444140] systemd[1]: Finished Coldplug All udev Devices.1040sshClient # [ 1.446116] systemd[1]: Reached target System Initialization.1041sshClient # [ 1.448040] systemd[1]: Reached target Basic System.1042machine # [ 1.702538] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121043machine # [ 1.721411] serio: i8042 KBD port at 0x60,0x64 irq 11044machine # [ 1.722100] serio: i8042 AUX port at 0x60,0x64 irq 121045machine # [ 1.723816] virtio_blk virtio2: 1/0/0 default/read/poll queues1046machine # [ 1.731978] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1047machine # [ 1.758310] ehci-pci 0000:00:1d.7: EHCI Host Controller1048machine # [ 1.759334] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11049machine # [ 1.761299] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001050machine # [ 1.767208] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001051machine # [ 1.768112] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181052machine # [ 1.769487] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11053machine # [ 1.772254] usb usb1: Product: EHCI Host Controller1054machine # [ 1.772927] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd1055machine # [ 1.775362] usb usb1: SerialNumber: 0000:00:1d.71056machine # [ 1.777549] hub 1-0:1.0: USB hub found1057machine # [ 1.779682] hub 1-0:1.0: 6 ports detected1058machine # [ 1.789613] uhci_hcd 0000:00:1d.0: UHCI Host Controller1059machine # [ 1.790645] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21060sshClient # [ 1.734021] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121061sshClient # [ 1.741574] virtio_blk virtio2: 1/0/0 default/read/poll queues1062sshClient # [ 1.743278] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1063machine # [ 1.803744] uhci_hcd 0000:00:1d.0: detected 2 ports1064sshClient # [ 1.748034] serio: i8042 KBD port at 0x60,0x64 irq 11065sshClient # [ 1.752409] serio: i8042 AUX port at 0x60,0x64 irq 121066machine # [ 1.811230] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801067machine # [ 1.820252] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181068machine # [ 1.821698] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11069sshClient # [ 1.769951] ehci-pci 0000:00:1d.7: EHCI Host Controller1070sshClient # [ 1.770739] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11071sshClient # [ 1.772515] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001072sshClient # [ 1.778471] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001073sshClient # [ 1.780844] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181074sshClient # [ 1.781989] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11075machine # [ 1.841237] usb usb2: Product: UHCI Host Controller1076machine # [ 1.842035] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd1077sshClient # [ 1.785395] usb usb1: Product: EHCI Host Controller1078sshClient # [ 1.786055] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd1079sshClient # [ 1.788403] usb usb1: SerialNumber: 0000:00:1d.71080sshClient # [ 1.789819] hub 1-0:1.0: USB hub found1081machine # [ 1.712253] (udev-worker)[87]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1082sshClient # [ 1.792106] hub 1-0:1.0: 6 ports detected1083machine # [ 1.854225] usb usb2: SerialNumber: 0000:00:1d.01084sshClient # [ 1.800442] uhci_hcd 0000:00:1d.0: UHCI Host Controller1085sshClient # [ 1.801209] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21086machine # [ 1.724411] systemd[1]: Starting Virtual Console Setup...1087machine # [ 1.727573] (udev-worker)[85]: Network interface NamePolicy= disabled on kernel command line.1088machine # [ 1.732766] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.1089sshClient # [ 1.816107] uhci_hcd 0000:00:1d.0: detected 2 ports1090machine # [ 1.876397] hub 2-0:1.0: USB hub found1091machine # [ 1.883419] SCSI subsystem initialized1092sshClient # [ 1.826204] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801093machine # [ 1.887481] hub 2-0:1.0: 2 ports detected1094sshClient # [ 1.833455] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181095sshClient # [ 1.834676] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11096machine # [ 1.893765] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01097sshClient # [ 1.710709] systemd[1]: Starting Virtual Console Setup...1098sshClient # [ 1.713708] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1099machine # [ 1.771441] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1100sshClient # [ 1.851411] usb usb2: Product: UHCI Host Controller1101sshClient # [ 1.852150] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd1102machine # [ 1.774245] systemd[1]: Finished Virtual Console Setup.1103machine # [ 1.920312] uhci_hcd 0000:00:1d.1: UHCI Host Controller1104machine # [ 1.921036] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31105sshClient # [ 1.863679] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01106machine # [ 1.792082] systemd[1]: Found device /dev/disk/by-label/nixos.1107machine # [ 1.794812] systemd[1]: Reached target Initrd Root Device.1108machine # [ 1.933027] uhci_hcd 0000:00:1d.1: detected 2 ports1109machine # [ 1.934301] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01110machine # [ 1.800357] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1111sshClient # [ 1.881713] usb usb2: SerialNumber: 0000:00:1d.01112machine # [ 1.942129] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181113sshClient # [ 1.888822] SCSI subsystem initialized1114machine # [ 1.948210] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11115sshClient # [ 1.754133] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1116machine # [ 1.950198] usb usb3: Product: UHCI Host Controller1117machine # [ 1.950867] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd1118sshClient # [ 1.757827] systemd[1]: Finished Virtual Console Setup.1119sshClient # [ 1.898177] hub 2-0:1.0: USB hub found1120machine # [ 1.957194] usb usb3: SerialNumber: 0000:00:1d.11121machine # [ 1.958731] hub 3-0:1.0: USB hub found1122machine # [ 1.960224] hub 3-0:1.0: 2 ports detected1123sshClient # [ 1.766274] (udev-worker)[84]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1124sshClient # [ 1.768539] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line.1125sshClient # [ 1.906024] hub 2-0:1.0: 2 ports detected1126machine # [ 1.965898] uhci_hcd 0000:00:1d.2: UHCI Host Controller1127machine # [ 1.966687] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41128machine # [ 1.970403] uhci_hcd 0000:00:1d.2: detected 2 ports1129sshClient # [ 1.779763] systemd[1]: Found device /dev/disk/by-label/nixos.1130machine # [ 1.975295] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01131sshClient # [ 1.783339] systemd[1]: Reached target Initrd Root Device.1132machine # [ 1.977356] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181133machine # [ 1.843101] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks1134sshClient # [ 1.788085] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1135machine # [ 1.982206] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11136sshClient # [ 1.925614] uhci_hcd 0000:00:1d.1: UHCI Host Controller1137sshClient # [ 1.926408] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31138machine # [ 1.850363] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1139machine # [ 1.988286] usb usb4: Product: UHCI Host Controller1140machine # [ 1.989010] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd1141machine # [ 1.991255] usb usb4: SerialNumber: 0000:00:1d.21142sshClient # [ 1.937440] uhci_hcd 0000:00:1d.1: detected 2 ports1143sshClient # [ 1.938331] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01144machine # [ 1.996370] hub 4-0:1.0: USB hub found1145machine # [ 1.997086] hub 4-0:1.0: 2 ports detected1146sshClient # [ 1.945516] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181147sshClient # [ 1.949442] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11148sshClient # [ 1.950882] usb usb3: Product: UHCI Host Controller1149sshClient # [ 1.952453] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd1150sshClient # [ 1.953296] usb usb3: SerialNumber: 0000:00:1d.11151machine # [ 2.014203] usb 1-1: new high-speed USB device number 2 using ehci-pci1152sshClient # [ 1.956947] hub 3-0:1.0: USB hub found1153sshClient # [ 1.958446] hub 3-0:1.0: 2 ports detected1154sshClient # [ 1.831354] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1155sshClient # [ 1.968895] uhci_hcd 0000:00:1d.2: UHCI Host Controller1156sshClient # [ 1.969691] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41157machine # [ 2.030073] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1158sshClient # [ 1.839701] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1159machine # [ 2.034588] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1160sshClient # [ 1.977520] uhci_hcd 0000:00:1d.2: detected 2 ports1161machine # [ 2.035973] ahci 0000:00:1f.2: flags: 64bit ncq only1162sshClient # [ 1.978345] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01163machine # [ 2.039179] scsi host0: ahci1164machine # [ 2.040728] scsi host1: ahci1165sshClient # [ 1.982633] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181166machine # [ 2.041859] scsi host2: ahci1167machine # [ 2.043417] scsi host3: ahci1168sshClient # [ 1.985461] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11169machine # [ 2.044837] scsi host4: ahci1170machine # [ 2.046007] scsi host5: ahci1171sshClient # [ 1.988458] usb usb4: Product: UHCI Host Controller1172sshClient # [ 1.989187] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd1173machine # [ 2.047382] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11174machine # [ 2.048689] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11175machine # [ 2.049915] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11176machine # [ 2.051138] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11177machine # [ 2.052384] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11178machine # [ 2.053629] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11179sshClient # [ 1.997484] usb usb4: SerialNumber: 0000:00:1d.21180sshClient # [ 1.999595] hub 4-0:1.0: USB hub found1181sshClient # [ 2.000815] hub 4-0:1.0: 2 ports detected1182sshClient # [ 2.031156] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1183sshClient # [ 2.032537] usb 1-1: new high-speed USB device number 2 using ehci-pci1184sshClient # [ 2.034303] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1185sshClient # [ 2.035204] ahci 0000:00:1f.2: flags: 64bit ncq only1186sshClient # [ 2.038855] scsi host0: ahci1187sshClient # [ 2.040140] scsi host1: ahci1188sshClient # [ 2.041917] scsi host2: ahci1189sshClient # [ 2.043238] scsi host3: ahci1190sshClient # [ 2.044538] scsi host4: ahci1191sshClient # [ 2.045945] scsi host5: ahci1192sshClient # [ 2.046913] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11193sshClient # [ 2.048461] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11194sshClient # [ 2.049628] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11195sshClient # [ 2.050789] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11196sshClient # [ 2.051929] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11197sshClient # [ 2.053080] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11198machine # [ 2.146305] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001199machine # [ 2.147472] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101200machine # [ 2.148807] usb 1-1: Product: QEMU USB Tablet1201machine # [ 2.149553] usb 1-1: Manufacturer: QEMU1202machine # [ 2.150104] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11203machine # [ 2.164056] hid: raw HID events driver (C) Jiri Kosina1204sshClient # [ 2.162348] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001205sshClient # [ 2.163551] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101206sshClient # [ 2.164863] usb 1-1: Product: QEMU USB Tablet1207sshClient # [ 2.165611] usb 1-1: Manufacturer: QEMU1208sshClient # [ 2.166168] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11209sshClient # [ 2.179720] hid: raw HID events driver (C) Jiri Kosina1210machine # [ 2.127726] systemd[1]: Mounting /sysroot...1211sshClient # [ 2.144634] systemd[1]: Mounting /sysroot...1212machine # [ 2.366246] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1213machine # [ 2.367410] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001214machine # [ 2.368180] ata3.00: applying bridge limits1215machine # [ 2.368871] ata6: SATA link down (SStatus 0 SControl 300)1216machine # [ 2.369872] ata2: SATA link down (SStatus 0 SControl 300)1217machine # [ 2.370790] ata4: SATA link down (SStatus 0 SControl 300)1218machine # [ 2.371723] ata1: SATA link down (SStatus 0 SControl 300)1219machine # [ 2.372719] ata5: SATA link down (SStatus 0 SControl 300)1220machine # [ 2.373623] ata3.00: configured for UDMA/1001221machine # [ 2.374643] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51222sshClient # [ 2.367357] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1223sshClient # [ 2.369714] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001224sshClient # [ 2.371944] ata3.00: applying bridge limits1225sshClient # [ 2.373866] ata5: SATA link down (SStatus 0 SControl 300)1226machine # [ 2.432574] usbcore: registered new interface driver usbhid1227sshClient # [ 2.376156] ata6: SATA link down (SStatus 0 SControl 300)1228machine # [ 2.435368] usbhid: USB HID core driver1229sshClient # [ 2.378503] ata2: SATA link down (SStatus 0 SControl 300)1230sshClient # [ 2.380700] ata1: SATA link down (SStatus 0 SControl 300)1231sshClient # [ 2.383074] ata4: SATA link down (SStatus 0 SControl 300)1232sshClient # [ 2.385365] ata3.00: configured for UDMA/1001233sshClient # [ 2.387793] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51234machine # [ 2.448484] 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/input21235machine # [ 2.453501] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01236machine # [ 2.460323] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1237machine # [ 2.476284] cdrom: Uniform CD-ROM driver Revision: 3.201238machine # [ 2.493490] EXT4-fs (vda): mounted filesystem 7c51f664-6b92-46e8-988a-d9be9058db81 r/w with ordered data mode. Quota mode: none.1239machine # [ 2.361397] systemd[1]: Mounted /sysroot.1240machine # [ 2.364063] systemd[1]: Reached target Initrd Root File System.1241machine # [ 2.366862] systemd[1]: Starting Mountpoints Configured in the Real Root...1242machine # [ 2.377282] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload.1243sshClient # [ 2.458089] usbcore: registered new interface driver usbhid1244machine # [ 2.382983] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)...1245sshClient # [ 2.462250] usbhid: USB HID core driver1246machine # [ 2.384425] systemd[1]: Reloading...1247sshClient # [ 2.473227] 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/input21248sshClient # [ 2.478538] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01249sshClient # [ 2.480764] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1250sshClient # [ 2.497395] cdrom: Uniform CD-ROM driver Revision: 3.201251sshClient # [ 2.521802] EXT4-fs (vda): mounted filesystem b7059297-a5ff-439c-8f84-1858122c8017 r/w with ordered data mode. Quota mode: none.1252sshClient # [ 2.395103] systemd[1]: Mounted /sysroot.1253sshClient # [ 2.395800] systemd[1]: Reached target Initrd Root File System.1254machine # [ 2.456648] systemd[1]: Reloading finished in 74 ms.1255sshClient # [ 2.399090] systemd[1]: Starting Mountpoints Configured in the Real Root...1256machine # [ 2.463644] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace...1257machine # [ 2.468178] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace...1258machine # [ 2.471877] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1259machine # [ 2.473265] systemd[1]: Finished Mountpoints Configured in the Real Root.1260sshClient # [ 2.415765] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.1261machine # [ 2.474275] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1262sshClient # [ 2.418937] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...1263sshClient # [ 2.420434] systemd[1]: Reloading...1264sshClient # [ 2.496216] systemd[1]: Reloading finished in 74 ms.1265sshClient # [ 2.504520] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...1266sshClient # [ 2.509213] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...1267sshClient # [ 2.513074] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1268sshClient # [ 2.515069] systemd[1]: Finished Mountpoints Configured in the Real Root.1269sshClient # [ 2.515987] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1270machine # [ 3.128941] systemd[1]: Mounting /sysroot/nix/.ro-store...1271machine # [ 3.131142] systemd[1]: Mounting /sysroot/nix/.rw-store...1272machine # [ 3.136144] systemd[1]: Mounting /sysroot/run...1273machine # [ 3.140791] systemd[1]: Mounting /sysroot/tmp/shared...1274machine # [ 3.149155] systemd[1]: Mounting /sysroot/tmp/xchg...1275machine # [ 3.168041] systemd[1]: Mounted /sysroot/nix/.ro-store.1276machine # [ 3.175073] systemd[1]: Mounted /sysroot/nix/.rw-store.1277machine # [ 3.175811] systemd[1]: Mounted /sysroot/run.1278machine # [ 3.176511] systemd[1]: Mounted /sysroot/tmp/shared.1279machine # [ 3.182082] systemd[1]: Starting rw-sysroot-nix-store.service...1280machine # [ 3.183748] systemd[1]: Mounted /sysroot/tmp/xchg.1281machine # [ 3.193478] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1282machine # [ 3.195077] systemd[1]: Finished rw-sysroot-nix-store.service.1283sshClient # [ 3.147223] systemd[1]: Mounting /sysroot/nix/.ro-store...1284sshClient # [ 3.152114] systemd[1]: Mounting /sysroot/nix/.rw-store...1285sshClient # [ 3.157193] systemd[1]: Mounting /sysroot/run...1286sshClient # [ 3.163095] systemd[1]: Mounting /sysroot/tmp/shared...1287sshClient # [ 3.170209] systemd[1]: Mounting /sysroot/tmp/xchg...1288sshClient # [ 3.214101] systemd[1]: Mounted /sysroot/nix/.ro-store.1289sshClient # [ 3.218035] systemd[1]: Mounted /sysroot/nix/.rw-store.1290sshClient # [ 3.219111] systemd[1]: Mounted /sysroot/run.1291sshClient # [ 3.219957] systemd[1]: Mounted /sysroot/tmp/shared.1292sshClient # [ 3.221148] systemd[1]: Mounted /sysroot/tmp/xchg.1293sshClient # [ 3.225406] systemd[1]: Starting rw-sysroot-nix-store.service...1294sshClient # [ 3.237345] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1295sshClient # [ 3.239072] systemd[1]: Finished rw-sysroot-nix-store.service.1296sshClient # [ 3.241387] systemd[1]: Mounting /sysroot/nix/store...1297sshClient # [ 3.265859] systemd[1]: Mounted /sysroot/nix/store.1298sshClient # [ 3.267077] systemd[1]: Reached target Initrd File Systems.1299sshClient # [ 3.268850] systemd[1]: Starting Find NixOS closure...1300sshClient # [ 3.271509] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1301sshClient # [ 3.295408] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1302sshClient # [ 3.302919] systemd[1]: Finished Find NixOS closure.1303sshClient # [ 3.304533] systemd[1]: Reached target Initrd Default Target.1304sshClient # [ 3.306540] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1305sshClient # [ 3.324207] systemd[1]: Stopped target Initrd Default Target.1306sshClient # [ 3.325112] systemd[1]: Stopped target Basic System.1307sshClient # [ 3.325845] systemd[1]: Stopped target Initrd Root Device.1308sshClient # [ 3.326607] systemd[1]: Stopped target Path Units.1309sshClient # [ 3.327325] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1310sshClient # [ 3.328363] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1311sshClient # [ 3.329508] systemd[1]: Stopped target Slice Units.1312sshClient # [ 3.330561] systemd[1]: Stopped target Socket Units.1313sshClient # [ 3.331581] systemd[1]: Stopped target System Initialization.1314sshClient # [ 3.332797] systemd[1]: Stopped target Swaps.1315sshClient # [ 3.334118] systemd[1]: Stopped target Timer Units.1316sshClient # [ 3.334836] systemd[1]: dbus.socket: Deactivated successfully.1317sshClient # [ 3.335738] systemd[1]: Closed D-Bus System Message Bus Socket.1318sshClient # [ 3.337200] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1319sshClient # [ 3.338283] systemd[1]: Stopped Find NixOS closure.1320sshClient # [ 3.339618] systemd[1]: Starting rw-sysroot-nix-store.service...1321sshClient # [ 3.340647] systemd[1]: systemd-sysctl.service: Deactivated successfully.1322sshClient # [ 3.342249] systemd[1]: Stopped Apply Kernel Variables.1323sshClient # [ 3.343267] systemd[1]: systemd-modules-load.service: Deactivated successfully.1324sshClient # [ 3.344489] systemd[1]: Stopped Load Kernel Modules.1325sshClient # [ 3.346062] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1326sshClient # [ 3.347143] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1327sshClient # [ 3.348210] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1328sshClient # [ 3.349332] systemd[1]: Stopped Create System Files and Directories.1329sshClient # [ 3.350212] systemd[1]: Stopped target Local File Systems.1330sshClient # [ 3.352112] systemd[1]: Stopped target Preparation for Local File Systems.1331sshClient # [ 3.353054] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1332sshClient # [ 3.354141] systemd[1]: Stopped Coldplug All udev Devices.1333sshClient # [ 3.356102] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1334sshClient # [ 3.357133] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1335sshClient # [ 3.359476] systemd[1]: Stopped Virtual Console Setup.1336sshClient # [ 3.369633] systemd[1]: systemd-udevd.service: Deactivated successfully.1337sshClient # [ 3.371469] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1338sshClient # [ 3.376084] systemd[1]: initrd-cleanup.service: Deactivated successfully.1339sshClient # [ 3.379097] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1340sshClient # [ 3.384108] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.1341sshClient # [ 3.385966] systemd[1]: Closed udev Varlink Socket.1342sshClient # [ 3.387885] systemd[1]: Starting Cleanup udev Database...1343sshClient # [ 3.389130] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1344sshClient # [ 3.390174] systemd[1]: Stopped Create Static Device Nodes in /dev.1345sshClient # [ 3.391118] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1346sshClient # [ 3.393131] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1347sshClient # [ 3.394281] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1348sshClient # [ 3.396153] systemd[1]: Stopped Create List of Static Device Nodes.1349sshClient # [ 3.397030] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1350sshClient # [ 3.399176] systemd[1]: Finished rw-sysroot-nix-store.service.1351sshClient # [ 3.416073] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1352sshClient # [ 3.418181] systemd[1]: Finished Cleanup udev Database.1353sshClient # [ 3.418972] systemd[1]: Reached target Switch Root.1354sshClient # [ 3.420978] systemd[1]: Starting NixOS Activation...1355sshClient # [ 3.500754] initrd-nixos-activation-start[190]: booting system configuration /nix/store/fi5wi6w23z4hxhp8w9s2li85rkv09p73-nixos-system-sshClient-test1356sshClient # [ 3.529635] initrd-nixos-activation-start[190]: running activation script...1357sshClient # [ 3.717368] initrd-nixos-activation-start[213]: setting up /etc...1358sshClient # [ 3.818649] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1359sshClient # [ 3.820312] systemd[1]: Finished NixOS Activation.1360sshClient # [ 3.822474] systemd[1]: Starting Switch Root...1361sshClient # [ 3.840055] systemd[1]: Switching root.1362sshClient # [ 4.109888] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1363sshClient # [ 4.176425] NET: Registered PF_VSOCK protocol family1364sshClient # [ 4.202253] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)1365sshClient # [ 4.206416] systemd[1]: Detected virtualization kvm.1366machine # [ 4.127941] systemd[1]: Mounting /sysroot/nix/store...1367sshClient # [ 4.207089] systemd[1]: Detected architecture x86-64.1368sshClient # [ 4.207831] systemd[1]: Detected first boot.1369sshClient # [ 4.209717] systemd[1]: Initializing machine ID from random generator.1370machine # [ 4.149961] systemd[1]: Mounted /sysroot/nix/store.1371machine # [ 4.152085] systemd[1]: Reached target Initrd File Systems.1372machine # [ 4.153509] systemd[1]: Starting Find NixOS closure...1373machine # [ 4.157152] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1374machine # [ 4.176035] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1375machine # [ 4.179653] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1376machine # [ 4.185799] systemd[1]: Finished Find NixOS closure.1377machine # [ 4.187314] systemd[1]: Reached target Initrd Default Target.1378machine # [ 4.189127] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1379machine # [ 4.203540] systemd[1]: Stopped target Initrd Default Target.1380machine # [ 4.204609] systemd[1]: Stopped target Basic System.1381machine # [ 4.206131] systemd[1]: Stopped target Initrd Root Device.1382machine # [ 4.206914] systemd[1]: Stopped target Path Units.1383machine # [ 4.207635] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1384machine # [ 4.208752] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1385machine # [ 4.210059] systemd[1]: Stopped target Slice Units.1386machine # [ 4.211231] systemd[1]: Stopped target Socket Units.1387machine # [ 4.212280] systemd[1]: Stopped target System Initialization.1388machine # [ 4.214156] systemd[1]: Stopped target Swaps.1389machine # [ 4.214772] systemd[1]: Stopped target Timer Units.1390machine # [ 4.215512] systemd[1]: dbus.socket: Deactivated successfully.1391machine # [ 4.216493] systemd[1]: Closed D-Bus System Message Bus Socket.1392machine # [ 4.217314] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1393machine # [ 4.218327] systemd[1]: Stopped Find NixOS closure.1394machine # [ 4.219646] systemd[1]: Starting rw-sysroot-nix-store.service...1395machine # [ 4.221213] systemd[1]: systemd-sysctl.service: Deactivated successfully.1396machine # [ 4.222332] systemd[1]: Stopped Apply Kernel Variables.1397machine # [ 4.223270] systemd[1]: systemd-modules-load.service: Deactivated successfully.1398machine # [ 4.224445] systemd[1]: Stopped Load Kernel Modules.1399machine # [ 4.225476] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1400machine # [ 4.227228] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1401machine # [ 4.228513] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1402machine # [ 4.229729] systemd[1]: Stopped Create System Files and Directories.1403machine # [ 4.230932] systemd[1]: Stopped target Local File Systems.1404machine # [ 4.232321] systemd[1]: Stopped target Preparation for Local File Systems.1405machine # [ 4.233408] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1406machine # [ 4.234577] systemd[1]: Stopped Coldplug All udev Devices.1407machine # [ 4.237499] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1408machine # [ 4.238551] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1409machine # [ 4.239506] systemd[1]: Stopped Virtual Console Setup.1410machine # [ 4.248367] systemd[1]: initrd-cleanup.service: Deactivated successfully.1411machine # [ 4.252102] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1412machine # [ 4.257137] systemd[1]: systemd-udevd.service: Deactivated successfully.1413sshClient # [ 4.335905] systemd[1]: bpf-restrict-fs: LSM BPF program attached1414machine # [ 4.259152] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1415machine # [ 4.261151] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.1416machine # [ 4.262751] systemd[1]: Closed udev Varlink Socket.1417machine # [ 4.264433] systemd[1]: Starting Cleanup udev Database...1418machine # [ 4.265284] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1419machine # [ 4.266386] systemd[1]: Stopped Create Static Device Nodes in /dev.1420machine # [ 4.268240] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1421machine # [ 4.269435] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1422machine # [ 4.270533] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1423machine # [ 4.271615] systemd[1]: Stopped Create List of Static Device Nodes.1424machine # [ 4.272933] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1425machine # [ 4.275136] systemd[1]: Finished rw-sysroot-nix-store.service.1426machine # [ 4.290276] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1427machine # [ 4.291856] systemd[1]: Finished Cleanup udev Database.1428machine # [ 4.294123] systemd[1]: Reached target Switch Root.1429machine # [ 4.295147] systemd[1]: Starting NixOS Activation...1430sshClient # [ 4.405129] systemd[1]: Applying preset policy.1431machine # [ 4.370812] initrd-nixos-activation-start[189]: booting system configuration /nix/store/70g6p2yffrnb6lxqrk2zjwr15phylwr7-nixos-system-machine-test1432machine # [ 4.398909] initrd-nixos-activation-start[189]: running activation script...1433sshClient # [ 4.581275] systemd[1]: Populated /etc with preset unit settings.1434machine # [ 4.581375] initrd-nixos-activation-start[212]: setting up /etc...1435machine # [ 4.674994] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1436machine # [ 4.677377] systemd[1]: Finished NixOS Activation.1437machine # [ 4.678324] systemd[1]: Starting Switch Root...1438sshClient # [ 4.759936] systemd[1]: initrd-switch-root.service: Deactivated successfully.1439sshClient # [ 4.761277] systemd[1]: Stopped initrd-switch-root.service.1440sshClient # [ 4.763919] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1441sshClient # [ 4.766116] systemd[1]: Created slice Slice /system/getty.1442sshClient # [ 4.767516] systemd[1]: Created slice User and Session Slice.1443sshClient # [ 4.768473] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1444sshClient # [ 4.769702] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1445machine # [ 4.692314] systemd[1]: Switching root.1446sshClient # [ 4.770820] systemd[1]: Expecting device /dev/hvc0...1447sshClient # [ 4.771578] systemd[1]: Expecting device /dev/ttyS0...1448sshClient # [ 4.772318] systemd[1]: Reached target Local Encrypted Volumes.1449sshClient # [ 4.773171] systemd[1]: Stopped target initrd-fs.target.1450sshClient # [ 4.773894] systemd[1]: Stopped target initrd-root-fs.target.1451sshClient # [ 4.774688] systemd[1]: Stopped target initrd-switch-root.target.1452sshClient # [ 4.787035] systemd[1]: Reached target Virtual Machines and Containers.1453sshClient # [ 4.787934] systemd[1]: Reached target Path Units.1454sshClient # [ 4.788629] systemd[1]: Reached target Remote File Systems.1455sshClient # [ 4.789426] systemd[1]: Reached target Slice Units.1456sshClient # [ 4.790111] systemd[1]: Reached target Swaps.1457machine # [ 4.848533] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1458sshClient # [ 4.792033] systemd[1]: Listening on Query the User Interactively for a Password.1459sshClient # [ 4.794541] systemd[1]: Listening on Process Core Dump Socket.1460sshClient # [ 4.796247] systemd[1]: Listening on Credential Encryption/Decryption.1461sshClient # [ 4.798045] systemd[1]: Listening on Factory Reset Management.1462sshClient # [ 4.799008] systemd[1]: Listening on Hostname Service Socket.1463sshClient # [ 4.801831] systemd[1]: Starting Journal Log Access Socket...1464sshClient # [ 4.803617] systemd[1]: Listening on Journal Audit Socket.1465sshClient # [ 4.806573] systemd[1]: Listening on Console Output Muting Service Socket.1466sshClient # [ 4.807801] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1467sshClient # [ 4.808915] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1468sshClient # [ 4.810238] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1469sshClient # [ 4.814202] systemd[1]: Listening on Disk Repartitioning Service Socket.1470sshClient # [ 4.815287] systemd[1]: Listening on udev Varlink Socket.1471sshClient # [ 4.816167] systemd[1]: Listening on User Database Manager Socket.1472sshClient # [ 4.818837] systemd[1]: Mounting Huge Pages File System...1473sshClient # [ 4.821535] systemd[1]: Mounting POSIX Message Queue File System...1474sshClient # [ 4.829964] systemd[1]: Mounting Kernel Debug File System...1475sshClient # [ 4.837831] systemd[1]: Mounting Kernel Trace File System...1476sshClient # [ 4.846475] systemd[1]: Starting Create List of Static Device Nodes...1477machine # [ 4.904812] NET: Registered PF_VSOCK protocol family1478sshClient # [ 4.859357] systemd[1]: Starting Load Kernel Module configfs...1479sshClient # [ 4.869490] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1480machine # [ 4.924898] systemd[1]: systemd 263-558da31 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE +EXPERIMENTAL-ENVVAR)1481machine # [ 4.928962] systemd[1]: Detected virtualization kvm.1482machine # [ 4.929671] systemd[1]: Detected architecture x86-64.1483machine # [ 4.930469] systemd[1]: Detected first boot.1484machine # [ 4.931860] systemd[1]: Initializing machine ID from random generator.1485sshClient # [ 4.875911] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1486sshClient # [ 4.885656] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1487sshClient # [ 4.901207] systemd[1]: Mounting FUSE Control File System...1488sshClient # [ 4.907342] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671489sshClient # [ 4.923711] systemd[1]: Starting Journal Service...1490sshClient # [ 4.930609] systemd[1]: Starting Load Kernel Modules...1491sshClient # [ 4.942255] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1492sshClient # [ 4.954598] systemd[1]: Starting Remount Root and Kernel File Systems...1493sshClient # [ 4.959899] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1494sshClient # [ 4.980570] systemd[1]: Starting Coldplug All udev Devices...1495sshClient # [ 4.992076] systemd[1]: Listening on Journal Log Access Socket.1496sshClient # [ 4.996748] systemd[1]: Mounted Huge Pages File System.1497machine # [ 5.057559] systemd[1]: bpf-restrict-fs: LSM BPF program attached1498sshClient # [ 5.000727] systemd[1]: Mounted POSIX Message Queue File System.1499sshClient # [ 5.003594] systemd[1]: Mounted Kernel Debug File System.1500sshClient # [ 5.007858] systemd-journald[284]: Collecting audit messages is enabled.1501sshClient # [ 5.010507] systemd[1]: Mounted Kernel Trace File System.1502sshClient # [ 5.024487] systemd[1]: Finished Create List of Static Device Nodes.1503sshClient # [ 5.027547] loop: module loaded1504sshClient # [ 5.032843] systemd[1]: modprobe@configfs.service: Deactivated successfully.1505sshClient # [ 4.900453] systemd[1]: Queued start job for default target Multi-User System.1506sshClient # [ 5.037738] EXT4-fs (vda): re-mounted b7059297-a5ff-439c-8f84-1858122c8017.1507sshClient # [ 5.040618] systemd[1]: Finished Load Kernel Module configfs.1508sshClient # [ 4.905411] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.1509sshClient # [ 4.906755] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.1510sshClient # [ 4.909338] systemd[1]: systemd-journald.service: Deactivated successfully.1511sshClient # [ 5.048299] systemd[1]: Started Journal Service.1512sshClient # [ 4.914192] systemd-modules-load[285]: Inserted module 'loop'1513sshClient # [ 4.918104] systemd[1]: Mounted FUSE Control File System.1514sshClient # [ 4.920827] systemd[1]: Finished Load Kernel Modules.1515sshClient # [ 4.924545] systemd[1]: Finished Remount Root and Kernel File Systems.1516machine # [ 5.133365] systemd[1]: Applying preset policy.1517sshClient # [ 4.939513] systemd[1]: Listening on Disk Image Download Service Socket.1518sshClient # [ 4.944090] systemd[1]: Mounting Kernel Configuration File System...1519sshClient # [ 4.947179] systemd[1]: Starting Firewall...1520sshClient # [ 4.953244] systemd[1]: Starting Flush Journal to Persistent Storage...1521sshClient # [ 4.954191] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1522sshClient # [ 4.960251] systemd-oomd[286]: No swap; memory pressure usage will be degraded1523sshClient # [ 4.965277] systemd[1]: Starting Load/Save OS Random Seed...1524sshClient # [ 4.974502] systemd[1]: Starting Apply Kernel Variables...1525sshClient # [ 5.000776] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1526sshClient # [ 5.001854] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1527sshClient # [ 5.003150] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1528sshClient # [ 5.209609] systemd-journald[284]: Received client request to flush runtime journal.1529machine # [ 5.308876] systemd[1]: Populated /etc with preset unit settings.1530sshClient # [ 5.164537] systemd[1]: Mounted Kernel Configuration File System.1531sshClient # [ 5.165666] systemd[1]: Finished Load/Save OS Random Seed.1532sshClient # [ 5.167541] systemd[1]: Finished Apply Kernel Variables.1533sshClient # [ 5.171453] systemd[1]: Finished Flush Journal to Persistent Storage.1534sshClient # [ 5.200200] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1535sshClient # [ 5.205523] systemd[1]: Starting Create Static Device Nodes in /dev...1536sshClient # [ 5.273759] systemd[1]: Finished Coldplug All udev Devices.1537sshClient # [ 5.295794] systemd[1]: Finished Create Static Device Nodes in /dev.1538machine # [ 5.490382] systemd[1]: initrd-switch-root.service: Deactivated successfully.1539sshClient # [ 5.297201] systemd[1]: Reached target Preparation for Local File Systems.1540machine # [ 5.491737] systemd[1]: Stopped initrd-switch-root.service.1541sshClient # [ 5.299961] systemd[1]: Starting Rule-based Manager for Device Events and Files...1542machine # [ 5.493757] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1543machine # [ 5.495929] systemd[1]: Created slice Slice /system/getty.1544machine # [ 5.497307] systemd[1]: Created slice User and Session Slice.1545machine # [ 5.498202] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1546machine # [ 5.499401] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1547machine # [ 5.500512] systemd[1]: Expecting device /dev/hvc0...1548machine # [ 5.501266] systemd[1]: Expecting device /dev/ttyS0...1549machine # [ 5.501986] systemd[1]: Reached target Local Encrypted Volumes.1550machine # [ 5.502845] systemd[1]: Stopped target initrd-fs.target.1551machine # [ 5.503622] systemd[1]: Stopped target initrd-root-fs.target.1552machine # [ 5.504437] systemd[1]: Stopped target initrd-switch-root.target.1553machine # [ 5.516844] systemd[1]: Reached target Virtual Machines and Containers.1554machine # [ 5.517786] systemd[1]: Reached target Path Units.1555machine # [ 5.518510] systemd[1]: Reached target Remote File Systems.1556machine # [ 5.519350] systemd[1]: Reached target Slice Units.1557machine # [ 5.520082] systemd[1]: Reached target Swaps.1558machine # [ 5.521773] systemd[1]: Listening on Query the User Interactively for a Password.1559machine # [ 5.524075] systemd[1]: Listening on Process Core Dump Socket.1560machine # [ 5.525685] systemd[1]: Listening on Credential Encryption/Decryption.1561machine # [ 5.527311] systemd[1]: Listening on Factory Reset Management.1562machine # [ 5.528278] systemd[1]: Listening on Hostname Service Socket.1563machine # [ 5.530762] systemd[1]: Starting Journal Log Access Socket...1564machine # [ 5.532671] systemd[1]: Listening on Journal Audit Socket.1565machine # [ 5.534808] systemd[1]: Listening on Console Output Muting Service Socket.1566machine # [ 5.535946] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1567machine # [ 5.537034] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1568machine # [ 5.538385] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1569machine # [ 5.541767] systemd[1]: Listening on Disk Repartitioning Service Socket.1570sshClient # [ 5.348349] systemd-udevd[324]: Using default interface naming scheme 'v261'.1571machine # [ 5.542823] systemd[1]: Listening on udev Varlink Socket.1572machine # [ 5.543740] systemd[1]: Listening on User Database Manager Socket.1573machine # [ 5.545982] systemd[1]: Mounting Huge Pages File System...1574machine # [ 5.548505] systemd[1]: Mounting POSIX Message Queue File System...1575machine # [ 5.556242] systemd[1]: Mounting Kernel Debug File System...1576sshClient # [ 5.369217] systemd[1]: Starting User Database Manager...1577machine # [ 5.564435] systemd[1]: Mounting Kernel Trace File System...1578machine # [ 5.572615] systemd[1]: Starting Create List of Static Device Nodes...1579machine # [ 5.582984] systemd[1]: Starting Load Kernel Module configfs...1580machine # [ 5.586765] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1581machine # [ 5.600016] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1582sshClient # [ 5.414622] systemd[1]: Started User Database Manager.1583machine # [ 5.610434] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1584machine # [ 5.626290] systemd[1]: Mounting FUSE Control File System...1585machine # [ 5.627121] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671586machine # [ 5.636821] systemd[1]: Starting Journal Service...1587machine # [ 5.646451] systemd[1]: Starting Load Kernel Modules...1588machine # [ 5.655495] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1589sshClient # [ 5.472177] systemd[1]: Started Rule-based Manager for Device Events and Files.1590machine # [ 5.670887] systemd[1]: Starting Remount Root and Kernel File Systems...1591machine # [ 5.673694] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1592machine # [ 5.681060] systemd[1]: Starting Coldplug All udev Devices...1593machine # [ 5.688776] systemd[1]: Listening on Journal Log Access Socket.1594machine # [ 5.699488] systemd-journald[283]: Collecting audit messages is enabled.1595machine # [ 5.700451] systemd[1]: Mounted Huge Pages File System.1596machine # [ 5.704356] systemd[1]: Mounted POSIX Message Queue File System.1597machine # [ 5.711101] systemd[1]: Mounted Kernel Debug File System.1598machine # [ 5.715390] systemd[1]: Mounted Kernel Trace File System.1599machine # [ 5.723253] systemd[1]: Finished Create List of Static Device Nodes.1600machine # [ 5.591437] systemd[1]: Queued start job for default target Multi-User System.1601machine # [ 5.594359] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.1602machine # [ 5.732415] systemd[1]: Started Journal Service.1603sshClient # [ 5.539686] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1604machine # [ 5.598529] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.1605machine # [ 5.601805] systemd[1]: systemd-journald.service: Deactivated successfully.1606machine # [ 5.609776] systemd[1]: modprobe@configfs.service: Deactivated successfully.1607machine # [ 5.613059] systemd[1]: Finished Load Kernel Module configfs.1608machine # [ 5.756761] loop: module loaded1609machine # [ 5.624306] systemd[1]: Mounted FUSE Control File System.1610machine # [ 5.625504] systemd-modules-load[284]: Inserted module 'loop'1611machine # [ 5.638213] systemd[1]: Mounting Kernel Configuration File System...1612machine # [ 5.779177] EXT4-fs (vda): re-mounted 7c51f664-6b92-46e8-988a-d9be9058db81.1613machine # [ 5.645699] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1614machine # [ 5.652159] systemd[1]: Finished Load Kernel Modules.1615machine # [ 5.666102] systemd[1]: Starting Firewall...1616machine # [ 5.671799] systemd[1]: Starting Apply Kernel Variables...1617machine # [ 5.677222] systemd[1]: Finished Remount Root and Kernel File Systems.1618machine # [ 5.678358] systemd-oomd[286]: No swap; memory pressure usage will be degraded1619sshClient # [ 5.620909] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1620sshClient # [ 5.628522] systemd[1]: Mounting /run/wrappers...1621machine # [ 5.686797] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1622machine # [ 5.691265] systemd[1]: Listening on Disk Image Download Service Socket.1623machine # [ 5.709111] systemd[1]: Starting Flush Journal to Persistent Storage...1624machine # [ 5.710067] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1625sshClient # [ 5.659343] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1626machine # [ 5.726503] systemd[1]: Starting Load/Save OS Random Seed...1627machine # [ 5.727470] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1628sshClient # [ 5.672640] systemd[1]: Mounted /run/wrappers.1629sshClient # [ 5.674557] systemd[1]: Reached target Local File Systems.1630sshClient # [ 5.678888] systemd[1]: Listening on Boot Loader Control Service Socket.1631sshClient # [ 5.682075] systemd[1]: Starting Create SUID/SGID Wrappers...1632sshClient # [ 5.682942] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1633sshClient # [ 5.688211] systemd[1]: Starting Create System Files and Directories...1634machine # [ 5.913421] systemd-journald[283]: Received client request to flush runtime journal.1635sshClient # [ 5.722316] (udev-worker)[367]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1636sshClient # [ 5.731101] (udev-worker)[367]: Network interface NamePolicy= disabled on kernel command line.1637sshClient # [ 5.738929] (udev-worker)[356]: Network interface NamePolicy= disabled on kernel command line.1638sshClient # [ 5.809543] systemd[1]: Finished Create System Files and Directories.1639sshClient # [ 5.818234] systemd[1]: Starting Rebuild Journal Catalog...1640sshClient # [ 5.822924] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1641machine # [ 5.883549] systemd[1]: Mounted Kernel Configuration File System.1642machine # [ 5.885803] systemd[1]: Finished Load/Save OS Random Seed.1643machine # [ 5.890319] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1644machine # [ 5.891361] systemd[1]: Starting Create Static Device Nodes in /dev...1645machine # [ 5.892291] systemd[1]: Finished Apply Kernel Variables.1646machine # [ 5.899166] systemd[1]: Finished Flush Journal to Persistent Storage.1647sshClient # [ 5.914920] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1648machine # [ 5.979159] systemd[1]: Finished Create Static Device Nodes in /dev.1649machine # [ 5.980176] systemd[1]: Reached target Preparation for Local File Systems.1650machine # [ 5.984413] systemd[1]: Starting Rule-based Manager for Device Events and Files...1651sshClient # [ 5.935928] systemd[1]: Finished Rebuild Journal Catalog.1652sshClient # [ 5.942823] systemd[1]: Starting Update is Completed...1653machine # [ 6.003839] systemd[1]: Finished Coldplug All udev Devices.1654machine # [ 6.039762] systemd-udevd[320]: Using default interface naming scheme 'v261'.1655sshClient # [ 5.995050] systemd[1]: Condition check resulted in Virtio network device being skipped.1656sshClient # [ 5.997136] systemd[1]: Condition check resulted in Virtio network device being skipped.1657machine # [ 6.057948] systemd[1]: Starting User Database Manager...1658sshClient # [ 6.001128] systemd[1]: Finished Update is Completed.1659sshClient # [ 6.003378] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1660sshClient # [ 6.004980] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1661sshClient # [ 6.007194] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671662sshClient # [ 6.011169] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1663sshClient # [ 6.013484] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1664sshClient # [ 6.014775] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1665machine # [ 6.101045] systemd[1]: Started User Database Manager.1666machine # [ 6.151105] systemd[1]: Started Rule-based Manager for Device Events and Files.1667machine # [ 6.210977] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1668sshClient # [ 6.302944] mousedev: PS/2 mouse device common for all mice1669sshClient # [ 6.219564] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1670sshClient # [ 6.223910] systemd[1]: Finished Create SUID/SGID Wrappers.1671sshClient # [ 6.225110] systemd[1]: Reached target System Initialization.1672machine # [ 6.283686] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1673sshClient # [ 6.228489] systemd[1]: Started Discard unused filesystem blocks once a week.1674sshClient # [ 6.229515] systemd[1]: Started Daily Cleanup of Temporary Directories.1675sshClient # [ 6.230542] systemd[1]: Reached target Timer Units.1676sshClient # [ 6.232474] systemd[1]: Listening on D-Bus System Message Bus Socket.1677sshClient # [ 6.233510] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1678sshClient # [ 6.235496] systemd[1]: Reached target Socket Units.1679sshClient # [ 6.237151] systemd[1]: Reached target Basic System.1680sshClient # [ 6.241722] systemd[1]: Started backdoor.service.1681sshClient # [ 6.245842] systemd[1]: Starting Import lastlog data into lastlog2 database...1682machine # [ 6.310127] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1683sshClient # [ 6.256170] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1684sshClient # [ 6.265104] systemd[1]: Starting Post-Boot Actions...1685sshClient # [ 6.281220] systemd[1]: Started Reset console on configuration changes.1686machine # [ 6.343340] (udev-worker)[364]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1687machine # [ 6.345639] (udev-worker)[364]: Network interface NamePolicy= disabled on kernel command line.1688machine # [ 6.352759] (udev-worker)[355]: Network interface NamePolicy= disabled on kernel command line.1689sshClient # [ 6.299484] systemd[1]: Starting resolvconf update...1690machine # [ 6.359082] systemd[1]: Mounting /run/wrappers...1691sshClient # [ 6.329556] systemd[1]: Starting Home Area Manager...1692machine # [ 6.404291] systemd[1]: Mounted /run/wrappers.1693machine # [ 6.406069] systemd[1]: Reached target Local File Systems.1694machine # [ 6.411496] systemd[1]: Listening on Boot Loader Control Service Socket.1695sshClient # [ 6.354299] systemd[1]: Finished Firewall.1696machine # [ 6.416070] systemd[1]: Starting Create SUID/SGID Wrappers...1697machine # [ 6.416897] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1698machine # [ 6.426498] systemd[1]: Starting Create System Files and Directories...1699sshClient # [ 6.512192] rtc_cmos PNP0B00:00: RTC can wake from S41700sshClient # [ 6.401905] systemd[1]: Starting D-Bus System Message Bus...1701sshClient # connecting to host...1702sshClient # [ 6.421701] nsncd[502]: Oct 22 03:07:14.859 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1703sshClient # [ 6.431476] systemd[1]: Finished Post-Boot Actions.1704sshClient # [ 6.432286] systemd[1]: Started Name Service Cache Daemon (nsncd).1705sshClient # [ 6.469681] systemd[1]: Reached target Host and Network Name Lookups.1706sshClient # [ 6.471582] systemd[1]: Reached target User and Group Name Lookups.1707machine # [ 6.532278] systemd[1]: Finished Create System Files and Directories.1708sshClient # [ 6.618410] rtc_cmos PNP0B00:00: registered as rtc01709sshClient # [ 6.619300] rtc_cmos PNP0B00:00: setting system clock to 2026-10-22T03:07:14 UTC (1792638434)1710machine # [ 6.542179] systemd[1]: Starting Rebuild Journal Catalog...1711sshClient # [ 6.621285] systemd-journald[284]: Time jumped backwards, rotating.1712machine # [ 6.546578] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1713machine # [ 6.558144] systemd[1]: Condition check resulted in Virtio network device being skipped.1714machine # [ 6.559927] systemd[1]: Condition check resulted in Virtio network device being skipped.1715machine # [ 6.561580] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1716machine # [ 6.563799] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1717machine # [ 6.565611] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671718machine # [ 6.570321] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1719machine # [ 6.572995] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1720machine # [ 6.576345] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1721sshClient # [ 6.684799] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input31722sshClient # [ 6.552810] systemd[1]: Starting User Login Management...1723sshClient # [ 6.695714] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1724sshClient # [ 6.566949] systemd-homed[508]: Watching /home.1725sshClient # [ 6.572927] systemd[1]: Finished Import lastlog data into lastlog2 database.1726machine # [ 6.659565] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1727machine # [ 6.673679] systemd[1]: Finished Rebuild Journal Catalog.1728machine # [ 6.679147] systemd[1]: Starting Update is Completed...1729sshClient # [ 6.664782] systemd[1]: Stopped target Host and Network Name Lookups.1730sshClient # [ 6.665853] systemd[1]: Stopping Host and Network Name Lookups...1731sshClient # [ 6.668298] systemd[1]: Stopped target User and Group Name Lookups.1732sshClient # [ 6.670697] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'...1733sshClient # [ 6.673277] systemd[1]: Stopping User and Group Name Lookups...1734machine # [ 6.732746] systemd[1]: Finished Update is Completed.1735sshClient # [ 6.681145] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1736sshClient # [ 6.684843] systemd[1]: nscd.service: Deactivated successfully.1737sshClient # [ 6.686113] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1738sshClient # [ 6.688669] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync'1739sshClient # [ 6.689913] dbus-broker-launch[512]: Invalid user-name in /nix/store/q7qs7i5c58kg1fjc1m7gq4dsp5mq0dwv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1740machine # [ 6.893255] mousedev: PS/2 mouse device common for all mice1741sshClient # [ 6.705189] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1742sshClient # [ 6.725113] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1743machine # [ 7.029650] rtc_cmos PNP0B00:00: RTC can wake from S41744sshClient # [ 6.728228] parport_pc 00:02: reported by Plug and Play ACPI1745sshClient # [ 6.728330] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1746sshClient # [ 6.744982] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1747sshClient # [ 6.890924] Console: switching to colour dummy device 80x251748machine # [ 7.066366] rtc_cmos PNP0B00:00: registered as rtc01749machine # [ 7.067114] rtc_cmos PNP0B00:00: setting system clock to 2026-10-22T03:07:14 UTC (1792638434)1750machine # [ 7.068743] systemd-journald[283]: Time jumped backwards, rotating.1751machine # [ 7.086739] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input31752machine # [ 7.096614] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1753machine # [ 7.105541] parport_pc 00:02: reported by Plug and Play ACPI1754sshClient # [ 6.955516] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1755sshClient # [ 6.955630] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1756machine # [ 6.980376] systemd[1]: Finished Firewall.1757machine # [ 7.118238] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1758machine # [ 7.126721] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1759machine # [ 7.014605] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1760machine # [ 7.017201] systemd[1]: Finished Create SUID/SGID Wrappers.1761machine # [ 7.018939] systemd[1]: Reached target System Initialization.1762machine # [ 7.021565] systemd[1]: Started Discard unused filesystem blocks once a week.1763machine # [ 7.022612] systemd[1]: Started Daily Cleanup of Temporary Directories.1764machine # [ 7.023841] systemd[1]: Reached target Timer Units.1765machine # [ 7.024631] systemd[1]: Listening on D-Bus System Message Bus Socket.1766machine # [ 7.028127] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1767sshClient # [ 7.106820] [drm] Found bochs VGA, ID 0xb0c5.1768sshClient # [ 7.106823] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1769machine # [ 7.029292] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1770machine # [ 7.030396] systemd[1]: Reached target Socket Units.1771sshClient # [ 6.727777] systemd[1]: Started D-Bus System Message Bus.1772machine # [ 7.031093] systemd[1]: Reached target Basic System.1773sshClient # [ 6.973718] nsncd[581]: Oct 22 03:07:14.812 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1774machine # [ 7.033075] systemd[1]: Started backdoor.service.1775machine # [ 7.034328] systemd[1]: Starting Import lastlog data into lastlog2 database...1776sshClient # [ 6.980157] dbus-broker-launch[512]: Ready1777sshClient # [ 6.984915] systemd[1]: Started Home Area Manager.1778machine # [ 7.044236] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1779sshClient # [ 6.994373] systemd[1]: Finished Home Area Activation.1780sshClient # [ 6.996341] network-addresses-eth1-start[611]: adding address 192.168.1.2/24... done1781machine # [ 7.054511] systemd[1]: Starting Post-Boot Actions...1782sshClient # [ 7.001537] systemd[1]: Starting First Boot Home Area Wizard...1783sshClient # [ 7.003751] systemd[1]: Started Name Service Cache Daemon (nsncd).1784sshClient # [ 7.007252] systemd[1]: Reached target Host and Network Name Lookups.1785machine # [ 7.067815] systemd[1]: Started Reset console on configuration changes.1786sshClient # [ 7.012108] systemd[1]: Reached target User and Group Name Lookups.1787sshClient # [ 7.012954] systemd[1]: Finished resolvconf update.1788sshClient # [ 7.015426] systemd[1]: Reached target Preparation for Network.1789sshClient # [ 7.016962] systemd[1]: Starting DHCP Client...1790sshClient # [ 7.155483] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1791sshClient # [ 7.156167] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01792sshClient # [ 7.020541] systemd[1]: Starting Address configuration of eth1...1793sshClient # [ 7.021738] systemd[1]: Starting Extra networking commands....1794machine # [ 7.081564] systemd[1]: Starting resolvconf update...1795sshClient # [ 7.026648] network-addresses-eth1-start[611]: adding address 2001:db8:1::2/64... done1796sshClient # [ 7.027703] systemd[1]: Starting Virtual Console Setup...1797sshClient # [ 7.028660] systemd-logind[532]: New seat seat0.1798sshClient # [ 7.032373] systemd[1]: Started User Login Management.1799sshClient # [ 7.172226] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51800machine # [ 7.100419] systemd[1]: Starting SSH Host Keys Generation...1801sshClient # [ 7.182676] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input41802sshClient # [ 7.050398] systemd[1]: Starting linger-users.service...1803machine # [ 7.127089] systemd[1]: Starting Home Area Manager...1804sshClient # [ 7.083371] systemd[1]: Finished Address configuration of eth1.1805sshClient # [ 7.087268] systemd-logind[532]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1806machine # [ 7.144540] nsncd[511]: Oct 22 03:07:14.712 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1807machine # [ 7.158837] systemd[1]: Started Name Service Cache Daemon (nsncd).1808machine # connecting to host...1809sshClient # [ 7.108116] systemd[1]: Finished First Boot Home Area Wizard.1810sshClient # [ 7.118453] systemd[1]: Reached target First Boot Complete.1811sshClient # [ 7.126263] systemd[1]: Starting Save Transient machine-id to Disk...1812machine # [ 7.185273] systemd[1]: Finished Post-Boot Actions.1813machine # [ 7.215252] systemd[1]: Reached target Host and Network Name Lookups.1814machine # [ 7.216187] systemd[1]: Reached target User and Group Name Lookups.1815machine: Guest shell says: b'Spawning backdoor root shell...\n'1816machine # [ 7.229449] systemd[1]: Starting D-Bus System Message Bus...1817sshClient # [ 7.182938] systemd[1]: linger-users.service: Deactivated successfully.1818sshClient # [ 7.187845] systemd[1]: Finished linger-users.service.1819machine # [ 7.246223] systemd[1]: Starting User Login Management...1820machine # [ 7.132954] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1821machine: connected to guest root shell1822machine # [ 7.312431] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1823machine: (connecting took 7.92 seconds)1824machine # [ 7.259684] systemd[1]: Finished Import lastlog data into lastlog2 database.1825machine: (finished: waiting for the VM to finish booting, in 7.92 seconds)1826machine # [ 7.299857] systemd-homed[519]: Watching /home.1827sshClient # [ 7.247327] dhcpcd[623]: dhcpcd-10.3.2 starting1828sshClient # [ 7.254227] systemd[1]: Finished Extra networking commands..1829sshClient # [ 7.256664] systemd[1]: Reached target Network.1830sshClient # [ 7.259634] dhcpcd[682]: dev: loaded udev1831sshClient # [ 7.263856] systemd[1]: Starting Permit User Sessions...1832machine # [ 7.312545] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1833machine # [ 7.393455] Console: switching to colour dummy device 80x251834machine # [ 7.494797] [drm] Found bochs VGA, ID 0xb0c5.1835machine # [ 7.494800] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1836machine # [ 7.497665] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51837machine # [ 7.498705] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input41838machine # [ 7.501608] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1839machine # [ 7.502353] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01840sshClient # [ 7.428029] 8021q: 802.1Q VLAN Support v1.81841sshClient # [ 7.428046] 8021q: adding VLAN 0 to HW filter on device eth11842sshClient # [ 7.429597] ppdev: user-space parallel port driver1843sshClient # [ 7.493765] Console: switching to colour frame buffer device 160x501844sshClient # [ 7.501260] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1845sshClient # [ 7.526087] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1846sshClient # [ 7.568402] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1847sshClient # [ 7.304641] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1848machine # [ 7.491385] systemd-logind[540]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1849sshClient # [ 7.433947] systemd[1]: Finished Save Transient machine-id to Disk.1850sshClient # [ 7.435041] systemd[1]: Finished Permit User Sessions.1851sshClient # [ 7.442118] systemd-logind[532]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)1852machine # [ 7.500476] systemd-logind[540]: New seat seat0.1853sshClient # [ 7.443579] systemd[1]: Started Getty on tty1.1854sshClient # [ 7.444557] systemd[1]: Reached target Login Prompts.1855machine # [ 7.508815] systemd[1]: Starting Virtual Console Setup...1856machine # [ 7.509661] systemd[1]: Started User Login Management.1857sshClient # [ 7.590075] cfg80211: Loading compiled-in X.509 certificates for regulatory database1858sshClient # [ 7.593069] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1859machine # [ 7.514190] dbus-broker-launch[538]: Looking up NSS user entry for 'systemd-timesync'...1860sshClient # [ 7.595842] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1861machine # [ 7.518246] systemd[1]: Starting linger-users.service...1862sshClient # [ 7.462749] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1863machine # [ 7.520862] dbus-broker-launch[538]: NSS returned no entry for 'systemd-timesync'1864sshClient # [ 7.601227] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21865machine # [ 7.521882] dbus-broker-launch[538]: Invalid user-name in /nix/store/q8inrnnqgnjc4w9vxa3cwpsk5rrw0zd3-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1866sshClient # [ 7.602072] cfg80211: failed to load regulatory.db1867sshClient # [ 7.466800] systemd[1]: Stopped Virtual Console Setup.1868sshClient # [ 7.471830] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1869sshClient # [ 7.480050] systemd[1]: Starting Virtual Console Setup...1870sshClient # [ 7.494169] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1871sshClient # [ 7.495605] systemd[1]: Stopped Virtual Console Setup.1872sshClient # [ 7.501269] systemd[1]: Starting Virtual Console Setup...1873machine # [ 7.566930] systemd[1]: Stopped target Host and Network Name Lookups.1874machine # [ 7.567868] systemd[1]: Stopping Host and Network Name Lookups...1875machine # [ 7.568642] systemd[1]: Stopped target User and Group Name Lookups.1876machine # [ 7.569470] systemd[1]: Stopping User and Group Name Lookups...1877machine # [ 7.570407] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1878machine # [ 7.579099] systemd[1]: nscd.service: Deactivated successfully.1879machine # [ 7.582333] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1880machine # [ 7.594725] systemd[1]: Started D-Bus System Message Bus.1881sshClient # [ 7.726287] kvm_amd: TSC scaling supported1882sshClient # [ 7.726725] kvm_amd: Nested Virtualization enabled1883sshClient # [ 7.727199] kvm_amd: Nested Paging enabled1884sshClient # [ 7.728123] 8021q: adding VLAN 0 to HW filter on device eth01885sshClient # [ 7.592674] dhcpcd[682]: eth0: waiting for carrier1886sshClient # [ 7.593840] dhcpcd[682]: eth0: carrier acquired1887sshClient # [ 7.730898] kvm_amd: LBR virtualization supported1888sshClient # [ 7.731862] kvm_amd: Virtual VMLOAD VMSAVE supported1889sshClient # [ 7.732616] kvm_amd: Virtual GIF supported1890sshClient # [ 7.733014] kvm_amd: Virtual NMI enabled1891sshClient # [ 7.607081] dhcpcd[682]: DUID 00:01:00:01:32:6c:3a:63:52:54:00:12:34:561892sshClient # [ 7.608064] dhcpcd[682]: eth0: IAID 00:12:34:561893sshClient # [ 7.608707] dhcpcd[682]: eth0: adding address fe80::5054:ff:fe12:34561894sshClient # [ 7.766067] EDAC MC: Ver: 3.0.01895machine # [ 7.844960] Console: switching to colour frame buffer device 160x501896machine # [ 7.856526] ppdev: user-space parallel port driver1897machine # [ 7.863074] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1898machine # [ 7.884100] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1899machine # [ 7.619283] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1900machine # [ 7.751751] dbus-broker-launch[538]: Ready1901sshClient # [ 7.696555] systemd-vconsole-setup[697]: Configuration of first virtual console was skipped, ignoring remaining ones.1902machine # [ 7.755368] systemd[1]: linger-users.service: Deactivated successfully.1903sshClient # [ 7.699187] systemd[1]: Finished Virtual Console Setup.1904machine # [ 7.894253] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1905machine # [ 7.760337] nsncd[606]: Oct 22 03:07:15.286 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1906machine # [ 7.762669] systemd[1]: Finished linger-users.service.1907machine # [ 7.766423] systemd[1]: Started Home Area Manager.1908machine # [ 7.769146] systemd[1]: Finished Home Area Activation.1909machine # [ 7.769829] systemd[1]: Starting First Boot Home Area Wizard...1910machine # [ 7.771906] systemd[1]: Started Name Service Cache Daemon (nsncd).1911machine # [ 7.774088] systemd[1]: Reached target Host and Network Name Lookups.1912machine # [ 7.774885] systemd[1]: Reached target User and Group Name Lookups.1913machine # [ 7.776184] systemd-logind[540]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)1914machine # [ 7.778688] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1915machine # [ 7.781273] sshd-keygen-start[563]: Generating public/private rsa key pair.1916machine # [ 7.783952] sshd-keygen-start[563]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1917machine # [ 7.785096] sshd-keygen-start[563]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1918machine # [ 7.786198] sshd-keygen-start[563]: The key fingerprint is:1919machine # [ 7.786892] sshd-keygen-start[563]: SHA256:2pmfQt4tzsjqBAuyF9Y2oW93oTBgkM5ri0bJkGWla4I root@machine1920machine # [ 7.788531] sshd-keygen-start[563]: The key's randomart image is:1921machine # [ 7.789981] sshd-keygen-start[563]: +---[RSA 4096]----+1922machine # [ 7.792501] sshd-keygen-start[563]: |.. .. |1923machine # [ 7.793410] sshd-keygen-start[563]: |..o. |1924machine # [ 7.794210] sshd-keygen-start[563]: |o++ . |1925machine # [ 7.794851] sshd-keygen-start[563]: |++ = . |1926machine # [ 7.796076] sshd-keygen-start[563]: |E X B S |1927machine # [ 7.796726] sshd-keygen-start[563]: | % = * +.+ |1928machine # [ 7.798137] sshd-keygen-start[563]: |= o + =o=. . |1929machine # [ 7.798817] sshd-keygen-start[563]: |.+ . o oo+o.. |1930machine # [ 7.802117] sshd-keygen-start[563]: |. .o.oo=. |1931machine # [ 7.802830] sshd-keygen-start[563]: +----[SHA256]-----+1932machine # [ 7.803665] systemd[1]: Stopped Virtual Console Setup.1933machine # [ 7.804392] systemd[1]: Finished resolvconf update.1934machine # [ 7.805085] systemd[1]: Reached target Preparation for Network.1935machine # [ 7.811673] systemd[1]: Starting DHCP Client...1936machine # [ 7.816304] systemd[1]: Starting Address configuration of eth1...1937machine # [ 7.835224] systemd[1]: Starting Extra networking commands....1938machine # [ 7.857111] systemd[1]: Starting Virtual Console Setup...1939machine # [ 7.888369] sshd-keygen-start[641]: Generating public/private ed25519 key pair.1940machine # [ 7.889442] sshd-keygen-start[641]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1941machine # [ 7.891716] sshd-keygen-start[641]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1942machine # [ 7.893428] sshd-keygen-start[641]: The key fingerprint is:1943machine # [ 7.896721] sshd-keygen-start[641]: SHA256:0FCHh78G4QKsWLjDAiI2XHxPMgfkxRldi0z2syIC4zk root@machine1944machine # [ 7.897921] sshd-keygen-start[641]: The key's randomart image is:1945machine # [ 7.898763] sshd-keygen-start[641]: +--[ED25519 256]--+1946machine # [ 7.899481] sshd-keygen-start[641]: |..oo.o++==o. |1947machine # [ 7.900144] sshd-keygen-start[641]: |=+..++.BBo+ . |1948machine # [ 7.900784] sshd-keygen-start[641]: |*+.+.oB..* + |1949machine # [ 7.901460] sshd-keygen-start[641]: |=.o + .oo . o |1950machine # [ 7.902128] sshd-keygen-start[641]: |.. E . oSo o |1951machine # [ 7.902758] sshd-keygen-start[641]: | . . . + |1952machine # [ 7.904986] sshd-keygen-start[641]: | . |1953machine # [ 7.905762] sshd-keygen-start[641]: | |1954machine # [ 7.907207] sshd-keygen-start[641]: | |1955machine # [ 7.907850] sshd-keygen-start[641]: +----[SHA256]-----+1956machine # [ 7.909496] systemd[1]: Created slice Slice /system/systemd-mute-console.1957machine # [ 7.911652] systemd[1]: Started Console Output Muting Service (PID 615/UID 0).1958machine # [ 7.925202] systemd[1]: sshd-keygen.service: Deactivated successfully.1959machine # [ 7.929606] systemd[1]: Finished SSH Host Keys Generation.1960machine # [ 8.006654] network-addresses-eth1-start[634]: adding address 192.168.1.1/24... done1961machine # [ 8.018568] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1962machine # [ 8.024188] systemd[1]: Stopped Virtual Console Setup.1963machine # [ 8.041994] systemd[1]: Starting Virtual Console Setup...1964machine # [ 8.044284] network-addresses-eth1-start[634]: adding address 2001:db8:1::1/64... done1965machine # [ 8.085227] systemd[1]: Finished Address configuration of eth1.1966machine # [ 8.219190] dhcpcd[664]: dhcpcd-10.3.2 starting1967machine # [ 8.222074] systemd[1]: Finished Extra networking commands..1968machine # [ 8.224695] dhcpcd[712]: dev: loaded udev1969machine # [ 8.227398] systemd[1]: Reached target Network.1970machine # [ 8.232932] systemd[1]: Starting SSH Daemon...1971machine # [ 8.280729] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1972machine # [ 8.316608] sshd[714]: Server listening on 0.0.0.0 port 22.1973machine # [ 8.317581] sshd[714]: Server listening on :: port 22.1974machine # [ 8.318827] systemd[1]: Started SSH Daemon.1975machine # [ 8.380295] dhcpcd[712]: eth0: waiting for carrier1976machine # [ 8.381245] dhcpcd[712]: eth0: carrier acquired1977machine # [ 8.387237] dhcpcd[712]: DUID 00:01:00:01:32:6c:3a:63:52:54:00:12:34:561978machine # [ 8.388482] dhcpcd[712]: eth0: IAID 00:12:34:561979machine # [ 8.389258] dhcpcd[712]: eth0: adding address fe80::5054:ff:fe12:34561980machine # [ 8.425320] systemd-vconsole-setup[662]: Configuration of first virtual console was skipped, ignoring remaining ones.1981machine # [ 8.429117] systemd[1]: Finished Virtual Console Setup.1982machine: (finished: waiting for unit systemd-homed.service, in 9.17 seconds)1983machine: waiting for Please enter user name to create to appear on tty 11984machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 0.03 seconds)1985machine: sending keys 'test-homed-user\n'1986machine # [ 8.696402] dhcpcd[712]: eth0: soliciting a DHCP lease1987machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)1988machine: waiting for Please enter new password for user test-homed-user: to appear on tty 11989machine # [ 8.721677] dhcpcd[712]: eth0: offered 10.0.2.15 from 10.0.2.21990machine # [ 8.726426] dhcpcd[712]: eth0: probing address 10.0.2.15/241991sshClient # [ 8.907857] dhcpcd[682]: eth0: soliciting a DHCP lease1992sshClient # [ 9.061687] NET: Registered PF_PACKET protocol family1993sshClient # [ 8.932899] dhcpcd[682]: eth0: offered 10.0.2.15 from 10.0.2.21994sshClient # [ 8.935543] dhcpcd[682]: eth0: probing address 10.0.2.15/241995sshClient # [ 9.114684] dhcpcd[682]: eth0: soliciting an IPv6 router1996sshClient # [ 9.116760] dhcpcd[682]: eth0: Router Advertisement from fe80::21997sshClient # [ 9.118808] dhcpcd[682]: eth0: adding address fec0::5054:ff:fe12:3456/641998sshClient # [ 9.121348] dhcpcd[682]: eth0: adding route to fec0::/641999sshClient # [ 9.123685] dhcpcd[682]: eth0: adding default route via fe80::22000machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.11 seconds)2001machine: sending keys 'foobarfoo\n'2002machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2003machine: waiting for (repeat) to appear on tty 12004machine # [ 9.975308] dhcpcd[712]: eth0: soliciting an IPv6 router2005machine # [ 9.977214] dhcpcd[712]: eth0: Router Advertisement from fe80::22006machine # [ 9.978923] dhcpcd[712]: eth0: adding address fec0::5054:ff:fe12:3456/642007machine # [ 9.981259] dhcpcd[712]: eth0: adding route to fec0::/642008machine # [ 9.983325] dhcpcd[712]: eth0: adding default route via fe80::22009machine: (finished: waiting for (repeat) to appear on tty 1, in 1.12 seconds)2010machine: sending keys 'foobarfoo\n'2011machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2012machine: waiting for unit systemd-homed-firstboot.service2013machine # [ 12.951893] dhcpcd[712]: eth0: leased 10.0.2.15 for 86400 seconds2014machine # [ 12.953071] dhcpcd[712]: eth0: adding route to 10.0.2.0/242015machine # [ 12.953946] dhcpcd[712]: eth0: adding default route via 10.0.2.22016machine # [ 13.016277] systemd[1]: Started DHCP Client.2017sshClient # [ 13.131972] dhcpcd[682]: eth0: leased 10.0.2.15 for 86400 seconds2018sshClient # [ 13.132912] dhcpcd[682]: eth0: adding route to 10.0.2.0/242019sshClient # [ 13.133654] dhcpcd[682]: eth0: adding default route via 10.0.2.22020sshClient # [ 13.194458] systemd[1]: Started DHCP Client.2021sshClient # [ 13.196339] systemd[1]: Reached target Multi-User System.2022sshClient # [ 13.197524] systemd[1]: Startup finished in 863ms (kernel) + 3.153s (initrd) + 9.180s (userspace) = 13.197s.2023machine # [ 21.311657] systemd-homed[519]: Generating key pair for signing local user identity records.2024machine # [ 21.316125] systemd-homed[519]: Successfully created Ed25519 key pair.2025machine # [ 21.347847] systemd-homed[519]: test-homed-user: changing state absent → creating2026machine # [ 21.417645] systemd-homework[867]: Using automatic default storage of 'luks'.2027machine # [ 21.421902] systemd-homework[867]: Sizing home to 83% of available disk space, which is 743M.2028machine # [ 21.423102] systemd-homework[867]: Allocating image file completed.2029machine # [ 21.443368] systemd-homework[867]: Writing of partition table completed.2030machine # [ 21.450284] systemd-homework[867]: Setting up loopback device /dev/loop0 completed.2031machine # [ 22.722632] systemd-homework[867]: LUKS formatting completed.2032machine # [ 24.503802] systemd-homework[867]: Writing password to LUKS keyslot 0 completed.2033machine # [ 24.727293] systemd-homework[867]: LUKS activation by volume key succeeded.2034machine # [ 25.261488] systemd-homework[867]: Writing user record as LUKS token completed.2035machine # [ 25.263086] systemd-homework[867]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2036machine # [ 25.264889] systemd-homework[867]: Formatting /dev/mapper/home-test-homed-user as btrfs2037machine # [ 25.758097] systemd[1]: proc-901-mounts.mount: Deactivated successfully.2038machine # [ 25.759397] systemd-homework[867]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid 618c8b8a-68a1-4a43-a978-726316f9bcb4)2039machine # [ 25.761147] systemd-homework[867]: Formatting file system completed.2040machine # [ 25.803027] systemd-homework[867]: Mounting file system completed.2041machine # [ 25.805087] systemd-homework[867]: Skeleton directory /etc/skel missing, ignoring.2042machine # [ 25.806409] systemd-homework[867]: Wrote embedded .identity file.2043machine # [ 25.807580] systemd-homework[867]: Replaced embedded blob dir with contents of system blob dir.2044machine # [ 25.808988] systemd-homework[867]: Recursive changing of ownership completed.2045machine # [ 25.809985] systemd-homework[867]: Changed top-level directory access mode to 0700.2046machine # [ 25.816603] systemd-homework[867]: Synchronized disk.2047machine # [ 25.818330] systemd-homework[867]: Discarded unused 651.8M.2048machine # [ 25.830147] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed.2049machine # [ 25.837275] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed.2050machine # [ 25.849628] (udev-worker)[896]: loop0: Failed to add device watch, ignoring: No such file or directory2051machine # [ 25.852419] (udev-worker)[896]: loop0: Failed to add device watch, ignoring: No such file or directory2052machine # [ 25.855293] (udev-worker)[896]: loop0: Failed to add device watch, ignoring: No such file or directory2053machine # [ 25.858072] (udev-worker)[896]: loop0: Failed to add device watch, ignoring: No such file or directory2054machine # [ 25.861621] systemd-homework[867]: Moved image file into place.2055machine # [ 25.862514] systemd-homework[867]: Creation completed.2056machine # [ 25.863205] systemd-homework[867]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M.2057machine # [ 25.864728] (udev-worker)[896]: loop0: Failed to add device watch, ignoring: No such file or directory2058machine # [ 25.868753] systemd-homed[519]: block device /sys/devices/virtual/block/loop0 has been removed.2059machine # [ 25.875440] systemd-homed[519]: test-homed-user: changing state creating → inactive2060machine # [ 25.881526] systemd[1]: systemd-mute-console@0-1-615_616-0.service: Deactivated successfully.2061machine # [ 25.884849] systemd[1]: Finished First Boot Home Area Wizard.2062machine # [ 25.889126] systemd[1]: Reached target First Boot Complete.2063machine # [ 25.892075] systemd[1]: Starting Save Transient machine-id to Disk...2064machine # [ 25.895462] systemd[1]: Starting Permit User Sessions...2065machine # [ 25.919783] systemd[1]: Finished Permit User Sessions.2066machine # [ 25.924551] systemd[1]: Started Getty on tty1.2067machine # [ 25.926309] systemd[1]: Reached target Login Prompts.2068machine # [ 25.927440] systemd[1]: Reached target Multi-User System.2069machine # [ 26.149517] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2070machine # [ 26.156957] systemd[1]: Finished Save Transient machine-id to Disk.2071machine # [ 26.162269] systemd[1]: Startup finished in 847ms (kernel) + 3.901s (initrd) + 21.412s (userspace) = 26.161s.2072machine: (finished: waiting for unit systemd-homed-firstboot.service, in 15.68 seconds)2073(finished: subtest: create systemd-homed user on first boot prompt, in 27.49 seconds)2074machine: must succeed: homectl update test-homed-user --offline -G wheel2075machine # [ 26.870274] systemd-homed[519]: test-homed-user: changing state inactive → updating2076machine # [ 26.878541] systemd-homework[947]: Offline update requested. Not touching embedded records.2077machine # [ 26.880269] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting.2078machine # [ 26.886277] systemd-homed[519]: test-homed-user: changing state updating → inactive2079machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.06 seconds)2080subtest: login as homed user2081machine: waiting for login: to appear on tty 12082machine: (finished: waiting for login: to appear on tty 1, in 0.02 seconds)2083machine: sending keys 'test-homed-user\n'2084machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)2085machine: waiting for Password: to appear on tty 12086machine # [ 27.244868] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire2087machine # [ 27.251109] systemd-homework[962]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2088machine # [ 27.259590] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2089machine # [ 27.262072] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive2090machine # [ 27.263647] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2091machine # [ 27.265583] systemd-homed[519]: Home test-homed-user already deactivated, no automatic deactivation needed.2092machine: (finished: waiting for Password: to appear on tty 1, in 1.08 seconds)2093machine: sending keys 'foobarfoo\n'2094machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2095machine: waiting for success: pgrep -u test-homed-user -t tty1 bash2096machine # [ 28.342573] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire2097machine # [ 28.372444] systemd-homework[974]: Provided password unlocks user record.2098machine # [ 28.377581] systemd-homework[974]: Successfully locked image file '/home/test-homed-user.home'.2099machine # [ 28.383394] systemd-homework[974]: Allocated additional 651.8M.2100machine # [ 28.523837] loop1: detected capacity change from 0 to 15175682101machine # [ 28.389255] systemd-homework[974]: Setting up loopback device /dev/loop1 completed.2102machine # [ 29.178103] systemd-homework[974]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2103machine # [ 29.202914] systemd-homework[974]: Provided password unlocks user record.2104machine # [ 29.207714] systemd-homework[974]: Probing file system completed (found btrfs).2105machine # [ 29.210650] systemd-homework[974]: No fsck for file system btrfs installed, ignoring.2106machine # [ 29.348826] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (974)2107machine # [ 29.351293] BTRFS info (device dm-0): first mount of filesystem 618c8b8a-68a1-4a43-a978-726316f9bcb42108machine # [ 29.352264] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2109machine # [ 29.356403] BTRFS info (device dm-0): enabling free space tree2110machine # [ 29.356989] BTRFS info (device dm-0): use zstd compression, level 12111machine # [ 29.221829] systemd-homework[974]: Mounting file system completed.2112machine # [ 29.223419] systemd-homework[974]: Discovered used loopback device /dev/loop1.2113machine # [ 29.224440] systemd-homework[974]: offset = 1048576, size = 776994816, image = 7790919682114machine # [ 29.230978] systemd-homework[974]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M.2115machine # [ 29.232941] systemd-homework[974]: Growing of image file from 743M to 896M completed.2116machine # [ 29.372113] loop1: detected capacity change from 1517568 to 18309122117machine # [ 29.236682] systemd-homework[974]: Refreshing loop device size completed.2118machine # [ 29.248359] systemd-homework[974]: Growing of partition completed.2119machine # [ 29.401525] async_tx: api initialized (async)2120machine # [ 29.294817] systemd-homework[974]: LUKS device growing completed.2121machine # [ 29.463193] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 9206497282122machine # [ 29.328538] systemd-homework[974]: File system resizing from 725M to 878M completed.2123machine # [ 29.331064] systemd-homework[974]: Synchronized disk.2124machine # [ 29.331885] systemd-homework[974]: Synchronized disk.2125machine # [ 29.332726] systemd-homework[974]: Resizing completed.2126machine # [ 29.333550] systemd-homework[974]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2127machine # [ 29.335214] systemd-homework[974]: Read embedded .identity file.2128machine # [ 29.354081] systemd-homework[974]: Provided password unlocks user record.2129machine # [ 29.355121] systemd-homework[974]: Reconciling header user identity completed (host version was newer).2130machine # [ 29.356801] systemd-homework[974]: Reconciling embedded user identity completed (host version was newer).2131machine # [ 29.373748] systemd-homework[974]: Wrote LUKS header user record.2132machine # [ 29.374725] systemd-homework[974]: Wrote embedded .identity file.2133machine # [ 29.375805] systemd-homework[974]: Replaced embedded blob dir with contents of system blob dir.2134machine # [ 29.377503] systemd-homework[974]: Recursive changing of ownership not necessary, skipped.2135machine # [ 29.384076] systemd-homework[974]: Synchronized disk.2136machine # [ 29.386533] systemd-homework[974]: Moving to final mount point /home/test-homed-user completed.2137machine # [ 29.408835] systemd-homework[974]: Activation completed.2138machine # [ 29.409885] systemd-homework[974]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2139machine # [ 29.433369] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting.2140machine # [ 29.448587] login[938]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired.2141machine # [ 29.450848] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → active2142machine # [ 29.461122] systemd-homed[519]: test-homed-user: changing state active → resizing-while-active2143machine # [ 29.479228] systemd-homework[1017]: Successfully acquired home volume key from kernel keyring.2144machine # [ 29.480470] systemd-homework[1017]: LUKS volume key from keyring unlocks user record.2145machine # [ 29.531507] login[938]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0)2146machine # [ 29.569338] systemd[1]: Created slice Slice /user/60388.2147machine # [ 29.574343] systemd[1]: Starting User Runtime Directory /run/user/60388...2148machine # [ 29.581075] systemd-homework[1017]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2149machine # [ 29.593276] systemd-logind[540]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'.2150machine # [ 29.648676] systemd[1]: Finished User Runtime Directory /run/user/60388.2151machine # [ 29.664181] systemd[1]: Starting User Manager for UID 60388...2152machine # [ 29.713540] (systemd)[1023]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2153machine # [ 29.765897] (systemd)[1023]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2154machine # [ 29.771165] systemd-logind[540]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2155machine # [ 29.833287] systemd[1023]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2156machine # [ 29.855960] systemd-homework[1017]: Successfully re-activated LUKS device.2157machine # [ 29.860830] systemd-homework[1017]: LUKS volume key from keyring unlocks user record.2158machine # [ 29.861959] systemd-homework[1017]: Discovered used loopback device /dev/loop1.2159machine # [ 29.863035] systemd-homework[1017]: Read embedded .identity file.2160machine # [ 29.864109] systemd-homework[1017]: LUKS volume key from keyring unlocks user record.2161machine # [ 29.867089] systemd-homework[1017]: Reconciling header user identity completed (host version was newer).2162machine # [ 29.868284] systemd-homework[1017]: Reconciling embedded user identity completed (host version was newer).2163machine # [ 29.869443] systemd-homework[1017]: offset = 1048576, size = 937426944, image = 9395240962164machine # [ 29.885851] systemd-homework[1017]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M.2165machine # [ 29.887822] systemd-homework[1017]: Wrote embedded .identity file.2166machine # [ 29.888732] systemd-homework[1017]: Replaced embedded blob dir with contents of system blob dir.2167machine # [ 29.889887] systemd-homework[1017]: Backing file is fully allocated already.2168machine # [ 30.030971] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 7822376962169machine # [ 29.896323] systemd-homework[1017]: File system resizing from 878M to 746M completed.2170machine # [ 29.901406] systemd-homework[1017]: Synchronized disk.2171machine # [ 29.947830] systemd-homework[1017]: LUKS device shrinking completed.2172machine # [ 30.087150] loop1: detected capacity change from 1830912 to 15605762173machine # [ 29.953850] systemd-homework[1017]: Refreshing loop device size completed.2174machine # [ 29.954972] systemd-homework[1017]: Shrinking of image file completed.2175machine # [ 29.975193] systemd-homework[1017]: Shrinking of partition completed.2176machine # [ 29.994574] systemd-homework[1017]: Wrote LUKS header user record.2177machine # [ 29.995904] systemd-homework[1017]: Synchronized disk.2178machine # [ 29.999941] systemd-homework[1017]: Resizing completed.2179machine # [ 30.000777] systemd-homework[1017]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2180machine # [ 30.012875] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting.2181machine # [ 30.018854] systemd-homed[519]: test-homed-user: changing state resizing-while-active → active2182machine # [ 30.020858] systemd-homed[519]: Rebalancing complete.2183machine # [ 30.023408] systemd[1023]: Queued start job for default target Main User Target.2184machine # [ 30.025867] systemd[1023]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2185machine # [ 30.032075] systemd[1023]: Created slice User Application Slice.2186machine # [ 30.033061] systemd[1023]: Started Daily Cleanup of User's Temporary Directories.2187machine # [ 30.035064] systemd[1023]: Reached target Paths.2188machine # [ 30.035812] systemd[1023]: Reached target Timers.2189machine # [ 30.037400] systemd[1023]: Starting D-Bus User Message Bus Socket...2190machine # [ 30.041393] systemd[1023]: Starting Create User Files and Directories...2191machine # [ 30.063298] systemd[1023]: Finished Create User Files and Directories.2192machine # [ 30.079403] systemd[1023]: Listening on D-Bus User Message Bus Socket.2193machine # [ 30.081624] systemd[1023]: Reached target Sockets.2194machine # [ 30.082582] systemd[1023]: Reached target Basic System.2195machine # [ 30.083437] systemd[1]: Started User Manager for UID 60388.2196machine # [ 30.086696] systemd[1023]: Starting Run user-specific NixOS activation...2197machine # [ 30.090070] systemd[1]: Started Session 1 of User test-homed-user.2198machine # [ 30.121400] systemd[1023]: Finished Run user-specific NixOS activation.2199machine # [ 30.122543] systemd[1023]: Reached target Main User Target.2200machine # [ 30.123592] systemd[1023]: Startup finished in 308ms.2201machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.09 seconds)2202machine: sending keys 'whoami > /tmp/2\n'2203machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.16 seconds)2204machine: waiting for file '/tmp/2'2205machine: (finished: waiting for file '/tmp/2', in 1.04 seconds)2206machine: must succeed: cat /tmp/22207machine: (finished: must succeed: cat /tmp/2, in 0.01 seconds)2208(finished: subtest: login as homed user, in 4.68 seconds)2209subtest: login as regular user2210sshClient: waiting for login: to appear on tty 12211sshClient: waiting for the VM to finish booting2212sshClient: Guest shell says: b'Spawning backdoor root shell...\n'2213sshClient: connected to guest root shell2214sshClient: (connecting took 0.00 seconds)2215sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds)2216sshClient: (finished: waiting for login: to appear on tty 1, in 0.03 seconds)2217sshClient: sending keys 'test-normal-user\n'2218sshClient: (finished: sending keys 'test-normal-user\n', in 0.17 seconds)2219sshClient: waiting for Password: to appear on tty 12220sshClient: (finished: waiting for Password: to appear on tty 1, in 1.05 seconds)2221sshClient: sending keys 'foobarfoo\n'2222sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2223sshClient: waiting for success: pgrep -u test-normal-user bash2224sshClient # [ 32.960060] login[690]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0)2225sshClient # [ 33.032385] systemd-logind[532]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'.2226sshClient # [ 33.043264] systemd[1]: Created slice Slice /user/1000.2227sshClient # [ 33.048239] systemd[1]: Starting User Runtime Directory /run/user/1000...2228sshClient # [ 33.090441] systemd[1]: Finished User Runtime Directory /run/user/1000.2229sshClient # [ 33.095965] systemd[1]: Starting User Manager for UID 1000...2230sshClient # [ 33.140647] (systemd)[806]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0)2231sshClient # [ 33.145796] systemd-logind[532]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'.2232sshClient # [ 33.175229] systemd[806]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2233sshClient # [ 33.263136] systemd[806]: Queued start job for default target Main User Target.2234sshClient # [ 33.266894] systemd[806]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2235sshClient # [ 33.269515] systemd[806]: Created slice User Application Slice.2236sshClient # [ 33.270517] systemd[806]: Started Daily Cleanup of User's Temporary Directories.2237sshClient # [ 33.271655] systemd[806]: Reached target Paths.2238sshClient # [ 33.273063] systemd[806]: Reached target Timers.2239sshClient # [ 33.274950] systemd[806]: Starting D-Bus User Message Bus Socket...2240sshClient # [ 33.279382] systemd[806]: Starting Create User Files and Directories...2241sshClient # [ 33.306249] systemd[806]: Finished Create User Files and Directories.2242sshClient # [ 33.325550] systemd[806]: Listening on D-Bus User Message Bus Socket.2243sshClient # [ 33.326636] systemd[806]: Reached target Sockets.2244sshClient # [ 33.327414] systemd[806]: Reached target Basic System.2245sshClient # [ 33.328239] systemd[1]: Started User Manager for UID 1000.2246sshClient # [ 33.332062] systemd[806]: Starting Run user-specific NixOS activation...2247sshClient # [ 33.334054] systemd[1]: Started Session 1 of User test-normal-user.2248sshClient # [ 33.376164] systemd[806]: Finished Run user-specific NixOS activation.2249sshClient # [ 33.377449] systemd[806]: Reached target Main User Target.2250sshClient # [ 33.379155] systemd[806]: Startup finished in 213ms.2251sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.05 seconds)2252sshClient: sending keys 'whoami > /tmp/1\n'2253sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds)2254sshClient: waiting for file '/tmp/1'2255sshClient: (finished: waiting for file '/tmp/1', in 1.03 seconds)2256sshClient: must succeed: cat /tmp/12257sshClient: (finished: must succeed: cat /tmp/1, in 0.01 seconds)2258(finished: subtest: login as regular user, in 3.61 seconds)2259subtest: add homed ssh authorized key2260sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n'2261sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds)2262sshClient: waiting for file '/tmp/id_ed25519.pub'2263sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.05 seconds)2264sshClient: must succeed: cat /tmp/id_ed25519.pub2265sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.02 seconds)2266machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINxn1/iBm8h25CBWUeO8bHOc2PRpFh1itFQY90fKKOK8 test-normal-user@sshClient'2267machine # [ 36.779640] systemd-homed[519]: test-homed-user: changing state active → updating-while-active2268machine # [ 36.785036] systemd-homework[1071]: Offline update requested. Not touching embedded records.2269machine # [ 36.799329] systemd-homed[519]: test-homed-user: changing state updating-while-active → active2270machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAINxn1/iBm8h25CBWUeO8bHOc2PRpFh1itFQY90fKKOK8 test-normal-user@sshClient', in 0.06 seconds)2271machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed255192272machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.02 seconds)2273(finished: subtest: add homed ssh authorized key, in 1.64 seconds)2274subtest: change homed user password2275machine: sending keys 'passwd; echo $? > /tmp/3\n'2276machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds)2277machine: waiting for New password: to appear on tty 12278machine: (finished: waiting for New password: to appear on tty 1, in 1.08 seconds)2279machine: sending keys 'barfoobar\n'2280machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2281machine: waiting for Retype new password: to appear on tty 12282machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.10 seconds)2283machine: sending keys 'barfoobar\n'2284machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2285??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead.2286 File "/nix/store/9a17m19ckncxr4bg1lfalvqxs7gnfj0f-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 5732287machine: must succeed: sleep 4.02288machine # [ 39.601292] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active2289machine # [ 40.310647] systemd-homework[1111]: No valid password for LUKS superblock.2290machine # [ 42.613393] systemd-homed[519]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2291machine # [ 42.615597] systemd-homed[519]: test-homed-user: changing state passwd-while-active → active2292machine: (finished: must succeed: sleep 4.0, in 4.03 seconds)2293machine: sending keys 'foobarfoo\n'2294machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2295machine: waiting for file '/tmp/3'2296machine # [ 43.738774] systemd-homed[519]: test-homed-user: changing state active → passwd-while-active2297machine # [ 45.013436] systemd-homework[1117]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2298machine # [ 45.142111] systemd-homework[1117]: Successfully re-activated LUKS device.2299machine # [ 45.182234] systemd-homework[1117]: Provided password unlocks user record.2300machine # [ 45.183709] systemd-homework[1117]: Discovered used loopback device /dev/loop1.2301machine # [ 45.184821] systemd-homework[1117]: Read embedded .identity file.2302machine # [ 45.222100] systemd-homework[1117]: Provided password unlocks user record.2303machine # [ 45.224083] systemd-homework[1117]: Reconciling header user identity completed (host version was newer).2304machine # [ 45.225266] systemd-homework[1117]: Reconciling embedded user identity completed (host version was newer).2305machine # [ 48.097655] systemd-homework[1117]: Added LUKS key slot 1.2306machine # [ 48.130040] systemd-homework[1117]: Destroyed LUKS key slot 0.2307machine # [ 48.142916] systemd-homework[1117]: Wrote LUKS header user record.2308machine # [ 48.144209] systemd-homework[1117]: Wrote embedded .identity file.2309machine # [ 48.145183] systemd-homework[1117]: Replaced embedded blob dir with contents of system blob dir.2310machine # [ 48.151921] systemd-homework[1117]: Synchronized disk.2311machine # [ 48.154380] systemd-homework[1117]: Everything completed.2312machine # [ 48.167107] systemd-homed[519]: test-homed-user: changing state passwd-while-active → active2313machine # [ 48.168759] passwd[1086]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user.2314machine: (finished: waiting for file '/tmp/3', in 5.14 seconds)2315machine: must succeed: cat /tmp/32316machine: (finished: must succeed: cat /tmp/3, in 0.03 seconds)2317(finished: subtest: change homed user password, in 11.96 seconds)2318subtest: escalate to root from homed user2319machine: sending keys 'sudo id | tee /tmp/4\n'2320machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds)2321machine: waiting for password for test-homed-user to appear on tty 12322machine # [ 49.262904] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire2323machine # [ 49.271832] systemd-homework[1153]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2324machine # [ 49.283530] systemd-homed[519]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2325machine # [ 49.286808] systemd-homed[519]: test-homed-user: changing state authenticating-for-acquire → active2326machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.11 seconds)2327machine: sending keys 'barfoobar\n'2328machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2329machine: waiting for file '/tmp/4'2330machine: (finished: waiting for file '/tmp/4', in 0.03 seconds)2331machine: waiting for success: grep uid=0 /tmp/42332machine # [ 51.952428] systemd-homed[519]: test-homed-user: changing state active → authenticating-for-acquire2333machine # [ 52.005505] systemd-homework[1173]: Provided password unlocks user record.2334machine # [ 52.680156] systemd-homework[1173]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2335machine # [ 52.809092] systemd-homework[1173]: Successfully re-activated LUKS device.2336machine # [ 52.830963] systemd-homework[1173]: Provided password unlocks user record.2337machine # [ 52.832406] systemd-homework[1173]: Discovered used loopback device /dev/loop1.2338machine # [ 52.833498] systemd-homework[1173]: Read embedded .identity file.2339machine # [ 52.853127] systemd-homework[1173]: Provided password unlocks user record.2340machine # [ 52.854199] systemd-homework[1173]: Reconciling user identities completed (host and header version were identical).2341machine # [ 52.855647] systemd-homework[1173]: Reconciling embedded user identity completed (host and embedded version were identical).2342machine # [ 54.325669] systemd-homework[1173]: Everything completed.2343machine # [ 54.329591] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting.2344machine # [ 54.443684] systemd-homed[519]: test-homed-user: changing state authenticating-for-acquire → active2345machine # [ 54.448519] sudo[1151]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired.2346machine # [ 54.464504] sudo[1151]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id2347machine # [ 54.489920] sudo[1151]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388)2348machine # [ 54.501425] sudo[1151]: pam_unix(sudo:session): session closed for user root2349machine: (finished: waiting for success: grep uid=0 /tmp/4, in 5.20 seconds)2350(finished: subtest: escalate to root from homed user, in 6.66 seconds)2351subtest: log out and deactivate homed user's home area2352machine: sending keys 'exit\n'2353machine: (finished: sending keys 'exit\n', in 0.05 seconds)2354machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive'2355machine # [ 55.529392] login[938]: pam_unix(login:session): session closed for user test-homed-user2356machine # [ 55.531653] login[938]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used.2357machine # [ 55.537082] systemd[1]: getty@tty1.service: Deactivated successfully.2358machine # [ 55.543911] systemd[1]: session-1.scope: Deactivated successfully.2359machine # [ 55.547856] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2360machine # [ 55.551367] systemd-logind[540]: Session 1 logged out. Waiting for processes to exit.2361machine # [ 55.554662] systemd[1]: Started Getty on tty1.2362machine # [ 55.558159] systemd-logind[540]: Removed session 1.2363machine # [ 65.649478] systemd[1]: Stopping User Manager for UID 60388...2364machine # [ 65.656370] systemd[1023]: Activating special unit Exit the Session...2365machine # [ 65.659578] systemd[1023]: Stopped target Main User Target.2366machine # [ 65.663257] systemd[1023]: Stopped Run user-specific NixOS activation.2367machine # [ 65.666639] systemd[1023]: Stopped target Basic System.2368machine # [ 65.669838] systemd[1023]: Stopped target Paths.2369machine # [ 65.673429] systemd[1023]: Stopped target Sockets.2370machine # [ 65.675662] systemd[1023]: Stopped target Timers.2371machine # [ 65.679379] systemd[1023]: Stopped Daily Cleanup of User's Temporary Directories.2372machine # [ 65.682844] systemd[1023]: Closed D-Bus User Message Bus Socket.2373machine # [ 65.687168] systemd[1023]: Stopped Create User Files and Directories.2374machine # [ 65.689809] systemd[1023]: Removed slice User Application Slice.2375machine # [ 65.691879] systemd[1023]: Reached target Shutdown.2376machine # [ 65.696852] systemd[1023]: Finished Exit the Session.2377machine # [ 65.700260] systemd[1023]: Reached target Exit the Session.2378machine # [ 65.706297] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2379machine # [ 65.712788] systemd-homed[519]: test-homed-user: changing state active → deactivating2380machine # [ 65.717388] systemd-logind[540]: Removed session 2.2381machine # [ 65.719189] systemd[1]: user@60388.service: Deactivated successfully.2382machine # [ 65.722145] systemd[1]: Stopped User Manager for UID 60388.2383machine # [ 65.724493] systemd-homework[1264]: Successfully acquired home volume key from kernel keyring.2384machine # [ 65.726718] systemd-homework[1264]: Discarded unused 673.5M.2385machine # [ 65.736672] systemd-homework[1264]: Syncing completed.2386machine # [ 65.738773] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully.2387machine # [ 65.746587] systemd[1]: Stopping User Runtime Directory /run/user/60388...2388machine # [ 65.784559] systemd[1]: run-user-60388.mount: Deactivated successfully.2389machine # [ 65.790067] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully.2390machine # [ 65.791721] systemd[1]: Stopped User Runtime Directory /run/user/60388.2391machine # [ 65.811080] systemd-homework[1264]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2392machine # [ 65.953477] systemd-homework[1264]: Successfully re-activated LUKS device.2393machine # [ 65.956869] systemd-homework[1264]: Discovered used loopback device /dev/loop1.2394machine # [ 65.958153] systemd-homework[1264]: offset = 1048576, size = 799014912, image = 8011120642395machine # [ 66.144983] systemd-homework[1264]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M.2396machine # [ 66.150874] systemd-homework[1264]: Allocated additional 673.5M.2397machine # [ 66.295638] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 2684354562398machine # [ 66.161933] systemd-homework[1264]: File system resizing from 746M to 256M completed.2399machine # [ 66.165047] systemd-homework[1264]: Synchronized disk.2400machine # [ 66.272180] systemd-homework[1264]: LUKS device shrinking completed.2401machine # [ 66.411028] loop1: detected capacity change from 1560576 to 5570562402machine # [ 66.276591] systemd-homework[1264]: Refreshing loop device size completed.2403machine # [ 66.277876] systemd-homework[1264]: Shrinking of image file completed.2404machine # [ 66.308857] systemd-homework[1264]: Shrinking of partition completed.2405machine # [ 66.445858] BTRFS info (device dm-0): last unmount of filesystem 618c8b8a-68a1-4a43-a978-726316f9bcb42406machine # [ 66.310883] systemd-homework[1264]: Synchronized disk.2407machine # [ 66.311676] systemd-homework[1264]: Resizing completed.2408machine # [ 66.312400] systemd-homework[1264]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M.2409machine # [ 66.315520] systemd-homework[1264]: Unmounting completed.2410machine # [ 66.316590] systemd-homework[1264]: Discovered used LUKS device /dev/mapper/home-test-homed-user.2411machine # [ 66.318476] systemd-homework[1264]: Device home-test-homed-user is not active.2412machine # [ 66.329775] systemd-homed[519]: block device /sys/devices/virtual/block/dm-0 has been removed.2413machine # [ 66.358298] systemd-homework[1264]: Everything completed.2414machine # [ 66.366517] systemd-homed[519]: test-homed-user: changing state deactivating → inactive2415machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.52 seconds)2416(finished: subtest: log out and deactivate homed user's home area, in 11.58 seconds)2417subtest: ssh as homed user2418sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n'2419sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.78 seconds)2420sshClient: waiting for Please enter password for user to appear on tty 12421machine # [ 68.811079] systemd-homed[519]: test-homed-user: changing state inactive → activating-for-acquire2422machine # [ 68.814958] systemd-homework[1298]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2423machine # [ 68.821391] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2424machine # [ 68.823487] systemd-homed[519]: test-homed-user: changing state activating-for-acquire → inactive2425machine # [ 68.824883] sshd-session[1294]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error2426machine # [ 68.826551] systemd-homed[519]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2427machine # [ 68.829228] systemd-homed[519]: Home test-homed-user already deactivated, no automatic deactivation needed.2428machine # [ 68.830521] sshd-session[1294]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation.2429machine # [ 68.832504] sshd-session[1294]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 33480 ssh2: ED25519 SHA256:9JHz7ukqHqE64A0MyoN+s16lEIUkWr9ry/lgdHbt9tY2430machine # [ 68.870368] sshd-session[1294]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0)2431machine # [ 68.880309] systemd-logind[540]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'.2432machine # [ 68.885359] systemd[1]: Starting User Runtime Directory /run/user/60388...2433machine # [ 68.904989] systemd[1]: Finished User Runtime Directory /run/user/60388.2434machine # [ 68.909624] systemd[1]: Started Session 3 of User test-homed-user.2435machine # [ 68.924692] sshd-session[1294]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2436machine # [ 68.927620] sshd-session[1294]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2437machine # [ 68.943158] systemd-homed[519]: test-homed-user: changing state inactive → activating2438machine # [ 68.946952] systemd-homework[1303]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2439machine # [ 68.955542] systemd-homed[519]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2440machine # [ 68.957506] systemd-homed[519]: test-homed-user: changing state activating → inactive2441sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.14 seconds)2442sshClient: sending keys 'barfoobar\n'2443sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2444machine: waiting for success: pgrep -u test-homed-user bash2445machine # [ 70.138402] systemd-homed[519]: test-homed-user: changing state inactive → activating2446machine # [ 70.176570] systemd-homework[1308]: Provided password unlocks user record.2447machine # [ 70.180525] systemd-homework[1308]: Successfully locked image file '/home/test-homed-user.home'.2448machine # [ 70.186325] systemd-homework[1308]: Backing file is fully allocated already.2449machine # [ 70.325237] loop1: detected capacity change from 0 to 5570562450machine # [ 70.190350] systemd-homework[1308]: Setting up loopback device /dev/loop1 completed.2451machine # [ 71.084314] systemd-homework[1308]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2452machine # [ 71.116601] systemd-homework[1308]: Provided password unlocks user record.2453machine # [ 71.123526] systemd-homework[1308]: Probing file system completed (found btrfs).2454machine # [ 71.125082] systemd-homework[1308]: No fsck for file system btrfs installed, ignoring.2455machine # [ 71.263207] BTRFS: device label test-homed-user devid 1 transid 18 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1308)2456machine # [ 71.265686] BTRFS info (device dm-0): first mount of filesystem 618c8b8a-68a1-4a43-a978-726316f9bcb42457machine # [ 71.266605] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2458machine # [ 71.274680] BTRFS info (device dm-0): enabling free space tree2459machine # [ 71.275338] BTRFS info (device dm-0): use zstd compression, level 12460machine # [ 71.142146] systemd-homework[1308]: Mounting file system completed.2461machine # [ 71.145120] systemd-homework[1308]: Discovered used loopback device /dev/loop1.2462machine # [ 71.146160] systemd-homework[1308]: offset = 1048576, size = 285212672, image = 2873098242463machine # [ 71.166275] systemd-homework[1308]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M.2464machine # [ 71.168304] systemd-homework[1308]: Growing of image file from 274M to 764M completed.2465machine # [ 71.308008] loop1: detected capacity change from 557056 to 15605762466machine # [ 71.173158] systemd-homework[1308]: Refreshing loop device size completed.2467machine # [ 71.186771] systemd-homework[1308]: Growing of partition completed.2468machine # [ 71.216269] systemd-homework[1308]: LUKS device growing completed.2469machine # [ 71.358457] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 7822376962470machine # [ 71.223677] systemd-homework[1308]: File system resizing from 256M to 746M completed.2471machine # [ 71.226128] systemd-homework[1308]: Synchronized disk.2472machine # [ 71.226848] systemd-homework[1308]: Synchronized disk.2473machine # [ 71.227560] systemd-homework[1308]: Resizing completed.2474machine # [ 71.228264] systemd-homework[1308]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2475machine # [ 71.229768] systemd-homework[1308]: Read embedded .identity file.2476machine # [ 71.248643] systemd-homework[1308]: Provided password unlocks user record.2477machine # [ 71.249794] systemd-homework[1308]: Reconciling user identities completed (host and header version were identical).2478machine # [ 71.251186] systemd-homework[1308]: Reconciling embedded user identity completed (host and embedded version were identical).2479machine # [ 71.253378] systemd-homework[1308]: Recursive changing of ownership not necessary, skipped.2480machine # [ 71.254837] systemd-homework[1308]: Synchronized disk.2481machine # [ 71.256754] systemd-homework[1308]: Moving to final mount point /home/test-homed-user completed.2482machine # [ 71.282174] systemd-homework[1308]: Activation completed.2483machine # [ 71.283150] systemd-homework[1308]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2484machine # [ 71.294260] systemd-homed[519]: Home test-homed-user is signed exclusively by our key, accepting.2485machine # [ 71.300504] systemd-homed[519]: test-homed-user: changing state activating → active2486machine # [ 71.310322] systemd[1]: Starting User Manager for UID 60388...2487machine # [ 71.331296] (systemd)[1350]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2488machine # [ 71.368723] (systemd)[1350]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2489machine # [ 71.374399] systemd-logind[540]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2490machine # [ 71.390047] systemd[1350]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2491machine # [ 71.464424] systemd[1350]: Queued start job for default target Main User Target.2492machine # [ 71.466823] systemd[1350]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2493machine # [ 71.469104] systemd[1350]: Created slice User Application Slice.2494machine # [ 71.470157] systemd[1350]: Started Daily Cleanup of User's Temporary Directories.2495machine # [ 71.471173] systemd[1350]: Reached target Paths.2496machine # [ 71.472200] systemd[1350]: Reached target Timers.2497machine # [ 71.474956] systemd[1350]: Starting D-Bus User Message Bus Socket...2498machine # [ 71.476930] systemd[1350]: Starting Create User Files and Directories...2499machine # [ 71.501499] systemd[1350]: Finished Create User Files and Directories.2500machine # [ 71.506531] systemd[1350]: Listening on D-Bus User Message Bus Socket.2501machine # [ 71.507465] systemd[1350]: Reached target Sockets.2502machine # [ 71.508163] systemd[1350]: Reached target Basic System.2503machine # [ 71.508845] systemd[1]: Started User Manager for UID 60388.2504machine # [ 71.512281] systemd[1350]: Starting Run user-specific NixOS activation...2505machine # [ 71.542437] systemd[1350]: Finished Run user-specific NixOS activation.2506machine # [ 71.543538] systemd[1350]: Reached target Main User Target.2507machine # [ 71.545295] systemd[1350]: Startup finished in 157ms.2508machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.17 seconds)2509sshClient: sending keys 'whoami > /tmp/5\n'2510sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.16 seconds)2511machine: waiting for file '/tmp/5'2512machine: (finished: waiting for file '/tmp/5', in 1.06 seconds)2513machine: must succeed: cat /tmp/52514machine: (finished: must succeed: cat /tmp/5, in 0.03 seconds)2515sshClient: sending keys 'exit\n'2516sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2517sshClient: sending keys 'exit\n'2518sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2519(finished: subtest: ssh as homed user, in 6.55 seconds)2520(finished: run the VM test script, in 74.87 seconds)2521machine # [ 73.568406] sshd-session[1301]: Received disconnect from 2001:db8:1::2 port 33480:11: disconnected by user2522machine # [ 73.571846] sshd-session[1301]: Disconnected from user test-homed-user 2001:db8:1::2 port 334802523machine # [ 73.577553] sshd-session[1294]: pam_unix(sshd:session): session closed for user test-homed-user2524machine # [ 73.581777] sshd-session[1294]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used.2525machine # [ 73.588898] systemd[1]: session-3.scope: Deactivated successfully.2526machine # [ 73.595305] systemd-logind[540]: Session 3 logged out. Waiting for processes to exit.2527machine # [ 73.597623] systemd-logind[540]: Removed session 3.2528sshClient # [ 73.592523] login[690]: pam_unix(login:session): session closed for user test-normal-user2529sshClient # [ 73.603854] systemd[1]: getty@tty1.service: Deactivated successfully.2530sshClient # [ 73.623251] systemd[1]: session-1.scope: Deactivated successfully.2531sshClient # [ 73.629759] systemd[1]: session-1.scope: Consumed 126ms CPU time over 40.292s wall clock time, 8.4M memory peak, 12K written to disk, 20.6K incoming IP traffic, 19.8K outgoing IP traffic.2532sshClient # [ 73.643142] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2533sshClient # [ 73.645919] systemd-logind[532]: Session 1 logged out. Waiting for processes to exit.2534sshClient # [ 73.651629] systemd[1]: Started Getty on tty1.2535sshClient # [ 73.654503] systemd-logind[532]: Removed session 1.2536test script finished in 75.11s2537cleanup2538kill QemuMachine (pid 47)2539machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2540machine # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2541machine # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2542machine # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2543kill QemuMachine (pid 48)2544sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2545sshClient # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2546sshClient # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2547sshClient # [2026-10-22T03:08:22Z INFO virtiofsd] Client disconnected, shutting down2548(finished: cleanup, in 0.39 seconds)2549additionally exposed symbols:2550 machine, sshClient,2551 vlan1,2552 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