vm-test-run-systemd-homed
checks.x86_64-linux.systemd-homed
· build #63
· 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: QEMU running (pid 47)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.jRlK7D224v', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 519a658d-5834-4480-9dfb-759708a7caa017machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-21T03:09:01Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-21T03:09:01Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-21T03:09:01Z INFO virtiofsd] Client connected, servicing requests39sshClient # Disk image does not exist, creating the virtualisation disk image...40sshClient: QEMU running (pid 48)41sshClient # Formatting '/build/vm-state-sshClient/tmp.VY0Ngimf5Q', fmt=raw size=107374182442sshClient # mke2fs 1.47.4 (6-Mar-2025)43sshClient # Discarding device blocks: 0/262144 done44(finished: start all VMs, in 0.64 seconds)45sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes46subtest: create systemd-homed user on first boot prompt47sshClient # Filesystem UUID: 3e3975f7-254d-45cf-8ea9-fdc74d5c537c48machine: waiting for unit systemd-homed.service49sshClient # Superblock backups stored on blocks:50machine: waiting for the VM to finish booting51sshClient # 32768, 98304, 163840, 22937652sshClient # 53sshClient # Allocating group tables: 0/8 done54sshClient # Writing inode tables: 0/8 done55sshClient # Creating journal (8192 blocks): done56sshClient # Writing superblocks and filesystem accounting information: 0/8 done57sshClient # 58sshClient # Virtualisation disk image created.59sshClient # Starting virtiofs daemons...60sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)61sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether62sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)63sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether64sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)65sshClient # [2026-10-21T03:09:01Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether66sshClient # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...67sshClient # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...68sshClient # [2026-10-21T03:09:01Z INFO virtiofsd] Waiting for vhost-user socket connection...69sshClient # [2026-10-21T03:09:01Z INFO virtiofsd] Client connected, servicing requests70sshClient # [2026-10-21T03:09:01Z INFO virtiofsd] Client connected, servicing requests71sshClient # [2026-10-21T03:09:01Z 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)74machine # 75machine # 76sshClient # 77sshClient # 78machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0079sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0080machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...81machine # 82machine # 83machine # 84machine # 85sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)...86sshClient # 87sshClient # 88sshClient # 89sshClient # 90machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0091sshClient # 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/zmx98gb89cd96rbwl8jahlsx2sni6i5s-nixos-system-machine-test/init regInfo=/nix/.ro-store/0g8qvrh2bh41nlgmfbgzl9xph6wbq4c5-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.000000] kvm-clock: using sched offset of 486960701 cycles122machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns123machine # [ 0.000005] tsc: Detected 2400.008 MHz processor124machine # [ 0.000770] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000125machine # [ 0.000796] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs126machine # [ 0.000799] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT127machine # [ 0.002735] found SMP MP-table at [mem 0x000f5450-0x000f545f]128machine # [ 0.002747] Using GB pages for direct mapping129machine # [ 0.002843] RAMDISK: [mem 0x3e34e000-0x3ffcffff]130machine # [ 0.002853] ACPI: Early table checksum verification disabled131machine # [ 0.002856] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )132machine # [ 0.002860] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)133machine # [ 0.002864] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)134machine # [ 0.002870] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)135machine # [ 0.002873] ACPI: FACS 0x000000003FFE0000 000040136machine # [ 0.002874] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)137machine # [ 0.002876] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)138machine # [ 0.002877] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)139machine # [ 0.002879] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)140machine # [ 0.002880] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]141machine # [ 0.002881] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]142machine # [ 0.002882] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]143machine # [ 0.002882] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]144machine # [ 0.002883] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]145machine # [ 0.002883] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]146machine # [ 0.002884] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]147machine # [ 0.003110] No NUMA configuration found148machine # [ 0.003111] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]149machine # [ 0.003114] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]150machine # [ 0.005464] Zone ranges:151machine # [ 0.005465] DMA [mem 0x0000000000001000-0x0000000000ffffff]152machine # [ 0.005467] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]153machine # [ 0.005468] Normal empty154machine # [ 0.005469] Device empty155machine # [ 0.005470] Movable zone start for each node156machine # [ 0.005471] Early memory node ranges157machine # [ 0.005471] node 0: [mem 0x0000000000001000-0x000000000009efff]158machine # [ 0.005472] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]159machine # [ 0.005473] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]160machine # [ 0.005492] On node 0, zone DMA: 1 pages in unavailable ranges161machine # [ 0.005745] On node 0, zone DMA: 97 pages in unavailable ranges162machine # [ 0.022717] On node 0, zone DMA32: 40 pages in unavailable ranges163machine # [ 0.023159] ACPI: PM-Timer IO Port: 0x608164machine # [ 0.023178] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])165machine # [ 0.023204] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23166machine # [ 0.023206] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)167machine # [ 0.023208] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)168machine # [ 0.023209] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)169machine # [ 0.023210] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)170machine # [ 0.023211] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)171machine # [ 0.023214] ACPI: Using ACPI (MADT) for SMP configuration information172machine # [ 0.023215] ACPI: HPET id: 0x8086a201 base: 0xfed00000173machine # [ 0.023218] TSC deadline timer available174machine # [ 0.023222] CPU topo: Max. logical packages: 1175machine # [ 0.023222] CPU topo: Max. logical dies: 1176sshClient # 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 @1792058300177machine # [ 0.023223] CPU topo: Max. dies per package: 1178machine # [ 0.023226] CPU topo: Max. threads per core: 1179machine # [ 0.023226] CPU topo: Num. cores per package: 1180machine # [ 0.023227] CPU topo: Num. threads per package: 1181machine # [ 0.023227] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs182machine # [ 0.023245] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()183sshClient # [ 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/9vjxxpk7pd8ccv8gnscd9f08xblncx9k-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/vf5rcq9ss8qcx683yj3rh7c1j7sd75g3-closure-info/registration console=ttyS0,115200n8 console=tty0184sshClient # [ 0.000000] BIOS-provided physical RAM map:185machine # [ 0.023275] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]186sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable187machine # [ 0.023276] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]188sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved189machine # [ 0.023278] [mem 0x40000000-0xafffffff] available for PCI devices190machine # [ 0.023279] Booting paravirtualized kernel on KVM191sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved192sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable193machine # [ 0.023281] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns194sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved195machine # [ 0.027968] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1196sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved197machine # [ 0.030080] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152198machine # [ 0.030126] kvm-guest: PV spinlocks disabled, single CPU199sshClient # [ 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] reserved203sshClient # [ 0.000000] NX (Execute Disable) protection: active204sshClient # [ 0.000000] APIC: Static calls initialized205machine # [ 0.030127] 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/zmx98gb89cd96rbwl8jahlsx2sni6i5s-nixos-system-machine-test/init regInfo=/nix/.ro-store/0g8qvrh2bh41nlgmfbgzl9xph6wbq4c5-closure-info/registration console=ttyS0,115200n8 console=tty0206sshClient # [ 0.000000] SMBIOS 2.8 present.207sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014208machine # [ 0.030229] Unknown kernel command line parameters "regInfo=/nix/.ro-store/0g8qvrh2bh41nlgmfbgzl9xph6wbq4c5-closure-info/registration", will be passed to user space.209sshClient # [ 0.000000] DMI: Memory slots populated: 1/1210machine # [ 0.030241] random: crng init done211sshClient # [ 0.000000] Hypervisor detected: KVM212sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000213machine # [ 0.030242] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes214sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00215machine # [ 0.031274] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)216sshClient # [ 0.000000] kvm-clock: using sched offset of 541929044 cycles217machine # [ 0.031286] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)218machine # [ 0.031317] Fallback order for Node 0: 0219sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns220sshClient # [ 0.000005] tsc: Detected 2400.008 MHz processor221machine # [ 0.031319] Built 1 zonelists, mobility grouping on. Total pages: 262006222machine # [ 0.031320] Policy zone: DMA32223sshClient # [ 0.000764] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000224machine # [ 0.033399] mem auto-init: stack:all(zero), heap alloc:on, heap free:off225sshClient # [ 0.000791] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs226machine # [ 0.035740] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1227sshClient # [ 0.000794] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT228machine # [ 0.038083] allocated 2097152 bytes of page_ext229machine # [ 0.047976] ftrace: allocating 48987 entries in 192 pages230sshClient # [ 0.002701] found SMP MP-table at [mem 0x000f5450-0x000f545f]231sshClient # [ 0.002713] Using GB pages for direct mapping232machine # [ 0.047978] ftrace: allocated 192 pages with 2 groups233machine # [ 0.048808] Dynamic Preempt: lazy234sshClient # [ 0.002796] RAMDISK: [mem 0x3e34b000-0x3ffcffff]235machine # [ 0.048932] rcu: Preemptible hierarchical RCU implementation.236sshClient # [ 0.002806] ACPI: Early table checksum verification disabled237machine # [ 0.048933] rcu: RCU event tracing is enabled.238sshClient # [ 0.002809] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )239machine # [ 0.048933] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.240sshClient # [ 0.002813] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)241machine # [ 0.048935] Trampoline variant of Tasks RCU enabled.242machine # [ 0.048935] Rude variant of Tasks RCU enabled.243sshClient # [ 0.002818] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)244machine # [ 0.048936] Tracing variant of Tasks RCU enabled.245sshClient # [ 0.002825] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)246machine # [ 0.048936] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.247sshClient # [ 0.002827] ACPI: FACS 0x000000003FFE0000 000040248machine # [ 0.048937] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1249sshClient # [ 0.002829] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)250machine # [ 0.048988] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.251sshClient # [ 0.002830] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)252machine # [ 0.048990] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.253sshClient # [ 0.002832] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)254machine # [ 0.048991] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.255sshClient # [ 0.002834] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)256machine # [ 0.053285] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16257sshClient # [ 0.002835] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]258machine # [ 0.053562] rcu: srcu_init: Setting srcu_struct sizes based on contention.259sshClient # [ 0.002836] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]260machine # [ 0.053568] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns261sshClient # [ 0.002836] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]262sshClient # [ 0.002837] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]263machine # [ 0.053663] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)264machine # [ 0.057161] Console: colour VGA+ 80x25265sshClient # [ 0.002837] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]266machine # [ 0.057163] printk: legacy console [tty0] enabled267sshClient # [ 0.002838] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]268machine # [ 0.086711] printk: legacy console [ttyS0] enabled269machine # [ 0.192075] ACPI: Core revision 20250807270sshClient # [ 0.002838] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]271sshClient # [ 0.003075] No NUMA configuration found272sshClient # [ 0.003075] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]273machine # [ 0.192970] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns274sshClient # [ 0.003077] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]275sshClient # [ 0.005360] Zone ranges:276machine # [ 0.194569] APIC: Switch to symmetric I/O mode setup277sshClient # [ 0.005361] DMA [mem 0x0000000000001000-0x0000000000ffffff]278machine # [ 0.195565] x2apic enabled279sshClient # [ 0.005363] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]280sshClient # [ 0.005364] Normal empty281machine # [ 0.196336] APIC: Switched APIC routing to: physical x2apic282sshClient # [ 0.005365] Device empty283sshClient # [ 0.005365] Movable zone start for each node284sshClient # [ 0.005366] Early memory node ranges285machine # [ 0.198141] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1286sshClient # [ 0.005367] node 0: [mem 0x0000000000001000-0x000000000009efff]287sshClient # [ 0.005368] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]288machine # [ 0.199162] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns289sshClient # [ 0.005368] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]290sshClient # [ 0.005392] On node 0, zone DMA: 1 pages in unavailable ranges291machine # [ 0.200892] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)292sshClient # [ 0.005645] On node 0, zone DMA: 97 pages in unavailable ranges293sshClient # [ 0.022743] On node 0, zone DMA32: 40 pages in unavailable ranges294machine # [ 0.201977] x86/cpu: User Mode Instruction Prevention (UMIP) activated295sshClient # [ 0.023192] ACPI: PM-Timer IO Port: 0x608296machine # [ 0.203827] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127297sshClient # [ 0.023204] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])298sshClient # [ 0.023232] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23299machine # [ 0.204627] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0300sshClient # [ 0.023235] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)301sshClient # [ 0.023236] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)302machine # [ 0.205694] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto303sshClient # [ 0.023237] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)304machine # [ 0.206889] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl305sshClient # [ 0.023238] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)306sshClient # [ 0.023239] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)307machine # [ 0.208890] Transient Scheduler Attacks: Vulnerable: No microcode308sshClient # [ 0.023242] ACPI: Using ACPI (MADT) for SMP configuration information309machine # [ 0.209889] Spectre V2 : Mitigation: Enhanced / Automatic IBRS310sshClient # [ 0.023243] ACPI: HPET id: 0x8086a201 base: 0xfed00000311sshClient # [ 0.023245] TSC deadline timer available312machine # [ 0.210889] Speculative Return Stack Overflow: Mitigation: Safe RET313sshClient # [ 0.023249] CPU topo: Max. logical packages: 1314sshClient # [ 0.023250] CPU topo: Max. logical dies: 1315sshClient # [ 0.023251] CPU topo: Max. dies per package: 1316sshClient # [ 0.023254] CPU topo: Max. threads per core: 1317sshClient # [ 0.023254] CPU topo: Num. cores per package: 1318sshClient # [ 0.023255] CPU topo: Num. threads per package: 1319machine # [ 0.211889] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization320sshClient # [ 0.023255] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs321machine # [ 0.213897] Spectre V2 : Enabling IBPB for BPF322sshClient # [ 0.023272] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()323machine # [ 0.214640] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier324sshClient # [ 0.023300] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]325machine # [ 0.215890] active return thunk: srso_alias_return_thunk326sshClient # [ 0.023301] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]327sshClient # [ 0.023303] [mem 0x40000000-0xafffffff] available for PCI devices328machine # [ 0.216910] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'329sshClient # [ 0.023304] Booting paravirtualized kernel on KVM330machine # [ 0.217889] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'331sshClient # [ 0.023307] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns332machine # [ 0.218889] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'333sshClient # [ 0.027953] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1334machine # [ 0.219889] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'335sshClient # [ 0.030158] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152336sshClient # [ 0.030212] kvm-guest: PV spinlocks disabled, single CPU337machine # [ 0.220889] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'338machine # [ 0.221889] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'339machine # [ 0.222889] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'340machine # [ 0.223889] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256341sshClient # [ 0.030213] 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/9vjxxpk7pd8ccv8gnscd9f08xblncx9k-nixos-system-sshClient-test/init regInfo=/nix/.ro-store/vf5rcq9ss8qcx683yj3rh7c1j7sd75g3-closure-info/registration console=ttyS0,115200n8 console=tty0342machine # [ 0.224889] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64343machine # [ 0.225889] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512344sshClient # [ 0.030311] Unknown kernel command line parameters "regInfo=/nix/.ro-store/vf5rcq9ss8qcx683yj3rh7c1j7sd75g3-closure-info/registration", will be passed to user space.345sshClient # [ 0.030323] random: crng init done346machine # [ 0.226889] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024347sshClient # [ 0.030324] printk: log buffer data + meta data: 1048576 + 3670016 = 4718592 bytes348machine # [ 0.227889] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8349sshClient # [ 0.031536] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)350machine # [ 0.228889] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.351sshClient # [ 0.031549] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)352sshClient # [ 0.031578] Fallback order for Node 0: 0353sshClient # [ 0.031580] Built 1 zonelists, mobility grouping on. Total pages: 262006354sshClient # [ 0.031582] Policy zone: DMA32355sshClient # [ 0.033676] mem auto-init: stack:all(zero), heap alloc:on, heap free:off356sshClient # [ 0.036029] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1357sshClient # [ 0.038702] allocated 2097152 bytes of page_ext358sshClient # [ 0.048533] ftrace: allocating 48987 entries in 192 pages359sshClient # [ 0.048535] ftrace: allocated 192 pages with 2 groups360sshClient # [ 0.049380] Dynamic Preempt: lazy361sshClient # [ 0.049530] rcu: Preemptible hierarchical RCU implementation.362sshClient # [ 0.049531] rcu: RCU event tracing is enabled.363sshClient # [ 0.049532] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.364sshClient # [ 0.049533] Trampoline variant of Tasks RCU enabled.365sshClient # [ 0.049533] Rude variant of Tasks RCU enabled.366sshClient # [ 0.049533] Tracing variant of Tasks RCU enabled.367sshClient # [ 0.049534] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.368sshClient # [ 0.049535] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1369sshClient # [ 0.049551] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.370sshClient # [ 0.049553] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.371sshClient # [ 0.049553] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.372sshClient # [ 0.053897] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16373sshClient # [ 0.054175] rcu: srcu_init: Setting srcu_struct sizes based on contention.374sshClient # [ 0.054184] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns375sshClient # [ 0.054290] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)376sshClient # [ 0.057864] Console: colour VGA+ 80x25377sshClient # [ 0.057867] printk: legacy console [tty0] enabled378sshClient # [ 0.087360] printk: legacy console [ttyS0] enabled379sshClient # [ 0.192438] ACPI: Core revision 20250807380sshClient # [ 0.193335] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns381sshClient # [ 0.194934] APIC: Switch to symmetric I/O mode setup382sshClient # [ 0.195940] x2apic enabled383sshClient # [ 0.196698] APIC: Switched APIC routing to: physical x2apic384sshClient # [ 0.198607] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1385sshClient # [ 0.199635] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns386sshClient # [ 0.201368] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)387sshClient # [ 0.202452] x86/cpu: User Mode Instruction Prevention (UMIP) activated388machine # [ 0.263183] Freeing SMP alternatives memory: 48K389sshClient # [ 0.204533] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127390machine # [ 0.263892] pid_max: default: 32768 minimum: 301391sshClient # [ 0.205365] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0392machine # [ 0.264745] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima393machine # [ 0.266011] landlock: Up and running.394sshClient # [ 0.206369] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto395machine # [ 0.266666] Yama: becoming mindful.396machine # [ 0.267547] LSM support for eBPF active397sshClient # [ 0.207365] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl398machine # [ 0.267985] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)399sshClient # [ 0.209365] Transient Scheduler Attacks: Vulnerable: No microcode400sshClient # [ 0.210365] Spectre V2 : Mitigation: Enhanced / Automatic IBRS401machine # [ 0.268910] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)402sshClient # [ 0.211365] Speculative Return Stack Overflow: Mitigation: Safe RET403machine # [ 0.271963] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)404machine # [ 0.273448] Performance Events: Fam17h+ core perfctr, AMD PMU driver.405sshClient # [ 0.212365] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization406machine # [ 0.273898] ... version: 2407sshClient # [ 0.214373] Spectre V2 : Enabling IBPB for BPF408machine # [ 0.274631] ... bit width: 48409machine # [ 0.274891] ... generic counters: 6410sshClient # [ 0.215365] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier411machine # [ 0.275643] ... generic bitmap: 000000000000003f412sshClient # [ 0.216365] active return thunk: srso_alias_return_thunk413machine # [ 0.275891] ... fixed-purpose counters: 0414machine # [ 0.276645] ... fixed-purpose bitmap: 0000000000000000415sshClient # [ 0.217386] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'416machine # [ 0.276891] ... value mask: 0000ffffffffffff417sshClient # [ 0.218365] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'418machine # [ 0.277839] ... max period: 00007fffffffffff419sshClient # [ 0.220170] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'420machine # [ 0.278587] ... global_ctrl mask: 000000000000003f421sshClient # [ 0.221151] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'422machine # [ 0.279004] signal: max sigframe size: 3376423sshClient # [ 0.222174] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'424machine # [ 0.279802] rcu: Hierarchical SRCU implementation.425machine # [ 0.280504] rcu: Max phase no-delay instances is 400.426sshClient # [ 0.223176] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'427sshClient # [ 0.224365] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'428sshClient # [ 0.225365] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256429sshClient # [ 0.226365] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64430sshClient # [ 0.227365] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512431sshClient # [ 0.228365] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024432machine # [ 0.285564] smp: Bringing up secondary CPUs ...433machine # [ 0.285905] smp: Brought up 1 node, 1 CPU434sshClient # [ 0.229365] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8435machine # [ 0.286633] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)436sshClient # [ 0.230365] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.437machine # [ 0.287142] Memory: 934784K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105856K reserved, 0K cma-reserved)438machine # [ 0.288104] devtmpfs: initialized439machine # [ 0.288981] x86/mm: Memory block size: 128MB440machine # [ 0.290657] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)441machine # [ 0.291874] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).442machine # [ 0.292976] pinctrl core: initialized pinctrl subsystem443machine # [ 0.294181] PM: RTC time: 03:09:01, date: 2026-10-21444machine # [ 0.297560] NET: Registered PF_NETLINK/PF_ROUTE protocol family445machine # [ 0.298244] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations446machine # [ 0.298908] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations447machine # [ 0.300031] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations448machine # [ 0.300901] audit: initializing netlink subsys (disabled)449machine # [ 0.302151] thermal_sys: Registered thermal governor 'fair_share'450machine # [ 0.302154] thermal_sys: Registered thermal governor 'bang_bang'451machine # [ 0.302893] thermal_sys: Registered thermal governor 'step_wise'452machine # [ 0.303895] audit: type=2000 audit(1792552142.635:1): state=initialized audit_enabled=0 res=1453machine # [ 0.305893] thermal_sys: Registered thermal governor 'user_space'454machine # [ 0.305895] thermal_sys: Registered thermal governor 'power_allocator'455machine # [ 0.306920] cpuidle: using governor menu456machine # [ 0.309217] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5457machine # [ 0.310155] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]458machine # [ 0.310895] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry459machine # [ 0.311903] PCI: Using configuration type 1 for base access460sshClient # [ 0.263877] Freeing SMP alternatives memory: 48K461machine # [ 0.313047] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.462sshClient # [ 0.264368] pid_max: default: 32768 minimum: 301463sshClient # [ 0.265480] LSM: initializing lsm=lockdown,capability,landlock,yama,bpf,ima464sshClient # [ 0.266482] landlock: Up and running.465sshClient # [ 0.267366] Yama: becoming mindful.466sshClient # [ 0.268201] LSM support for eBPF active467sshClient # [ 0.268952] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)468machine # [ 0.318130] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages469machine # [ 0.318892] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page470sshClient # [ 0.270384] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)471sshClient # [ 0.272670] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)472sshClient # [ 0.274338] Performance Events: Fam17h+ core perfctr, AMD PMU driver.473machine # [ 0.323893] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages474sshClient # [ 0.275172] ... version: 2475sshClient # [ 0.275368] ... bit width: 48476machine # [ 0.324892] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page477sshClient # [ 0.276169] ... generic counters: 6478sshClient # [ 0.276421] ... generic bitmap: 000000000000003f479sshClient # [ 0.277368] ... fixed-purpose counters: 0480sshClient # [ 0.278094] ... fixed-purpose bitmap: 0000000000000000481sshClient # [ 0.278368] ... value mask: 0000ffffffffffff482sshClient # [ 0.279301] ... max period: 00007fffffffffff483sshClient # [ 0.280085] ... global_ctrl mask: 000000000000003f484sshClient # [ 0.280480] signal: max sigframe size: 3376485sshClient # [ 0.281300] rcu: Hierarchical SRCU implementation.486sshClient # [ 0.282007] rcu: Max phase no-delay instances is 400.487machine # [ 0.335313] ACPI: Added _OSI(Module Device)488machine # [ 0.335893] ACPI: Added _OSI(Processor Device)489machine # [ 0.336643] ACPI: Added _OSI(Processor Aggregator Device)490sshClient # [ 0.287083] smp: Bringing up secondary CPUs ...491sshClient # [ 0.287381] smp: Brought up 1 node, 1 CPU492sshClient # [ 0.288078] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)493sshClient # [ 0.288615] Memory: 934780K/1048024K available (18186K kernel code, 5431K rwdata, 13716K rodata, 6720K init, 3992K bss, 105868K reserved, 0K cma-reserved)494sshClient # [ 0.289616] devtmpfs: initialized495sshClient # [ 0.290484] x86/mm: Memory block size: 128MB496machine # [ 0.345445] ACPI: 1 ACPI AML tables successfully acquired and loaded497sshClient # [ 0.292228] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)498sshClient # [ 0.293358] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).499sshClient # [ 0.294454] pinctrl core: initialized pinctrl subsystem500machine # [ 0.349310] ACPI: Interpreter enabled501machine # [ 0.349909] ACPI: PM: (supports S0 S3 S4 S5)502sshClient # [ 0.295620] PM: RTC time: 03:09:01, date: 2026-10-21503machine # [ 0.350658] ACPI: Using IOAPIC for interrupt routing504machine # [ 0.350947] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug505machine # [ 0.351892] PCI: Using E820 reservations for host bridge windows506sshClient # [ 0.299228] NET: Registered PF_NETLINK/PF_ROUTE protocol family507sshClient # [ 0.300548] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations508machine # [ 0.355016] ACPI: Enabled 2 GPEs in block 00 to 3F509sshClient # [ 0.301384] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations510sshClient # [ 0.302523] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations511sshClient # [ 0.303378] audit: initializing netlink subsys (disabled)512sshClient # [ 0.304369] audit: type=2000 audit(1792552142.700:1): state=initialized audit_enabled=0 res=1513sshClient # [ 0.305584] thermal_sys: Registered thermal governor 'fair_share'514sshClient # [ 0.305586] thermal_sys: Registered thermal governor 'bang_bang'515sshClient # [ 0.306369] thermal_sys: Registered thermal governor 'step_wise'516machine # [ 0.362710] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])517sshClient # [ 0.307361] thermal_sys: Registered thermal governor 'user_space'518machine # [ 0.363683] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]519sshClient # [ 0.308147] thermal_sys: Registered thermal governor 'power_allocator'520sshClient # [ 0.309135] cpuidle: using governor menu521machine # [ 0.364969] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]522sshClient # [ 0.310622] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5523machine # [ 0.366015] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]524machine # [ 0.367234] PCI host bridge to bus 0000:00525sshClient # [ 0.311614] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]526machine # [ 0.367896] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]527sshClient # [ 0.312370] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry528machine # [ 0.368892] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]529sshClient # [ 0.313378] PCI: Using configuration type 1 for base access530machine # [ 0.369892] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]531sshClient # [ 0.314521] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.532machine # [ 0.370893] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]533machine # [ 0.371892] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]534machine # [ 0.372891] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]535machine # [ 0.373892] pci_bus 0000:00: root bus resource [bus 00-ff]536sshClient # [ 0.319601] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages537machine # [ 0.374921] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint538sshClient # [ 0.320369] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page539machine # [ 0.376416] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint540sshClient # [ 0.325369] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages541sshClient # [ 0.326368] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page542machine # [ 0.378970] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]543machine # [ 0.379904] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]544machine # [ 0.380981] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]545machine # [ 0.382274] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]546machine # [ 0.383671] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint547sshClient # [ 0.336724] ACPI: Added _OSI(Module Device)548sshClient # [ 0.337369] ACPI: Added _OSI(Processor Device)549sshClient # [ 0.338149] ACPI: Added _OSI(Processor Aggregator Device)550machine # [ 0.385927] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]551machine # [ 0.386794] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]552machine # [ 0.387675] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]553machine # [ 0.388783] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]554machine # [ 0.390245] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555machine # [ 0.391922] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]556sshClient # [ 0.346168] ACPI: 1 ACPI AML tables successfully acquired and loaded557machine # [ 0.392765] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]558machine # [ 0.393617] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]559machine # [ 0.394433] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint560sshClient # [ 0.350123] ACPI: Interpreter enabled561sshClient # [ 0.350384] ACPI: PM: (supports S0 S3 S4 S5)562sshClient # [ 0.351136] ACPI: Using IOAPIC for interrupt routing563sshClient # [ 0.351431] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug564machine # [ 0.396925] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]565machine # [ 0.397898] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]566machine # [ 0.398913] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]567machine # [ 0.400465] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint568sshClient # [ 0.356368] PCI: Using E820 reservations for host bridge windows569sshClient # [ 0.357477] ACPI: Enabled 2 GPEs in block 00 to 3F570machine # [ 0.401920] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]571machine # [ 0.402837] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]572machine # [ 0.403704] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]573machine # [ 0.404807] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]574machine # [ 0.406446] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint575sshClient # [ 0.364539] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])576machine # [ 0.407734] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]577sshClient # [ 0.365375] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]578machine # [ 0.408696] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]579sshClient # [ 0.366444] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]580sshClient # [ 0.367489] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]581machine # [ 0.410334] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint582sshClient # [ 0.368716] PCI host bridge to bus 0000:00583machine # [ 0.411893] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]584sshClient # [ 0.369372] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]585sshClient # [ 0.370368] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]586machine # [ 0.412877] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]587sshClient # [ 0.371367] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]588machine # [ 0.414517] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint589sshClient # [ 0.372368] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]590sshClient # [ 0.373367] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]591machine # [ 0.415717] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]592sshClient # [ 0.374367] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]593machine # [ 0.416696] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]594sshClient # [ 0.375367] pci_bus 0000:00: root bus resource [bus 00-ff]595machine # [ 0.418327] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint596sshClient # [ 0.376360] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint597sshClient # [ 0.377879] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint598machine # [ 0.419923] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]599machine # [ 0.420914] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]600machine # [ 0.422438] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint601machine # [ 0.423930] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]602machine # [ 0.424833] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]603sshClient # [ 0.380499] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]604machine # [ 0.425698] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]605sshClient # [ 0.381380] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]606machine # [ 0.427325] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint607sshClient # [ 0.382433] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]608sshClient # [ 0.383748] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]609machine # [ 0.429893] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]610sshClient # [ 0.385094] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint611machine # [ 0.430899] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]612machine # [ 0.431913] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]613sshClient # [ 0.387379] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]614machine # [ 0.433467] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint615sshClient # [ 0.388268] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]616machine # [ 0.434469] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]617sshClient # [ 0.389159] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]618sshClient # [ 0.390311] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]619machine # [ 0.435095] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint620machine # [ 0.436431] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]621sshClient # [ 0.391729] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint622machine # [ 0.437081] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint623sshClient # [ 0.394389] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]624machine # [ 0.438429] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]625sshClient # [ 0.395281] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]626sshClient # [ 0.396148] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]627sshClient # [ 0.397813] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint628sshClient # [ 0.400513] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]629sshClient # [ 0.401375] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]630sshClient # [ 0.402377] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]631sshClient # [ 0.403925] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint632machine # [ 0.439115] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint633machine # [ 0.441439] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]634sshClient # [ 0.405385] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]635sshClient # [ 0.406255] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]636machine # [ 0.442185] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint637sshClient # [ 0.407159] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]638machine # [ 0.443181] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO639sshClient # [ 0.408254] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]640machine # [ 0.444144] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint641sshClient # [ 0.409923] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint642machine # [ 0.445862] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]643sshClient # [ 0.411151] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]644machine # [ 0.446581] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]645sshClient # [ 0.412192] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]646machine # [ 0.447224] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint647sshClient # [ 0.413855] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint648machine # [ 0.448622] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]649sshClient # [ 0.415381] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]650sshClient # [ 0.416389] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]651sshClient # [ 0.417928] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint652machine # [ 0.452582] ACPI: PCI: Interrupt link LNKA configured for IRQ 10653machine # [ 0.453003] ACPI: PCI: Interrupt link LNKB configured for IRQ 10654sshClient # [ 0.419113] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]655machine # [ 0.454011] ACPI: PCI: Interrupt link LNKC configured for IRQ 11656sshClient # [ 0.419391] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]657machine # [ 0.455013] ACPI: PCI: Interrupt link LNKD configured for IRQ 11658machine # [ 0.456009] ACPI: PCI: Interrupt link LNKE configured for IRQ 10659sshClient # [ 0.420902] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint660machine # [ 0.456994] ACPI: PCI: Interrupt link LNKF configured for IRQ 10661sshClient # [ 0.422296] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]662machine # [ 0.458009] ACPI: PCI: Interrupt link LNKG configured for IRQ 11663sshClient # [ 0.423144] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]664machine # [ 0.459007] ACPI: PCI: Interrupt link LNKH configured for IRQ 11665machine # [ 0.459935] ACPI: PCI: Interrupt link GSIA configured for IRQ 16666sshClient # [ 0.424898] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint667machine # [ 0.460910] ACPI: PCI: Interrupt link GSIB configured for IRQ 17668machine # [ 0.461913] ACPI: PCI: Interrupt link GSIC configured for IRQ 18669sshClient # [ 0.426398] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]670machine # [ 0.462910] ACPI: PCI: Interrupt link GSID configured for IRQ 19671sshClient # [ 0.427286] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]672machine # [ 0.463905] ACPI: PCI: Interrupt link GSIE configured for IRQ 20673sshClient # [ 0.428167] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]674machine # [ 0.464905] ACPI: PCI: Interrupt link GSIF configured for IRQ 21675machine # [ 0.465905] ACPI: PCI: Interrupt link GSIG configured for IRQ 22676sshClient # [ 0.429799] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint677machine # [ 0.466911] ACPI: PCI: Interrupt link GSIH configured for IRQ 23678machine # [ 0.469048] iommu: Default domain type: Translated679sshClient # [ 0.431461] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]680machine # [ 0.469902] iommu: DMA domain TLB invalidation policy: lazy mode681sshClient # [ 0.432374] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]682machine # [ 0.471204] ACPI: bus type USB registered683sshClient # [ 0.433367] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]684machine # [ 0.471953] usbcore: registered new interface driver usbfs685machine # [ 0.472917] usbcore: registered new interface driver hub686sshClient # [ 0.434925] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint687machine # [ 0.473934] usbcore: registered new device driver usb688sshClient # [ 0.435963] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]689machine # [ 0.475832] NetLabel: Initializing690sshClient # [ 0.436604] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint691machine # [ 0.476382] NetLabel: domain hash size = 128692machine # [ 0.476893] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO693sshClient # [ 0.437930] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]694machine # [ 0.477966] NetLabel: unlabeled traffic allowed by default695machine # [ 0.478910] PCI: Using ACPI for IRQ routing696sshClient # [ 0.438575] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint697sshClient # [ 0.439932] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]698sshClient # [ 0.440651] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint699sshClient # [ 0.442910] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]700sshClient # [ 0.443598] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint701sshClient # [ 0.444679] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO702sshClient # [ 0.445624] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint703sshClient # [ 0.447267] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]704sshClient # [ 0.448060] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]705sshClient # [ 0.448718] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint706sshClient # [ 0.450128] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]707sshClient # [ 0.453771] ACPI: PCI: Interrupt link LNKA configured for IRQ 10708sshClient # [ 0.454475] ACPI: PCI: Interrupt link LNKB configured for IRQ 10709sshClient # [ 0.455471] ACPI: PCI: Interrupt link LNKC configured for IRQ 11710sshClient # [ 0.456463] ACPI: PCI: Interrupt link LNKD configured for IRQ 11711sshClient # [ 0.457462] ACPI: PCI: Interrupt link LNKE configured for IRQ 10712sshClient # [ 0.458476] ACPI: PCI: Interrupt link LNKF configured for IRQ 10713sshClient # [ 0.459472] ACPI: PCI: Interrupt link LNKG configured for IRQ 11714sshClient # [ 0.460466] ACPI: PCI: Interrupt link LNKH configured for IRQ 11715sshClient # [ 0.461412] ACPI: PCI: Interrupt link GSIA configured for IRQ 16716sshClient # [ 0.462393] ACPI: PCI: Interrupt link GSIB configured for IRQ 17717sshClient # [ 0.463384] ACPI: PCI: Interrupt link GSIC configured for IRQ 18718machine # [ 0.524709] pci 0000:00:01.0: vgaarb: setting as boot VGA device719sshClient # [ 0.464384] ACPI: PCI: Interrupt link GSID configured for IRQ 19720machine # [ 0.524888] pci 0000:00:01.0: vgaarb: bridge control possible721sshClient # [ 0.465349] ACPI: PCI: Interrupt link GSIE configured for IRQ 20722machine # [ 0.524888] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none723sshClient # [ 0.466140] ACPI: PCI: Interrupt link GSIF configured for IRQ 21724machine # [ 0.524897] vgaarb: loaded725sshClient # [ 0.466379] ACPI: PCI: Interrupt link GSIG configured for IRQ 22726machine # [ 0.525642] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0727sshClient # [ 0.467369] ACPI: PCI: Interrupt link GSIH configured for IRQ 23728machine # [ 0.525894] hpet0: 3 comparators, 64-bit 100.000000 MHz counter729sshClient # [ 0.469388] iommu: Default domain type: Translated730sshClient # [ 0.470218] iommu: DMA domain TLB invalidation policy: lazy mode731sshClient # [ 0.471478] ACPI: bus type USB registered732sshClient # [ 0.472243] usbcore: registered new interface driver usbfs733machine # [ 0.529981] clocksource: Switched to clocksource kvm-clock734sshClient # [ 0.473088] usbcore: registered new interface driver hub735sshClient # [ 0.473385] usbcore: registered new device driver usb736sshClient # [ 0.475206] NetLabel: Initializing737sshClient # [ 0.475859] NetLabel: domain hash size = 128738machine # [ 0.533745] VFS: Disk quotas dquot_6.6.0739sshClient # [ 0.476367] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO740machine # [ 0.534444] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)741sshClient # [ 0.477392] NetLabel: unlabeled traffic allowed by default742machine # [ 0.535853] pnp: PnP ACPI init743sshClient # [ 0.478367] PCI: Using ACPI for IRQ routing744machine # [ 0.536642] ACPI: IRQ 4 override to edge(!), high(!)745machine # [ 0.537612] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved746machine # [ 0.539186] pnp: PnP ACPI: found 5 devices747machine # [ 0.546765] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns748machine # [ 0.548247] clocksource: Switched to clocksource acpi_pm749machine # [ 0.549276] NET: Registered PF_INET protocol family750machine # [ 0.550395] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)751machine # [ 0.567979] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)752machine # [ 0.569556] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)753machine # [ 0.570898] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)754machine # [ 0.572245] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)755machine # [ 0.573525] TCP: Hash tables configured (established 8192 bind 8192)756machine # [ 0.574654] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)757machine # [ 0.575995] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)758machine # [ 0.577142] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)759machine # [ 0.578389] NET: Registered PF_UNIX/PF_LOCAL protocol family760machine # [ 0.579380] NET: Registered PF_XDP protocol family761machine # [ 0.580238] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]762machine # [ 0.581280] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]763sshClient # [ 0.523419] pci 0000:00:01.0: vgaarb: setting as boot VGA device764machine # [ 0.582349] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]765sshClient # [ 0.524364] pci 0000:00:01.0: vgaarb: bridge control possible766machine # [ 0.583428] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]767sshClient # [ 0.524364] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none768machine # [ 0.584565] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]769sshClient # [ 0.524373] vgaarb: loaded770sshClient # [ 0.525134] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0771machine # [ 0.585684] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]772sshClient # [ 0.525367] hpet0: 3 comparators, 64-bit 100.000000 MHz counter773machine # [ 0.587445] ACPI: \_SB_.GSIA: Enabled at IRQ 16774machine # [ 0.589754] ACPI: \_SB_.GSIB: Enabled at IRQ 17775machine # [ 0.592144] ACPI: \_SB_.GSIC: Enabled at IRQ 18776sshClient # [ 0.531467] clocksource: Switched to clocksource kvm-clock777machine # [ 0.594189] ACPI: \_SB_.GSID: Enabled at IRQ 19778machine # [ 0.595946] PCI: CLS 0 bytes, default 64779sshClient # [ 0.535130] VFS: Disk quotas dquot_6.6.0780machine # [ 0.596859] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns781machine # [ 0.598625] Trying to unpack rootfs image as initramfs...782sshClient # [ 0.535883] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)783sshClient # [ 0.537345] pnp: PnP ACPI init784sshClient # [ 0.538204] ACPI: IRQ 4 override to edge(!), high(!)785sshClient # [ 0.539220] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved786sshClient # [ 0.540810] pnp: PnP ACPI: found 5 devices787sshClient # [ 0.548391] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns788sshClient # [ 0.549979] clocksource: Switched to clocksource acpi_pm789sshClient # [ 0.550988] NET: Registered PF_INET protocol family790sshClient # [ 0.552071] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)791sshClient # [ 0.569090] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)792sshClient # [ 0.570681] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)793sshClient # [ 0.572069] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)794sshClient # [ 0.573459] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)795sshClient # [ 0.574743] TCP: Hash tables configured (established 8192 bind 8192)796sshClient # [ 0.575873] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)797sshClient # [ 0.577219] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)798sshClient # [ 0.578382] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)799sshClient # [ 0.579653] NET: Registered PF_UNIX/PF_LOCAL protocol family800sshClient # [ 0.580671] NET: Registered PF_XDP protocol family801machine # [ 0.643770] Initialise system trusted keyrings802sshClient # [ 0.581568] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]803machine # [ 0.644628] Key type blacklist registered804sshClient # [ 0.582584] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]805sshClient # [ 0.583654] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]806sshClient # [ 0.584780] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]807machine # [ 0.647495] workingset: timestamp_bits=40 max_order=18 bucket_order=0808sshClient # [ 0.585958] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]809machine # [ 0.648888] integrity: Platform Keyring initialized810machine # [ 0.649775] integrity: Machine keyring initialized811sshClient # [ 0.587144] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]812sshClient # [ 0.588954] ACPI: \_SB_.GSIA: Enabled at IRQ 16813sshClient # [ 0.591236] ACPI: \_SB_.GSIB: Enabled at IRQ 17814sshClient # [ 0.593239] ACPI: \_SB_.GSIC: Enabled at IRQ 18815sshClient # [ 0.595116] ACPI: \_SB_.GSID: Enabled at IRQ 19816sshClient # [ 0.596721] PCI: CLS 0 bytes, default 64817sshClient # [ 0.597608] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns818sshClient # [ 0.599377] Trying to unpack rootfs image as initramfs...819machine # [ 0.670220] Key type asymmetric registered820machine # [ 0.673350] Asymmetric key parser 'x509' registered821machine # [ 0.674259] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)822machine # [ 0.677451] io scheduler mq-deadline registered823machine # [ 0.678269] io scheduler kyber registered824machine # [ 0.681920] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled825machine # [ 0.683234] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A826machine # [ 0.688627] Linux agpgart interface v0.103827machine # [ 0.689452] ACPI: bus type drm_connector registered828machine # [ 0.692779] usbcore: registered new interface driver usbserial_generic829machine # [ 0.693888] usbserial: USB Serial support registered for generic830machine # [ 0.697344] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.831machine # [ 0.697344] Please enable it if your BIOS has the CPPC option.832machine # [ 0.699691] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled833machine # [ 0.703483] drop_monitor: Initializing network drop monitor service834machine # [ 0.704684] NET: Registered PF_INET6 protocol family835machine # [ 0.707831] Segment Routing with IPv6836sshClient # [ 0.645661] Initialise system trusted keyrings837sshClient # [ 0.646525] Key type blacklist registered838machine # [ 0.711362] In-situ OAM (IOAM) with IPv6839sshClient # [ 0.649365] workingset: timestamp_bits=40 max_order=18 bucket_order=0840machine # [ 0.712471] IPI shorthand broadcast: enabled841sshClient # [ 0.652382] integrity: Platform Keyring initialized842sshClient # [ 0.653272] integrity: Machine keyring initialized843machine # [ 0.720765] sched_clock: Marking stable (577014698, 143320418)->(793957223, -73622107)844machine # [ 0.725590] registered taskstats version 1845machine # [ 0.726620] Loading compiled-in X.509 certificates846sshClient # [ 0.673771] Key type asymmetric registered847sshClient # [ 0.677208] Asymmetric key parser 'x509' registered848sshClient # [ 0.678061] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)849sshClient # [ 0.681328] io scheduler mq-deadline registered850sshClient # [ 0.682118] io scheduler kyber registered851machine # [ 0.745343] Demotion targets for Node 0: null852machine # [ 0.746245] Key type .fscrypt registered853sshClient # [ 0.686385] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled854machine # [ 0.749353] Key type fscrypt-provisioning registered855machine # [ 0.750313] ima: No TPM chip found, activating TPM-bypass!856sshClient # [ 0.687667] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A857machine # [ 0.751278] ima: Allocated hash algorithm: sha1858machine # [ 0.754371] ima: No architecture policies found859machine # [ 0.755386] PM: Magic number: 14:534:159860sshClient # [ 0.693019] Linux agpgart interface v0.103861sshClient # [ 0.693799] ACPI: bus type drm_connector registered862machine # [ 0.757026] RAS: Correctable Errors collector initialized.863sshClient # [ 0.696673] usbcore: registered new interface driver usbserial_generic864sshClient # [ 0.697781] usbserial: USB Serial support registered for generic865sshClient # [ 0.702211] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.866machine # [ 0.766076] clk: Disabling unused clocks867sshClient # [ 0.702211] Please enable it if your BIOS has the CPPC option.868sshClient # [ 0.704478] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled869machine # [ 0.769355] PM: genpd: Disabling unused power domains870sshClient # [ 0.707339] drop_monitor: Initializing network drop monitor service871sshClient # [ 0.708605] NET: Registered PF_INET6 protocol family872sshClient # [ 0.713565] Segment Routing with IPv6873sshClient # [ 0.714306] In-situ OAM (IOAM) with IPv6874sshClient # [ 0.717499] IPI shorthand broadcast: enabled875sshClient # [ 0.725837] sched_clock: Marking stable (583014656, 142180988)->(799313543, -74117899)876sshClient # [ 0.729426] registered taskstats version 1877sshClient # [ 0.730430] Loading compiled-in X.509 certificates878sshClient # [ 0.751210] Demotion targets for Node 0: null879sshClient # [ 0.752127] Key type .fscrypt registered880sshClient # [ 0.752873] Key type fscrypt-provisioning registered881sshClient # [ 0.753852] ima: No TPM chip found, activating TPM-bypass!882sshClient # [ 0.758222] ima: Allocated hash algorithm: sha1883sshClient # [ 0.759071] ima: No architecture policies found884sshClient # [ 0.761208] PM: Magic number: 14:534:159885sshClient # [ 0.762842] RAS: Correctable Errors collector initialized.886sshClient # [ 0.771918] clk: Disabling unused clocks887sshClient # [ 0.775215] PM: genpd: Disabling unused power domains888machine # [ 0.926985] Freeing initrd memory: 29192K889machine # [ 0.930181] Freeing unused decrypted memory: 2028K890machine # [ 0.934696] Freeing unused kernel image (initmem) memory: 6720K891machine # [ 0.935834] Write protecting the kernel read-only data: 32768k892machine # [ 0.937129] Freeing unused kernel image (text/rodata gap) memory: 244K893machine # [ 0.938683] Freeing unused kernel image (rodata/data gap) memory: 620K894sshClient # [ 0.926751] Freeing initrd memory: 29204K895machine # [ 0.989111] x86/mm: Checked W+X mappings: passed, no W+X pages found.896machine # [ 0.990190] Run /init as init process897sshClient # [ 0.930029] Freeing unused decrypted memory: 2028K898sshClient # [ 0.934378] Freeing unused kernel image (initmem) memory: 6720K899sshClient # [ 0.935446] Write protecting the kernel read-only data: 32768k900sshClient # [ 0.936710] Freeing unused kernel image (text/rodata gap) memory: 244K901machine # [ 0.999845] autofs4: module verification failed: signature and/or required key missing - tainting kernel902sshClient # [ 0.938152] Freeing unused kernel image (rodata/data gap) memory: 620K903machine # [ 1.002388] systemd[1]: Inserted module 'autofs4'904machine # [ 1.021997] fuse: init (API version 7.45)905machine # [ 1.029108] ACPI: \_SB_.GSIG: Enabled at IRQ 22906machine # [ 1.031478] ACPI: \_SB_.GSIH: Enabled at IRQ 23907machine # [ 1.034426] ACPI: \_SB_.GSIE: Enabled at IRQ 20908machine # [ 1.036355] ACPI: \_SB_.GSIF: Enabled at IRQ 21909machine # [ 1.041305] virtiofs virtio5: discovered new tag: nix-store910machine # [ 1.042861] virtiofs virtio5: virtio_fs_setup_dax: No cache capability911machine # [ 1.049507] virtiofs virtio6: discovered new tag: shared912machine # [ 1.050987] virtiofs virtio6: virtio_fs_setup_dax: No cache capability913sshClient # [ 0.988530] x86/mm: Checked W+X mappings: passed, no W+X pages found.914sshClient # [ 0.989605] Run /init as init process915machine # [ 1.054020] virtiofs virtio7: discovered new tag: xchg916machine # [ 1.055552] virtiofs virtio7: virtio_fs_setup_dax: No cache capability917sshClient # [ 0.999370] autofs4: module verification failed: signature and/or required key missing - tainting kernel918sshClient # [ 1.001962] systemd[1]: Inserted module 'autofs4'919machine # [ 1.077151] systemd[1]: Successfully made /usr/ read-only.920machine # [ 1.078941] systemd[1]: systemd 263-cb90bff 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.084065] systemd[1]: Detected virtualization kvm.922sshClient # [ 1.021543] fuse: init (API version 7.45)923machine # [ 1.084902] systemd[1]: Detected architecture x86-64.924machine # [ 1.085746] systemd[1]: Running in initrd.925machine # [ 1.086686] systemd[1]: Initializing machine ID from random generator.926machine # [ 1.087812] systemd[1]: Hostname set to <machine>.927sshClient # [ 1.028684] ACPI: \_SB_.GSIG: Enabled at IRQ 22928sshClient # [ 1.031141] ACPI: \_SB_.GSIH: Enabled at IRQ 23929sshClient # [ 1.034331] ACPI: \_SB_.GSIE: Enabled at IRQ 20930sshClient # [ 1.037023] ACPI: \_SB_.GSIF: Enabled at IRQ 21931sshClient # [ 1.042991] virtiofs virtio5: discovered new tag: nix-store932sshClient # [ 1.044650] virtiofs virtio5: virtio_fs_setup_dax: No cache capability933sshClient # [ 1.052136] virtiofs virtio6: discovered new tag: shared934sshClient # [ 1.053705] virtiofs virtio6: virtio_fs_setup_dax: No cache capability935sshClient # [ 1.057644] virtiofs virtio7: discovered new tag: xchg936sshClient # [ 1.059142] virtiofs virtio7: virtio_fs_setup_dax: No cache capability937sshClient # [ 1.078971] systemd[1]: Successfully made /usr/ read-only.938sshClient # [ 1.080732] systemd[1]: systemd 263-cb90bff 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.085927] systemd[1]: Detected virtualization kvm.940sshClient # [ 1.086757] systemd[1]: Detected architecture x86-64.941sshClient # [ 1.087591] systemd[1]: Running in initrd.942sshClient # [ 1.088547] systemd[1]: Initializing machine ID from random generator.943sshClient # [ 1.089700] systemd[1]: Hostname set to <sshClient>.944machine # [ 1.159875] systemd[1]: bpf-restrict-fs: LSM BPF program attached945machine # [ 1.195519] systemd[1]: Queued start job for default target Initrd Default Target.946machine # [ 1.198585] systemd[1]: Created slice Slice /system/modprobe.947machine # [ 1.199727] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.948machine # [ 1.201085] systemd[1]: Expecting device /dev/disk/by-label/nixos...949machine # [ 1.202144] systemd[1]: Reached target Path Units.950machine # [ 1.202995] systemd[1]: Reached target Slice Units.951machine # [ 1.203833] systemd[1]: Reached target Swaps.952machine # [ 1.204611] systemd[1]: Reached target Timer Units.953machine # [ 1.205556] systemd[1]: Listening on D-Bus System Message Bus Socket.954machine # [ 1.206736] systemd[1]: Listening on Journal Socket (/dev/log).955machine # [ 1.207849] systemd[1]: Listening on Journal Sockets.956machine # [ 1.208775] systemd[1]: Listening on udev Kernel Socket.957machine # [ 1.221244] systemd[1]: Listening on udev Varlink Socket.958machine # [ 1.222202] systemd[1]: Reached target Socket Units.959machine # [ 1.223971] systemd[1]: Starting Create List of Static Device Nodes...960sshClient # [ 1.161962] systemd[1]: bpf-restrict-fs: LSM BPF program attached961machine # [ 1.228408] systemd[1]: Starting Load Kernel Module configfs...962machine # [ 1.236405] systemd[1]: Starting Journal Service...963machine # [ 1.245954] systemd[1]: Starting Load Kernel Modules...964machine # [ 1.249416] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os965machine # [ 1.254369] systemd[1]: Starting Coldplug All udev Devices...966sshClient # [ 1.198062] systemd[1]: Queued start job for default target Initrd Default Target.967sshClient # [ 1.202526] systemd[1]: Created slice Slice /system/modprobe.968sshClient # [ 1.203799] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.969machine # [ 1.267680] systemd[1]: Finished Create List of Static Device Nodes.970sshClient # [ 1.205240] systemd[1]: Expecting device /dev/disk/by-label/nixos...971sshClient # [ 1.206314] systemd[1]: Reached target Path Units.972sshClient # [ 1.207142] systemd[1]: Reached target Slice Units.973sshClient # [ 1.208026] systemd[1]: Reached target Swaps.974sshClient # [ 1.208789] systemd[1]: Reached target Timer Units.975machine # [ 1.271959] systemd[1]: modprobe@configfs.service: Deactivated successfully.976sshClient # [ 1.209720] systemd[1]: Listening on D-Bus System Message Bus Socket.977sshClient # [ 1.210907] systemd[1]: Listening on Journal Socket (/dev/log).978sshClient # [ 1.212022] systemd[1]: Listening on Journal Sockets.979machine # [ 1.279717] systemd[1]: Finished Load Kernel Module configfs.980machine # [ 1.285801] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config981sshClient # [ 1.212983] systemd[1]: Listening on udev Kernel Socket.982sshClient # [ 1.225343] systemd[1]: Listening on udev Varlink Socket.983sshClient # [ 1.226312] systemd[1]: Reached target Socket Units.984machine # [ 1.290224] systemd-journald[65]: Collecting audit messages is disabled.985sshClient # [ 1.228112] systemd[1]: Starting Create List of Static Device Nodes...986sshClient # [ 1.232159] systemd[1]: Starting Load Kernel Module configfs...987machine # [ 1.297826] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...988sshClient # [ 1.241791] systemd[1]: Starting Journal Service...989machine # [ 1.308007] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.990sshClient # [ 1.251277] systemd[1]: Starting Load Kernel Modules...991machine # [ 1.316659] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev992sshClient # [ 1.255284] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os993sshClient # [ 1.260229] systemd[1]: Starting Coldplug All udev Devices...994machine # [ 1.335889] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.995sshClient # [ 1.273590] systemd[1]: Finished Create List of Static Device Nodes.996sshClient # [ 1.278832] systemd[1]: modprobe@configfs.service: Deactivated successfully.997machine # [ 1.344529] systemd[1]: Starting Create Static Device Nodes in /dev...998sshClient # [ 1.287770] systemd[1]: Finished Load Kernel Module configfs.999machine # [ 1.355427] systemd[1]: Finished Load Kernel Modules.1000sshClient # [ 1.293646] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config1001sshClient # [ 1.298017] systemd-journald[65]: Collecting audit messages is disabled.1002machine # [ 1.364413] systemd[1]: Starting Apply Kernel Variables...1003sshClient # [ 1.302972] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1004sshClient # [ 1.312393] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1005machine # [ 1.384953] systemd[1]: Finished Create Static Device Nodes in /dev.1006sshClient # [ 1.325379] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1007machine # [ 1.389548] systemd[1]: Reached target Preparation for Local File Systems.1008machine # [ 1.395421] systemd[1]: Reached target Local File Systems.1009machine # [ 1.401929] systemd[1]: Starting Rule-based Manager for Device Events and Files...1010sshClient # [ 1.346750] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1011machine # [ 1.265732] systemd-modules-load[66]: Inserted module 'dm_mod'1012machine # [ 1.268892] systemd-modules-load[66]: Inserted module 'virtio_balloon'1013machine # [ 1.269910] systemd-modules-load[66]: Inserted module 'virtio_gpu'1014machine # [ 1.414633] systemd[1]: Started Journal Service.1015sshClient # [ 1.355388] systemd[1]: Starting Create Static Device Nodes in /dev...1016machine # [ 1.279333] systemd[1]: Finished Apply Kernel Variables.1017sshClient # [ 1.366273] systemd[1]: Finished Load Kernel Modules.1018sshClient # [ 1.373406] systemd[1]: Starting Apply Kernel Variables...1019machine # [ 1.293084] systemd[1]: Starting Create System Files and Directories...1020sshClient # [ 1.395317] systemd[1]: Finished Create Static Device Nodes in /dev.1021machine # [ 1.319448] systemd[1]: Finished Create System Files and Directories.1022sshClient # [ 1.401438] systemd[1]: Reached target Preparation for Local File Systems.1023sshClient # [ 1.404269] systemd[1]: Reached target Local File Systems.1024machine # [ 1.325368] systemd-udevd[73]: Using default interface naming scheme 'v261'.1025sshClient # [ 1.411390] systemd[1]: Starting Rule-based Manager for Device Events and Files...1026sshClient # [ 1.274743] systemd-modules-load[66]: Inserted module 'dm_mod'1027sshClient # [ 1.277879] systemd-modules-load[66]: Inserted module 'virtio_balloon'1028sshClient # [ 1.278889] systemd-modules-load[66]: Inserted module 'virtio_gpu'1029sshClient # [ 1.423441] systemd[1]: Started Journal Service.1030sshClient # [ 1.287240] systemd[1]: Finished Apply Kernel Variables.1031machine # [ 1.348533] systemd[1]: Started Rule-based Manager for Device Events and Files.1032sshClient # [ 1.300303] systemd[1]: Starting Create System Files and Directories...1033sshClient # [ 1.328425] systemd[1]: Finished Create System Files and Directories.1034sshClient # [ 1.334121] systemd-udevd[73]: Using default interface naming scheme 'v261'.1035machine # [ 1.406774] systemd[1]: Finished Coldplug All udev Devices.1036machine # [ 1.409117] systemd[1]: Reached target System Initialization.1037machine # [ 1.410470] systemd[1]: Reached target Basic System.1038sshClient # [ 1.360140] systemd[1]: Started Rule-based Manager for Device Events and Files.1039sshClient # [ 1.419536] systemd[1]: Finished Coldplug All udev Devices.1040sshClient # [ 1.420438] systemd[1]: Reached target System Initialization.1041sshClient # [ 1.421391] systemd[1]: Reached target Basic System.1042machine # [ 1.695550] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121043machine # [ 1.706186] serio: i8042 KBD port at 0x60,0x64 irq 11044machine # [ 1.706914] serio: i8042 AUX port at 0x60,0x64 irq 121045machine # [ 1.708403] virtio_blk virtio2: 1/0/0 default/read/poll queues1046machine # [ 1.715472] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1047machine # [ 1.734947] ehci-pci 0000:00:1d.7: EHCI Host Controller1048machine # [ 1.735716] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11049machine # [ 1.737433] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001050machine # [ 1.745364] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001051machine # [ 1.751198] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181052machine # [ 1.753263] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11053machine # [ 1.754793] usb usb1: Product: EHCI Host Controller1054machine # [ 1.756285] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd1055machine # [ 1.757189] usb usb1: SerialNumber: 0000:00:1d.71056machine # [ 1.758408] hub 1-0:1.0: USB hub found1057machine # [ 1.760063] hub 1-0:1.0: 6 ports detected1058machine # [ 1.762507] uhci_hcd 0000:00:1d.0: UHCI Host Controller1059machine # [ 1.763241] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21060machine # [ 1.764282] uhci_hcd 0000:00:1d.0: detected 2 ports1061sshClient # [ 1.702616] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121062sshClient # [ 1.709432] virtio_blk virtio2: 1/0/0 default/read/poll queues1063sshClient # [ 1.710997] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1064sshClient # [ 1.715842] serio: i8042 KBD port at 0x60,0x64 irq 11065machine # [ 1.781081] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801066sshClient # [ 1.721208] serio: i8042 AUX port at 0x60,0x64 irq 121067sshClient # [ 1.728159] ehci-pci 0000:00:1d.7: EHCI Host Controller1068sshClient # [ 1.728906] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11069machine # [ 1.792514] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181070sshClient # [ 1.730684] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001071machine # [ 1.793726] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11072sshClient # [ 1.737776] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001073sshClient # [ 1.739568] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181074sshClient # [ 1.742491] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11075sshClient # [ 1.745316] usb usb1: Product: EHCI Host Controller1076machine # [ 1.808372] usb usb2: Product: UHCI Host Controller1077sshClient # [ 1.746084] usb usb1: Manufacturer: Linux 6.18.57 ehci_hcd1078machine # [ 1.809164] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd1079sshClient # [ 1.747703] usb usb1: SerialNumber: 0000:00:1d.71080machine # [ 1.668181] systemd[1]: Starting Virtual Console Setup...1081sshClient # [ 1.749389] hub 1-0:1.0: USB hub found1082sshClient # [ 1.750801] hub 1-0:1.0: 6 ports detected1083machine # [ 1.671302] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1084sshClient # [ 1.757868] uhci_hcd 0000:00:1d.0: UHCI Host Controller1085machine # [ 1.676311] (udev-worker)[86]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1086machine # [ 1.678377] (udev-worker)[86]: Network interface NamePolicy= disabled on kernel command line.1087machine # [ 1.826047] SCSI subsystem initialized1088machine # [ 1.830379] usb usb2: SerialNumber: 0000:00:1d.01089sshClient # [ 1.775751] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21090sshClient # [ 1.782147] uhci_hcd 0000:00:1d.0: detected 2 ports1091sshClient # [ 1.783998] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801092machine # [ 1.847398] hub 2-0:1.0: USB hub found1093sshClient # [ 1.789470] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181094sshClient # [ 1.790596] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11095machine # [ 1.709995] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1096machine # [ 1.855493] hub 2-0:1.0: 2 ports detected1097machine # [ 1.713410] systemd[1]: Finished Virtual Console Setup.1098machine # [ 1.725187] systemd[1]: Found device /dev/disk/by-label/nixos.1099machine # [ 1.727111] systemd[1]: Reached target Initrd Root Device.1100sshClient # [ 1.809271] usb usb2: Product: UHCI Host Controller1101sshClient # [ 1.809976] usb usb2: Manufacturer: Linux 6.18.57 uhci_hcd1102machine # [ 1.729896] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1103sshClient # [ 1.815103] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01104machine # [ 1.878212] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01105machine # [ 1.882608] uhci_hcd 0000:00:1d.1: UHCI Host Controller1106sshClient # [ 1.678343] systemd[1]: Starting Virtual Console Setup...1107machine # [ 1.883396] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31108sshClient # [ 1.828080] usb usb2: SerialNumber: 0000:00:1d.01109sshClient # [ 1.690241] (udev-worker)[84]: Network interface NamePolicy= disabled on kernel command line.1110machine # [ 1.897143] uhci_hcd 0000:00:1d.1: detected 2 ports1111machine # [ 1.898510] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01112sshClient # [ 1.837247] hub 2-0:1.0: USB hub found1113machine # [ 1.901661] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181114sshClient # [ 1.697390] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1115sshClient # [ 1.699319] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1116machine # [ 1.904373] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11117sshClient # [ 1.843282] hub 2-0:1.0: 2 ports detected1118machine # [ 1.906377] usb usb3: Product: UHCI Host Controller1119machine # [ 1.907096] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd1120machine # [ 1.910411] usb usb3: SerialNumber: 0000:00:1d.11121machine # [ 1.912402] hub 3-0:1.0: USB hub found1122sshClient # [ 1.853778] SCSI subsystem initialized1123machine # [ 1.916468] hub 3-0:1.0: 2 ports detected1124machine # [ 1.775786] systemd-fsck[103]: nixos: clean, 12/65536 files, 13019/262144 blocks1125sshClient # [ 1.860328] uhci_hcd 0000:00:1d.1: UHCI Host Controller1126machine # [ 1.923518] uhci_hcd 0000:00:1d.2: UHCI Host Controller1127sshClient # [ 1.861061] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31128machine # [ 1.928493] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41129machine # [ 1.930689] uhci_hcd 0000:00:1d.2: detected 2 ports1130machine # [ 1.789502] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1131machine # [ 1.934055] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01132machine # [ 1.936675] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181133machine # [ 1.939380] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11134sshClient # [ 1.735873] systemd-vconsole-setup[96]: Configuration of first virtual console was skipped, ignoring remaining ones.1135sshClient # [ 1.880655] uhci_hcd 0000:00:1d.1: detected 2 ports1136sshClient # [ 1.739947] systemd[1]: Finished Virtual Console Setup.1137machine # [ 1.945812] usb usb4: Product: UHCI Host Controller1138machine # [ 1.946819] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd1139sshClient # [ 1.744052] systemd[1]: Found device /dev/disk/by-label/nixos.1140machine # [ 1.950830] usb usb4: SerialNumber: 0000:00:1d.21141sshClient # [ 1.747169] systemd[1]: Reached target Initrd Root Device.1142machine # [ 1.952484] hub 4-0:1.0: USB hub found1143sshClient # [ 1.890962] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01144machine # [ 1.954556] hub 4-0:1.0: 2 ports detected1145sshClient # [ 1.892504] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181146sshClient # [ 1.893614] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11147sshClient # [ 1.753075] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1148sshClient # [ 1.900229] usb usb3: Product: UHCI Host Controller1149sshClient # [ 1.900919] usb usb3: Manufacturer: Linux 6.18.57 uhci_hcd1150sshClient # [ 1.903197] usb usb3: SerialNumber: 0000:00:1d.11151sshClient # [ 1.911288] hub 3-0:1.0: USB hub found1152sshClient # [ 1.913034] hub 3-0:1.0: 2 ports detected1153machine # [ 1.979681] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1154sshClient # [ 1.918253] uhci_hcd 0000:00:1d.2: UHCI Host Controller1155sshClient # [ 1.919150] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41156machine # [ 1.983266] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1157machine # [ 1.984145] ahci 0000:00:1f.2: flags: 64bit ncq only1158sshClient # [ 1.923738] uhci_hcd 0000:00:1d.2: detected 2 ports1159machine # [ 1.987370] scsi host0: ahci1160sshClient # [ 1.924890] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01161machine # [ 1.988943] scsi host1: ahci1162machine # [ 1.990101] scsi host2: ahci1163sshClient # [ 1.927394] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181164machine # [ 1.991627] scsi host3: ahci1165machine # [ 1.993062] scsi host4: ahci1166sshClient # [ 1.930444] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11167machine # [ 1.994269] scsi host5: ahci1168machine # [ 1.995745] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11169sshClient # [ 1.934814] usb usb4: Product: UHCI Host Controller1170machine # [ 1.997058] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11171machine # [ 1.998306] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11172sshClient # [ 1.936325] usb usb4: Manufacturer: Linux 6.18.57 uhci_hcd1173machine # [ 1.999487] usb 1-1: new high-speed USB device number 2 using ehci-pci1174sshClient # [ 1.937131] usb usb4: SerialNumber: 0000:00:1d.21175machine # [ 2.000698] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11176sshClient # [ 1.797286] systemd-fsck[104]: nixos: clean, 12/65536 files, 13019/262144 blocks1177machine # [ 2.001877] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11178machine # [ 2.003119] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11179sshClient # [ 1.941406] hub 4-0:1.0: USB hub found1180sshClient # [ 1.943755] hub 4-0:1.0: 2 ports detected1181sshClient # [ 1.969243] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1182sshClient # [ 1.970392] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1183sshClient # [ 1.971719] ahci 0000:00:1f.2: flags: 64bit ncq only1184sshClient # [ 1.974665] scsi host0: ahci1185sshClient # [ 1.976079] scsi host1: ahci1186sshClient # [ 1.977555] scsi host2: ahci1187sshClient # [ 1.979002] scsi host3: ahci1188sshClient # [ 1.980570] scsi host4: ahci1189sshClient # [ 1.981976] scsi host5: ahci1190sshClient # [ 1.983010] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11191sshClient # [ 1.984578] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11192sshClient # [ 1.985710] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11193sshClient # [ 1.986904] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11194sshClient # [ 1.988099] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11195sshClient # [ 1.989239] usb 1-1: new high-speed USB device number 2 using ehci-pci1196sshClient # [ 1.990372] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11197machine # [ 2.129425] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001198machine # [ 2.130802] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101199machine # [ 2.132137] usb 1-1: Product: QEMU USB Tablet1200machine # [ 2.132844] usb 1-1: Manufacturer: QEMU1201machine # [ 2.133469] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11202machine # [ 2.151795] hid: raw HID events driver (C) Jiri Kosina1203sshClient # [ 2.119250] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001204sshClient # [ 2.120428] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101205sshClient # [ 2.121757] usb 1-1: Product: QEMU USB Tablet1206sshClient # [ 2.122474] usb 1-1: Manufacturer: QEMU1207sshClient # [ 2.123052] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11208sshClient # [ 2.136669] hid: raw HID events driver (C) Jiri Kosina1209machine # [ 2.119268] systemd[1]: Mounting /sysroot...1210machine # [ 2.317169] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1211machine # [ 2.318116] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001212machine # [ 2.319111] ata3.00: applying bridge limits1213machine # [ 2.319828] ata3.00: configured for UDMA/1001214machine # [ 2.320594] ata5: SATA link down (SStatus 0 SControl 300)1215machine # [ 2.321498] ata1: SATA link down (SStatus 0 SControl 300)1216machine # [ 2.322354] ata2: SATA link down (SStatus 0 SControl 300)1217machine # [ 2.323209] ata6: SATA link down (SStatus 0 SControl 300)1218machine # [ 2.324218] ata4: SATA link down (SStatus 0 SControl 300)1219machine # [ 2.325372] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51220sshClient # [ 2.299802] ata4: SATA link down (SStatus 0 SControl 300)1221sshClient # [ 2.300723] ata6: SATA link down (SStatus 0 SControl 300)1222sshClient # [ 2.301753] ata5: SATA link down (SStatus 0 SControl 300)1223sshClient # [ 2.302678] ata1: SATA link down (SStatus 0 SControl 300)1224sshClient # [ 2.303571] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1225sshClient # [ 2.304570] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001226sshClient # [ 2.305397] ata3.00: applying bridge limits1227sshClient # [ 2.306088] ata2: SATA link down (SStatus 0 SControl 300)1228sshClient # [ 2.307018] ata3.00: configured for UDMA/1001229sshClient # [ 2.307984] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51230machine # [ 2.383567] usbcore: registered new interface driver usbhid1231machine # [ 2.384362] usbhid: USB HID core driver1232machine # [ 2.395200] 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/input21233sshClient # [ 2.335208] usbcore: registered new interface driver usbhid1234sshClient # [ 2.335968] usbhid: USB HID core driver1235machine # [ 2.398454] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1236machine # [ 2.400822] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01237sshClient # [ 2.343239] 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/input21238sshClient # [ 2.345006] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01239sshClient # [ 2.349550] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1240machine # [ 2.413333] cdrom: Uniform CD-ROM driver Revision: 3.201241sshClient # [ 2.360298] cdrom: Uniform CD-ROM driver Revision: 3.201242machine # [ 2.652579] EXT4-fs (vda): mounted filesystem 519a658d-5834-4480-9dfb-759708a7caa0 r/w with ordered data mode. Quota mode: none.1243sshClient # [ 2.451279] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1244machine # [ 2.517299] systemd[1]: Mounted /sysroot.1245machine # [ 2.520822] systemd[1]: Reached target Initrd Root File System.1246sshClient # [ 2.460324] systemd[1]: Mounting /sysroot...1247machine # [ 2.526744] systemd[1]: Mounting /sysroot/nix/.ro-store...1248machine # [ 2.533334] systemd[1]: Mounting /sysroot/nix/.rw-store...1249machine # [ 2.542313] systemd[1]: Mounting /sysroot/run...1250machine # [ 2.549262] systemd[1]: Mounting /sysroot/tmp/shared...1251machine # [ 2.563154] systemd[1]: Mounting /sysroot/tmp/xchg...1252machine # [ 2.571140] systemd[1]: Starting Mountpoints Configured in the Real Root...1253machine # [ 2.596561] systemd-sysroot-fstab-check[145]: /sysroot should be mounted in the initrd, will request daemon-reload.1254machine # [ 2.598472] systemd[1]: Mounted /sysroot/nix/.rw-store.1255machine # [ 2.602404] systemd[1]: Mounted /sysroot/nix/.ro-store.1256machine # [ 2.604125] systemd[1]: Mounted /sysroot/run.1257machine # [ 2.607747] systemd[1]: Mounted /sysroot/tmp/shared.1258machine # [ 2.608711] systemd[1]: Mounted /sysroot/tmp/xchg.1259sshClient # [ 2.690944] EXT4-fs (vda): mounted filesystem 3e3975f7-254d-45cf-8ea9-fdc74d5c537c r/w with ordered data mode. Quota mode: none.1260machine # [ 2.613107] systemd[1]: Starting rw-sysroot-nix-store.service...1261sshClient # [ 2.552147] systemd[1]: Mounted /sysroot.1262sshClient # [ 2.553519] systemd[1]: Reached target Initrd Root File System.1263machine # [ 2.615080] systemd[1]: Reload requested from client PID 145 ('systemd-sysroot') (unit initrd-parse-etc.service)...1264machine # [ 2.616474] systemd[1]: Reloading...1265sshClient # [ 2.555347] systemd[1]: Starting Mountpoints Configured in the Real Root...1266sshClient # [ 2.566845] systemd-sysroot-fstab-check[141]: /sysroot should be mounted in the initrd, will request daemon-reload.1267sshClient # [ 2.569625] systemd[1]: Reload requested from client PID 141 ('systemd-sysroot') (unit initrd-parse-etc.service)...1268sshClient # [ 2.571081] systemd[1]: Reloading...1269machine # [ 2.680170] systemd[1]: Reloading finished in 65 ms.1270sshClient # [ 2.626335] systemd[1]: Reloading finished in 54 ms.1271machine # [ 2.690212] systemd-sysroot-fstab-check[145]: Requesting initrd-fs.target/start/replace...1272machine # [ 2.692385] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1273machine # [ 2.693869] systemd[1]: Finished rw-sysroot-nix-store.service.1274sshClient # [ 2.634071] systemd-sysroot-fstab-check[141]: Requesting initrd-fs.target/start/replace...1275machine # [ 2.695857] systemd-sysroot-fstab-check[145]: Requesting swap.target/start/replace...1276sshClient # [ 2.636112] systemd-sysroot-fstab-check[141]: Requesting swap.target/start/replace...1277machine # [ 2.699316] systemd[1]: Starting rw-sysroot-nix-store.service...1278sshClient # [ 2.638813] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1279sshClient # [ 2.640086] systemd[1]: Finished Mountpoints Configured in the Real Root.1280machine # [ 2.701541] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1281machine # [ 2.702891] systemd[1]: Finished Mountpoints Configured in the Real Root.1282sshClient # [ 2.640995] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1283machine # [ 2.703898] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1284machine # [ 2.716132] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1285machine # [ 2.717184] systemd[1]: Finished rw-sysroot-nix-store.service.1286machine # [ 3.119484] systemd[1]: Mounting /sysroot/nix/store...1287machine # [ 3.141037] systemd[1]: Mounted /sysroot/nix/store.1288machine # [ 3.142379] systemd[1]: Reached target Initrd File Systems.1289machine # [ 3.143991] systemd[1]: Starting Find NixOS closure...1290machine # [ 3.146776] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1291machine # [ 3.167179] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1292machine # [ 3.169881] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1293machine # [ 3.175820] systemd[1]: Finished Find NixOS closure.1294machine # [ 3.177284] systemd[1]: Reached target Initrd Default Target.1295machine # [ 3.179086] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1296machine # [ 3.192620] systemd[1]: Stopped target Initrd Default Target.1297machine # [ 3.193899] systemd[1]: Stopped target Basic System.1298sshClient # [ 3.132129] systemd[1]: Mounting /sysroot/nix/.ro-store...1299machine # [ 3.194822] systemd[1]: Stopped target Initrd Root Device.1300machine # [ 3.195854] systemd[1]: Stopped target Path Units.1301machine # [ 3.197111] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1302machine # [ 3.198187] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1303machine # [ 3.199257] systemd[1]: Stopped target Slice Units.1304machine # [ 3.200281] systemd[1]: Stopped target Socket Units.1305machine # [ 3.201470] systemd[1]: Stopped target System Initialization.1306sshClient # [ 3.139229] systemd[1]: Mounting /sysroot/nix/.rw-store...1307machine # [ 3.202495] systemd[1]: Stopped target Swaps.1308machine # [ 3.203511] systemd[1]: Stopped target Timer Units.1309machine # [ 3.204493] systemd[1]: dbus.socket: Deactivated successfully.1310machine # [ 3.205623] systemd[1]: Closed D-Bus System Message Bus Socket.1311machine # [ 3.207133] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1312machine # [ 3.208172] systemd[1]: Stopped Find NixOS closure.1313machine # [ 3.210248] systemd[1]: Starting rw-sysroot-nix-store.service...1314sshClient # [ 3.148156] systemd[1]: Mounting /sysroot/run...1315machine # [ 3.211219] systemd[1]: systemd-sysctl.service: Deactivated successfully.1316machine # [ 3.213092] systemd[1]: Stopped Apply Kernel Variables.1317machine # [ 3.213807] systemd[1]: systemd-modules-load.service: Deactivated successfully.1318machine # [ 3.214741] systemd[1]: Stopped Load Kernel Modules.1319machine # [ 3.216162] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1320machine # [ 3.217522] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1321sshClient # [ 3.156303] systemd[1]: Mounting /sysroot/tmp/shared...1322machine # [ 3.218648] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1323machine # [ 3.219610] systemd[1]: Stopped Create System Files and Directories.1324machine # [ 3.221986] systemd[1]: Stopped target Local File Systems.1325machine # [ 3.223615] systemd[1]: Stopped target Preparation for Local File Systems.1326machine # [ 3.224516] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1327machine # [ 3.225469] systemd[1]: Stopped Coldplug All udev Devices.1328sshClient # [ 3.164575] systemd[1]: Mounting /sysroot/tmp/xchg...1329machine # [ 3.229627] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1330machine # [ 3.230675] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1331machine # [ 3.231724] systemd[1]: Stopped Virtual Console Setup.1332machine # [ 3.239302] systemd[1]: initrd-cleanup.service: Deactivated successfully.1333machine # [ 3.242171] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1334machine # [ 3.243212] systemd[1]: systemd-udevd.service: Deactivated successfully.1335machine # [ 3.245025] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1336machine # [ 3.245968] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1337machine # [ 3.246986] systemd[1]: Finished rw-sysroot-nix-store.service.1338machine # [ 3.250379] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.1339machine # [ 3.252095] systemd[1]: Closed udev Varlink Socket.1340machine # [ 3.253328] systemd[1]: Starting Cleanup udev Database...1341machine # [ 3.254184] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1342machine # [ 3.256215] systemd[1]: Stopped Create Static Device Nodes in /dev.1343machine # [ 3.257247] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1344machine # [ 3.258483] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1345machine # [ 3.259517] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1346machine # [ 3.260562] systemd[1]: Stopped Create List of Static Device Nodes.1347sshClient # [ 3.201325] systemd[1]: Mounted /sysroot/nix/.rw-store.1348sshClient # [ 3.208247] systemd[1]: Mounted /sysroot/nix/.ro-store.1349sshClient # [ 3.209519] systemd[1]: Mounted /sysroot/run.1350machine # [ 3.275874] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1351machine # [ 3.277557] systemd[1]: Finished Cleanup udev Database.1352machine # [ 3.278636] systemd[1]: Reached target Switch Root.1353sshClient # [ 3.217311] systemd[1]: Mounted /sysroot/tmp/shared.1354machine # [ 3.280166] systemd[1]: Starting NixOS Activation...1355sshClient # [ 3.219872] systemd[1]: Mounted /sysroot/tmp/xchg.1356sshClient # [ 3.223978] systemd[1]: Starting rw-sysroot-nix-store.service...1357sshClient # [ 3.234946] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1358sshClient # [ 3.236593] systemd[1]: Finished rw-sysroot-nix-store.service.1359sshClient # [ 3.239182] systemd[1]: Mounting /sysroot/nix/store...1360sshClient # [ 3.262209] systemd[1]: Mounted /sysroot/nix/store.1361sshClient # [ 3.263451] systemd[1]: Reached target Initrd File Systems.1362sshClient # [ 3.265140] systemd[1]: Starting Find NixOS closure...1363sshClient # [ 3.267672] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1364machine # [ 3.337722] initrd-nixos-activation-start[190]: booting system configuration /nix/store/zmx98gb89cd96rbwl8jahlsx2sni6i5s-nixos-system-machine-test1365sshClient # [ 3.288390] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1366sshClient # [ 3.296423] systemd[1]: Finished Find NixOS closure.1367sshClient # [ 3.298197] systemd[1]: Reached target Initrd Default Target.1368sshClient # [ 3.299946] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1369machine # [ 3.362132] initrd-nixos-activation-start[190]: running activation script...1370sshClient # [ 3.315897] systemd[1]: Stopped target Initrd Default Target.1371sshClient # [ 3.317402] systemd[1]: Stopped target Basic System.1372sshClient # [ 3.319266] systemd[1]: Stopped target Initrd Root Device.1373sshClient # [ 3.320106] systemd[1]: Stopped target Path Units.1374sshClient # [ 3.320890] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1375sshClient # [ 3.322108] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1376sshClient # [ 3.323380] systemd[1]: Stopped target Slice Units.1377sshClient # [ 3.324431] systemd[1]: Stopped target Socket Units.1378sshClient # [ 3.325736] systemd[1]: Stopped target System Initialization.1379sshClient # [ 3.326907] systemd[1]: Stopped target Swaps.1380sshClient # [ 3.327907] systemd[1]: Stopped target Timer Units.1381sshClient # [ 3.329210] systemd[1]: dbus.socket: Deactivated successfully.1382sshClient # [ 3.331029] systemd[1]: Closed D-Bus System Message Bus Socket.1383sshClient # [ 3.332026] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1384sshClient # [ 3.333228] systemd[1]: Stopped Find NixOS closure.1385sshClient # [ 3.334420] systemd[1]: Starting rw-sysroot-nix-store.service...1386sshClient # [ 3.336201] systemd[1]: systemd-sysctl.service: Deactivated successfully.1387sshClient # [ 3.337527] systemd[1]: Stopped Apply Kernel Variables.1388sshClient # [ 3.339126] systemd[1]: systemd-modules-load.service: Deactivated successfully.1389sshClient # [ 3.340126] systemd[1]: Stopped Load Kernel Modules.1390sshClient # [ 3.340976] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1391sshClient # [ 3.342122] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1392sshClient # [ 3.344129] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1393sshClient # [ 3.345173] systemd[1]: Stopped Create System Files and Directories.1394sshClient # [ 3.346318] systemd[1]: Stopped target Local File Systems.1395sshClient # [ 3.347343] systemd[1]: Stopped target Preparation for Local File Systems.1396sshClient # [ 3.348625] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1397sshClient # [ 3.350207] systemd[1]: Stopped Coldplug All udev Devices.1398sshClient # [ 3.351652] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1399sshClient # [ 3.353447] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1400sshClient # [ 3.354526] systemd[1]: Stopped Virtual Console Setup.1401sshClient # [ 3.363172] systemd[1]: initrd-cleanup.service: Deactivated successfully.1402sshClient # [ 3.368243] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1403sshClient # [ 3.370872] systemd[1]: systemd-udevd.service: Deactivated successfully.1404sshClient # [ 3.373141] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1405sshClient # [ 3.378109] systemd[1]: systemd-udevd-varlink.socket: Deactivated successfully.1406sshClient # [ 3.379124] systemd[1]: Closed udev Varlink Socket.1407sshClient # [ 3.380654] systemd[1]: Starting Cleanup udev Database...1408sshClient # [ 3.381463] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1409sshClient # [ 3.383157] systemd[1]: Stopped Create Static Device Nodes in /dev.1410sshClient # [ 3.384091] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1411sshClient # [ 3.385165] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1412sshClient # [ 3.386108] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1413sshClient # [ 3.388129] systemd[1]: Stopped Create List of Static Device Nodes.1414sshClient # [ 3.389447] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1415sshClient # [ 3.391115] systemd[1]: Finished rw-sysroot-nix-store.service.1416sshClient # [ 3.406206] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1417sshClient # [ 3.407774] systemd[1]: Finished Cleanup udev Database.1418sshClient # [ 3.409274] systemd[1]: Reached target Switch Root.1419sshClient # [ 3.410948] systemd[1]: Starting NixOS Activation...1420machine # [ 3.536467] initrd-nixos-activation-start[213]: setting up /etc...1421sshClient # [ 3.476129] initrd-nixos-activation-start[189]: booting system configuration /nix/store/9vjxxpk7pd8ccv8gnscd9f08xblncx9k-nixos-system-sshClient-test1422sshClient # [ 3.502339] initrd-nixos-activation-start[189]: running activation script...1423machine # [ 3.646607] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1424machine # [ 3.648967] systemd[1]: Finished NixOS Activation.1425machine # [ 3.650137] systemd[1]: Starting Switch Root...1426machine # [ 3.662885] systemd[1]: Switching root.1427sshClient # [ 3.686357] initrd-nixos-activation-start[212]: setting up /etc...1428machine # [ 3.929138] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1429machine # [ 3.988217] NET: Registered PF_VSOCK protocol family1430sshClient # [ 3.790981] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1431sshClient # [ 3.792593] systemd[1]: Finished NixOS Activation.1432sshClient # [ 3.794496] systemd[1]: Starting Switch Root...1433sshClient # [ 3.807073] systemd[1]: Switching root.1434machine # [ 4.010122] systemd[1]: systemd 263-cb90bff 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)1435machine # [ 4.014190] systemd[1]: Detected virtualization kvm.1436machine # [ 4.014886] systemd[1]: Detected architecture x86-64.1437machine # [ 4.015613] systemd[1]: Detected first boot.1438machine # [ 4.017346] systemd[1]: Initializing machine ID from random generator.1439machine # [ 4.104732] systemd[1]: bpf-restrict-fs: LSM BPF program attached1440sshClient # [ 4.074884] systemd-journald[65]: Received SIGTERM from PID 1 (systemd).1441machine # [ 4.191642] systemd[1]: Applying preset policy.1442sshClient # [ 4.149314] NET: Registered PF_VSOCK protocol family1443sshClient # [ 4.172198] systemd[1]: systemd 263-cb90bff 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)1444sshClient # [ 4.176275] systemd[1]: Detected virtualization kvm.1445sshClient # [ 4.177034] systemd[1]: Detected architecture x86-64.1446sshClient # [ 4.177767] systemd[1]: Detected first boot.1447sshClient # [ 4.179547] systemd[1]: Initializing machine ID from random generator.1448sshClient # [ 4.267870] systemd[1]: bpf-restrict-fs: LSM BPF program attached1449machine # [ 4.362391] systemd[1]: Populated /etc with preset unit settings.1450sshClient # [ 4.350671] systemd[1]: Applying preset policy.1451machine # [ 4.541449] systemd[1]: initrd-switch-root.service: Deactivated successfully.1452machine # [ 4.542819] systemd[1]: Stopped initrd-switch-root.service.1453machine # [ 4.544817] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1454machine # [ 4.546892] systemd[1]: Created slice Slice /system/getty.1455machine # [ 4.548213] systemd[1]: Created slice User and Session Slice.1456machine # [ 4.549187] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1457machine # [ 4.550453] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1458machine # [ 4.551586] systemd[1]: Expecting device /dev/hvc0...1459machine # [ 4.552286] systemd[1]: Expecting device /dev/ttyS0...1460machine # [ 4.553070] systemd[1]: Reached target Local Encrypted Volumes.1461machine # [ 4.553917] systemd[1]: Stopped target initrd-fs.target.1462machine # [ 4.554685] systemd[1]: Stopped target initrd-root-fs.target.1463machine # [ 4.555484] systemd[1]: Stopped target initrd-switch-root.target.1464machine # [ 4.567922] systemd[1]: Reached target Virtual Machines and Containers.1465machine # [ 4.568881] systemd[1]: Reached target Path Units.1466machine # [ 4.569608] systemd[1]: Reached target Remote File Systems.1467machine # [ 4.570416] systemd[1]: Reached target Slice Units.1468sshClient # [ 4.507694] systemd[1]: Populated /etc with preset unit settings.1469machine # [ 4.571140] systemd[1]: Reached target Swaps.1470machine # [ 4.572674] systemd[1]: Listening on Query the User Interactively for a Password.1471machine # [ 4.574745] systemd[1]: Listening on Process Core Dump Socket.1472machine # [ 4.576260] systemd[1]: Listening on Credential Encryption/Decryption.1473machine # [ 4.577871] systemd[1]: Listening on Factory Reset Management.1474machine # [ 4.578769] systemd[1]: Listening on Hostname Service Socket.1475machine # [ 4.581155] systemd[1]: Starting Journal Log Access Socket...1476machine # [ 4.582625] systemd[1]: Listening on Journal Audit Socket.1477machine # [ 4.585075] systemd[1]: Listening on Console Output Muting Service Socket.1478machine # [ 4.586197] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1479machine # [ 4.587364] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1480machine # [ 4.588676] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1481machine # [ 4.591967] systemd[1]: Listening on Disk Repartitioning Service Socket.1482machine # [ 4.592974] systemd[1]: Listening on udev Varlink Socket.1483machine # [ 4.593828] systemd[1]: Listening on User Database Manager Socket.1484machine # [ 4.596030] systemd[1]: Mounting Huge Pages File System...1485machine # [ 4.599715] systemd[1]: Mounting POSIX Message Queue File System...1486machine # [ 4.606397] systemd[1]: Mounting Kernel Debug File System...1487machine # [ 4.612622] systemd[1]: Mounting Kernel Trace File System...1488machine # [ 4.622171] systemd[1]: Starting Create List of Static Device Nodes...1489machine # [ 4.634666] systemd[1]: Starting Load Kernel Module configfs...1490machine # [ 4.640935] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1491machine # [ 4.652438] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1492machine # [ 4.659214] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1493machine # [ 4.668721] systemd[1]: Mounting FUSE Control File System...1494machine # [ 4.675430] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671495machine # [ 4.689219] systemd[1]: Starting Journal Service...1496machine # [ 4.694507] systemd[1]: Starting Load Kernel Modules...1497machine # [ 4.702954] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1498machine # [ 4.707907] systemd[1]: Starting Remount Root and Kernel File Systems...1499machine # [ 4.713577] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1500machine # [ 4.726030] systemd[1]: Starting Coldplug All udev Devices...1501machine # [ 4.736638] systemd[1]: Listening on Journal Log Access Socket.1502sshClient # [ 4.676266] systemd[1]: initrd-switch-root.service: Deactivated successfully.1503sshClient # [ 4.677564] systemd[1]: Stopped initrd-switch-root.service.1504machine # [ 4.740484] systemd[1]: Mounted Huge Pages File System.1505sshClient # [ 4.679611] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1506sshClient # [ 4.681651] systemd[1]: Created slice Slice /system/getty.1507sshClient # [ 4.682921] systemd[1]: Created slice User and Session Slice.1508sshClient # [ 4.683839] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1509machine # [ 4.747636] systemd[1]: Mounted POSIX Message Queue File System.1510sshClient # [ 4.685039] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1511sshClient # [ 4.686136] systemd[1]: Expecting device /dev/hvc0...1512sshClient # [ 4.686872] systemd[1]: Expecting device /dev/ttyS0...1513sshClient # [ 4.687627] systemd[1]: Reached target Local Encrypted Volumes.1514sshClient # [ 4.688445] systemd[1]: Stopped target initrd-fs.target.1515sshClient # [ 4.689202] systemd[1]: Stopped target initrd-root-fs.target.1516machine # [ 4.753698] systemd[1]: Mounted Kernel Debug File System.1517machine # [ 4.756842] systemd[1]: Mounted Kernel Trace File System.1518machine # [ 4.758561] systemd-journald[284]: Collecting audit messages is enabled.1519sshClient # [ 4.689966] systemd[1]: Stopped target initrd-switch-root.target.1520sshClient # [ 4.702006] systemd[1]: Reached target Virtual Machines and Containers.1521sshClient # [ 4.702919] systemd[1]: Reached target Path Units.1522machine # [ 4.766055] systemd[1]: Finished Create List of Static Device Nodes.1523sshClient # [ 4.703621] systemd[1]: Reached target Remote File Systems.1524sshClient # [ 4.704384] systemd[1]: Reached target Slice Units.1525sshClient # [ 4.705086] systemd[1]: Reached target Swaps.1526sshClient # [ 4.706721] systemd[1]: Listening on Query the User Interactively for a Password.1527sshClient # [ 4.709002] systemd[1]: Listening on Process Core Dump Socket.1528sshClient # [ 4.710645] systemd[1]: Listening on Credential Encryption/Decryption.1529machine # [ 4.773843] systemd[1]: modprobe@configfs.service: Deactivated successfully.1530sshClient # [ 4.712329] systemd[1]: Listening on Factory Reset Management.1531sshClient # [ 4.713265] systemd[1]: Listening on Hostname Service Socket.1532sshClient # [ 4.715811] systemd[1]: Starting Journal Log Access Socket...1533sshClient # [ 4.717251] systemd[1]: Listening on Journal Audit Socket.1534machine # [ 4.780273] systemd[1]: Finished Load Kernel Module configfs.1535machine # [ 4.781379] EXT4-fs (vda): re-mounted 519a658d-5834-4480-9dfb-759708a7caa0.1536sshClient # [ 4.719447] systemd[1]: Listening on Console Output Muting Service Socket.1537machine # [ 4.783475] loop: module loaded1538sshClient # [ 4.720577] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1539sshClient # [ 4.722064] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1540sshClient # [ 4.723365] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1541machine # [ 4.646733] systemd[1]: Queued start job for default target Multi-User System.1542sshClient # [ 4.728271] systemd[1]: Listening on Disk Repartitioning Service Socket.1543sshClient # [ 4.729320] systemd[1]: Listening on udev Varlink Socket.1544sshClient # [ 4.730190] systemd[1]: Listening on User Database Manager Socket.1545machine # [ 4.650075] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.1546machine # [ 4.651555] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.1547sshClient # [ 4.732537] systemd[1]: Mounting Huge Pages File System...1548sshClient # [ 4.734848] systemd[1]: Mounting POSIX Message Queue File System...1549machine # [ 4.654354] systemd[1]: systemd-journald.service: Deactivated successfully.1550machine # [ 4.798989] systemd[1]: Mounting Kernel Configuration File System...1551machine # [ 4.656961] systemd-modules-load[285]: Inserted module 'loop'1552sshClient # [ 4.740711] systemd[1]: Mounting Kernel Debug File System...1553machine # [ 4.805405] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1554machine # [ 4.808768] systemd[1]: Started Journal Service.1555machine # [ 4.668039] systemd[1]: Mounted FUSE Control File System.1556sshClient # [ 4.749498] systemd[1]: Mounting Kernel Trace File System...1557machine # [ 4.671063] systemd[1]: Finished Load Kernel Modules.1558sshClient # [ 4.757988] systemd[1]: Starting Create List of Static Device Nodes...1559machine # [ 4.680215] systemd[1]: Finished Remount Root and Kernel File Systems.1560sshClient # [ 4.771465] systemd[1]: Starting Load Kernel Module configfs...1561sshClient # [ 4.777558] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1562machine # [ 4.704233] systemd[1]: Listening on Disk Image Download Service Socket.1563machine # [ 4.707617] systemd[1]: Starting Firewall...1564machine # [ 4.711781] systemd[1]: Starting Flush Journal to Persistent Storage...1565sshClient # [ 4.792114] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1566machine # [ 4.712719] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1567machine # [ 4.714446] systemd-oomd[286]: No swap; memory pressure usage will be degraded1568sshClient # [ 4.798038] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1569machine # [ 4.721350] systemd[1]: Starting Load/Save OS Random Seed...1570sshClient # [ 4.809141] systemd[1]: Mounting FUSE Control File System...1571sshClient # [ 4.811945] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671572machine # [ 4.738185] systemd[1]: Starting Apply Kernel Variables...1573machine # [ 4.739024] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1574machine # [ 4.746837] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1575sshClient # [ 4.828831] systemd[1]: Starting Journal Service...1576sshClient # [ 4.836259] systemd[1]: Starting Load Kernel Modules...1577sshClient # [ 4.845103] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1578sshClient # [ 4.857256] systemd[1]: Starting Remount Root and Kernel File Systems...1579sshClient # [ 4.863288] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1580sshClient # [ 4.872493] systemd[1]: Starting Coldplug All udev Devices...1581machine # [ 4.940993] systemd-journald[284]: Received client request to flush runtime journal.1582sshClient # [ 4.883418] systemd[1]: Listening on Journal Log Access Socket.1583sshClient # [ 4.888691] systemd[1]: Mounted Huge Pages File System.1584sshClient # [ 4.891387] systemd-journald[283]: Collecting audit messages is enabled.1585sshClient # [ 4.892852] systemd[1]: Mounted POSIX Message Queue File System.1586sshClient # [ 4.897747] systemd[1]: Mounted Kernel Debug File System.1587sshClient # [ 4.904787] systemd[1]: Mounted Kernel Trace File System.1588sshClient # [ 4.909868] systemd[1]: Finished Create List of Static Device Nodes.1589sshClient # [ 4.919673] systemd[1]: modprobe@configfs.service: Deactivated successfully.1590sshClient # [ 4.784350] systemd[1]: Queued start job for default target Multi-User System.1591sshClient # [ 4.785735] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.1592sshClient # [ 4.929539] systemd[1]: Finished Load Kernel Module configfs.1593sshClient # [ 4.930899] loop: module loaded1594sshClient # [ 4.789834] systemd[1]: Unnecessary job was removed for /sys/devices/pnp0/00:03/00:03:0/00:03:0.0/tty/ttyS0.1595sshClient # [ 4.791640] systemd[1]: systemd-journald.service: Deactivated successfully.1596sshClient # [ 4.795465] systemd-modules-load[284]: Inserted module 'loop'1597sshClient # [ 4.940734] systemd[1]: Started Journal Service.1598sshClient # [ 4.810196] systemd[1]: Finished Load Kernel Modules.1599sshClient # [ 4.815150] systemd[1]: Mounted FUSE Control File System.1600sshClient # [ 4.963240] EXT4-fs (vda): re-mounted 3e3975f7-254d-45cf-8ea9-fdc74d5c537c.1601machine # [ 4.888592] systemd[1]: Mounted Kernel Configuration File System.1602machine # [ 4.891429] systemd[1]: Finished Load/Save OS Random Seed.1603machine # [ 4.893382] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1604sshClient # [ 4.834441] systemd[1]: Mounting Kernel Configuration File System...1605machine # [ 4.896131] systemd[1]: Starting Create Static Device Nodes in /dev...1606machine # [ 4.896983] systemd[1]: Finished Apply Kernel Variables.1607machine # [ 4.898499] systemd[1]: Finished Flush Journal to Persistent Storage.1608sshClient # [ 4.840063] systemd[1]: Starting Firewall...1609sshClient # [ 4.851071] systemd[1]: Starting Apply Kernel Variables...1610sshClient # [ 4.858231] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1611sshClient # [ 4.867605] systemd[1]: Finished Remount Root and Kernel File Systems.1612sshClient # [ 4.874853] systemd-oomd[285]: No swap; memory pressure usage will be degraded1613sshClient # [ 4.879157] systemd[1]: Listening on Disk Image Download Service Socket.1614sshClient # [ 4.890077] systemd[1]: Starting Flush Journal to Persistent Storage...1615sshClient # [ 4.891065] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1616sshClient # [ 4.901514] systemd[1]: Starting Load/Save OS Random Seed...1617sshClient # [ 4.902541] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1618sshClient # [ 4.915682] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1619machine # [ 4.993365] systemd[1]: Finished Coldplug All udev Devices.1620machine # [ 5.007263] systemd[1]: Finished Create Static Device Nodes in /dev.1621machine # [ 5.008470] systemd[1]: Reached target Preparation for Local File Systems.1622machine # [ 5.011512] systemd[1]: Starting Rule-based Manager for Device Events and Files...1623sshClient # [ 4.975230] systemd[1]: Mounted Kernel Configuration File System.1624sshClient # [ 5.121789] systemd-journald[283]: Received client request to flush runtime journal.1625machine # [ 5.054570] systemd-udevd[323]: Using default interface naming scheme 'v261'.1626machine # [ 5.072992] systemd[1]: Starting User Database Manager...1627machine # [ 5.112139] systemd[1]: Started User Database Manager.1628sshClient # [ 5.065442] systemd[1]: Finished Load/Save OS Random Seed.1629sshClient # [ 5.069834] systemd[1]: Finished Apply Kernel Variables.1630sshClient # [ 5.071131] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1631sshClient # [ 5.072864] systemd[1]: Starting Create Static Device Nodes in /dev...1632sshClient # [ 5.075407] systemd[1]: Finished Flush Journal to Persistent Storage.1633machine # [ 5.162095] systemd[1]: Started Rule-based Manager for Device Events and Files.1634sshClient # [ 5.155421] systemd[1]: Finished Coldplug All udev Devices.1635machine # [ 5.222307] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1636sshClient # [ 5.163141] systemd[1]: Finished Create Static Device Nodes in /dev.1637sshClient # [ 5.164659] systemd[1]: Reached target Preparation for Local File Systems.1638sshClient # [ 5.167678] systemd[1]: Starting Rule-based Manager for Device Events and Files...1639sshClient # [ 5.211959] systemd-udevd[324]: Using default interface naming scheme 'v261'.1640sshClient # [ 5.230278] systemd[1]: Starting User Database Manager...1641machine # [ 5.312135] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1642machine # [ 5.314086] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1643sshClient # [ 5.268092] systemd[1]: Started User Database Manager.1644machine # [ 5.344681] (udev-worker)[358]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1645machine # [ 5.346956] (udev-worker)[358]: Network interface NamePolicy= disabled on kernel command line.1646machine # [ 5.354581] (udev-worker)[356]: Network interface NamePolicy= disabled on kernel command line.1647sshClient # [ 5.319579] systemd[1]: Started Rule-based Manager for Device Events and Files.1648machine # [ 5.402192] systemd[1]: Mounting /run/wrappers...1649sshClient # [ 5.374728] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1650machine # [ 5.445216] systemd[1]: Mounted /run/wrappers.1651machine # [ 5.446294] systemd[1]: Reached target Local File Systems.1652machine # [ 5.452717] systemd[1]: Listening on Boot Loader Control Service Socket.1653machine # [ 5.456103] systemd[1]: Starting Create SUID/SGID Wrappers...1654machine # [ 5.456941] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1655machine # [ 5.461574] systemd[1]: Starting Create System Files and Directories...1656machine # [ 5.477324] systemd[1]: Condition check resulted in Virtio network device being skipped.1657machine # [ 5.478435] systemd[1]: Condition check resulted in Virtio network device being skipped.1658machine # [ 5.479475] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1659machine # [ 5.480820] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1660machine # [ 5.483739] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671661machine # [ 5.486825] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1662machine # [ 5.488850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1663machine # [ 5.492511] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1664sshClient # [ 5.469288] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1665sshClient # [ 5.478789] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1666sshClient # [ 5.500760] (udev-worker)[357]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1667sshClient # [ 5.502878] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line.1668sshClient # [ 5.505145] (udev-worker)[356]: Network interface NamePolicy= disabled on kernel command line.1669machine # [ 5.587458] systemd[1]: Finished Create System Files and Directories.1670machine # [ 5.595993] systemd[1]: Starting Rebuild Journal Catalog...1671sshClient # [ 5.537985] systemd[1]: Mounting /run/wrappers...1672machine # [ 5.601655] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1673sshClient # [ 5.574554] systemd[1]: Mounted /run/wrappers.1674sshClient # [ 5.576073] systemd[1]: Reached target Local File Systems.1675sshClient # [ 5.580085] systemd[1]: Listening on Boot Loader Control Service Socket.1676sshClient # [ 5.584438] systemd[1]: Starting Create SUID/SGID Wrappers...1677sshClient # [ 5.585292] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1678sshClient # [ 5.589580] systemd[1]: Starting Create System Files and Directories...1679machine # [ 5.667241] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1680machine # [ 5.818004] mousedev: PS/2 mouse device common for all mice1681machine # [ 5.696093] systemd[1]: Finished Rebuild Journal Catalog.1682machine # [ 5.700713] systemd[1]: Starting Update is Completed...1683sshClient # [ 5.656031] systemd[1]: Condition check resulted in Virtio network device being skipped.1684sshClient # [ 5.660865] systemd[1]: Condition check resulted in Virtio network device being skipped.1685sshClient # [ 5.662121] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1686sshClient # [ 5.663672] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1687sshClient # [ 5.665045] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671688sshClient # [ 5.667275] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1689sshClient # [ 5.669826] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1690sshClient # [ 5.672133] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1691machine # [ 5.747102] systemd[1]: Finished Update is Completed.1692sshClient # [ 5.703593] systemd[1]: Finished Create System Files and Directories.1693sshClient # [ 5.714073] systemd[1]: Starting Rebuild Journal Catalog...1694sshClient # [ 5.717036] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1695machine # [ 5.962916] rtc_cmos PNP0B00:00: RTC can wake from S41696sshClient # [ 5.795657] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1697machine # [ 6.000743] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1698machine # [ 6.008049] parport_pc 00:02: reported by Plug and Play ACPI1699machine # [ 6.009366] rtc_cmos PNP0B00:00: registered as rtc01700machine # [ 6.010121] rtc_cmos PNP0B00:00: setting system clock to 2026-10-21T03:09:07 UTC (1792552147)1701machine # [ 6.011703] systemd-journald[284]: Time jumped backwards, rotating.1702sshClient # [ 5.829756] systemd[1]: Finished Rebuild Journal Catalog.1703sshClient # [ 5.836161] systemd[1]: Starting Update is Completed...1704sshClient # [ 5.999583] mousedev: PS/2 mouse device common for all mice1705sshClient # [ 5.878901] systemd[1]: Finished Update is Completed.1706machine # [ 5.958342] systemd[1]: Finished Firewall.1707sshClient # [ 6.062137] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1708machine # [ 6.024305] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1709machine # [ 6.025897] systemd[1]: Finished Create SUID/SGID Wrappers.1710machine # [ 6.027968] systemd[1]: Reached target System Initialization.1711machine # [ 6.030550] systemd[1]: Started Discard unused filesystem blocks once a week.1712machine # [ 6.031863] systemd[1]: Started Daily Cleanup of Temporary Directories.1713machine # [ 6.034488] systemd[1]: Reached target Timer Units.1714machine # [ 6.035340] systemd[1]: Listening on D-Bus System Message Bus Socket.1715machine # [ 6.036701] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1716machine # [ 6.038451] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1717machine # [ 6.039717] systemd[1]: Reached target Socket Units.1718machine # [ 6.040987] systemd[1]: Reached target Basic System.1719machine # [ 6.042832] systemd[1]: Started backdoor.service.1720machine # [ 6.047938] systemd[1]: Starting Import lastlog data into lastlog2 database...1721machine # [ 6.054332] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1722machine # [ 6.067629] systemd[1]: Starting Post-Boot Actions...1723machine # [ 6.076592] systemd[1]: Started Reset console on configuration changes.1724machine # [ 6.093516] systemd[1]: Starting resolvconf update...1725sshClient # [ 6.043841] systemd[1]: Finished Firewall.1726machine # [ 6.106674] systemd[1]: Starting SSH Host Keys Generation...1727machine # [ 6.049158] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input31728machine # [ 6.053100] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1729machine # [ 6.077539] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1730machine # connecting to host...1731machine # [ 6.154161] systemd[1]: Starting Home Area Manager...1732machine # [ 6.168287] systemd[1]: Finished Post-Boot Actions.1733sshClient # [ 6.110123] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1734sshClient # [ 6.117784] systemd[1]: Finished Create SUID/SGID Wrappers.1735sshClient # [ 6.119513] systemd[1]: Reached target System Initialization.1736sshClient # [ 6.122224] systemd[1]: Started Discard unused filesystem blocks once a week.1737machine # [ 6.185281] nsncd[514]: Oct 21 03:09:07.817 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1738sshClient # [ 6.125722] systemd[1]: Started Daily Cleanup of Temporary Directories.1739sshClient # [ 6.128305] systemd[1]: Reached target Timer Units.1740sshClient # [ 6.130258] systemd[1]: Listening on D-Bus System Message Bus Socket.1741machine # [ 6.193061] systemd[1]: Started Name Service Cache Daemon (nsncd).1742machine: Guest shell says: b'Spawning backdoor root shell...\n'1743sshClient # [ 6.134093] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1744sshClient # [ 6.135439] systemd[1]: Reached target Socket Units.1745machine # [ 6.090348] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1746machine: connected to guest root shell1747machine # [ 6.150977] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1748machine: (connecting took 6.88 seconds)1749sshClient # [ 6.136753] systemd[1]: Reached target Basic System.1750machine: (finished: waiting for the VM to finish booting, in 6.88 seconds)1751sshClient # [ 6.139191] systemd[1]: Started backdoor.service.1752machine # [ 6.151090] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1753sshClient # [ 6.139891] systemd[1]: Starting Import lastlog data into lastlog2 database...1754sshClient # [ 6.141625] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1755sshClient # [ 6.143148] systemd[1]: Starting Post-Boot Actions...1756sshClient # [ 6.143886] systemd[1]: Started Reset console on configuration changes.1757sshClient # [ 6.150985] systemd[1]: Starting resolvconf update...1758machine # [ 6.219455] systemd[1]: Reached target Host and Network Name Lookups.1759machine # [ 6.224120] systemd[1]: Reached target User and Group Name Lookups.1760sshClient # [ 6.164496] systemd[1]: Starting Home Area Manager...1761machine # [ 6.236213] systemd[1]: Starting D-Bus System Message Bus...1762machine # [ 6.255746] systemd[1]: Starting User Login Management...1763sshClient # [ 6.201223] systemd[1]: Starting D-Bus System Message Bus...1764machine # [ 6.257472] Console: switching to colour dummy device 80x251765machine # [ 6.288357] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51766machine # [ 6.291756] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input41767sshClient # [ 6.219303] systemd[1]: Finished Post-Boot Actions.1768sshClient # connecting to host...1769machine # [ 6.295039] systemd[1]: Starting Virtual Console Setup...1770sshClient # [ 6.236645] nsncd[505]: Oct 21 03:09:07.670 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1771sshClient # [ 6.242118] systemd[1]: Started Name Service Cache Daemon (nsncd).1772machine # [ 6.305329] systemd[1]: Finished Import lastlog data into lastlog2 database.1773machine # [ 6.326267] systemd-homed[525]: Watching /home.1774sshClient # [ 6.272759] systemd[1]: Reached target Host and Network Name Lookups.1775sshClient # [ 6.275056] systemd[1]: Reached target User and Group Name Lookups.1776sshClient # [ 6.190657] rtc_cmos PNP0B00:00: RTC can wake from S41777sshClient # [ 6.197141] rtc_cmos PNP0B00:00: registered as rtc01778machine # [ 6.491485] [drm] Found bochs VGA, ID 0xb0c5.1779machine # [ 6.491488] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1780machine # [ 6.496926] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1781machine # [ 6.497624] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01782sshClient # [ 6.300272] systemd[1]: Starting User Login Management...1783sshClient # [ 6.332650] systemd-homed[512]: Watching /home.1784sshClient # [ 6.207732] rtc_cmos PNP0B00:00: setting system clock to 2026-10-21T03:09:07 UTC (1792552147)1785sshClient # [ 6.207825] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1786sshClient # [ 6.208464] systemd-journald[283]: Time jumped backwards, rotating.1787sshClient # [ 6.343478] systemd[1]: Finished Import lastlog data into lastlog2 database.1788sshClient # [ 6.223958] parport_pc 00:02: reported by Plug and Play ACPI1789sshClient # [ 6.224045] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1790sshClient # [ 6.241653] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1791sshClient # [ 6.415127] dbus-broker-launch[513]: Looking up NSS user entry for 'systemd-timesync'...1792sshClient # [ 6.420220] dbus-broker-launch[513]: NSS returned no entry for 'systemd-timesync'1793sshClient # [ 6.421660] dbus-broker-launch[513]: Invalid user-name in /nix/store/x1z68gv0dhcngld78yrc9rfbmb0p2vfs-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1794machine # [ 6.491582] systemd[1]: Stopped target Host and Network Name Lookups.1795machine # [ 6.493056] systemd[1]: Stopping Host and Network Name Lookups...1796machine # [ 6.493985] systemd[1]: Stopped target User and Group Name Lookups.1797machine # [ 6.494931] systemd[1]: Stopping User and Group Name Lookups...1798machine # [ 6.495780] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1799machine # [ 6.508274] systemd[1]: nscd.service: Deactivated successfully.1800machine # [ 6.512245] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1801machine # [ 6.514716] dbus-broker-launch[548]: Looking up NSS user entry for 'systemd-timesync'...1802sshClient # [ 6.257652] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input31803sshClient # [ 6.418296] Console: switching to colour dummy device 80x251804sshClient # [ 6.530173] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1805machine # [ 6.522937] systemd-logind[551]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)1806sshClient # [ 6.530290] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1807sshClient # [ 6.648439] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51808sshClient # [ 6.648695] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input41809sshClient # [ 6.669932] [drm] Found bochs VGA, ID 0xb0c5.1810sshClient # [ 6.669934] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1811sshClient # [ 6.452842] systemd[1]: Stopped target Host and Network Name Lookups.1812sshClient # [ 6.531383] systemd[1]: Stopping Host and Network Name Lookups...1813sshClient # [ 6.675368] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1814sshClient # [ 6.675376] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01815sshClient # [ 6.535321] systemd[1]: Stopped target User and Group Name Lookups.1816sshClient # [ 6.541852] systemd[1]: Stopping User and Group Name Lookups...1817sshClient # [ 6.544447] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1818sshClient # [ 6.547243] systemd[1]: nscd.service: Deactivated successfully.1819sshClient # [ 6.549632] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1820sshClient # [ 6.550634] systemd[1]: Started D-Bus System Message Bus.1821sshClient # [ 6.551491] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1822sshClient # [ 6.555940] dbus-broker-launch[513]: Ready1823sshClient # [ 6.557511] systemd[1]: Started Home Area Manager.1824sshClient # [ 6.559150] systemd[1]: Finished Home Area Activation.1825sshClient # [ 6.561319] systemd-logind[535]: New seat seat0.1826sshClient # [ 6.563194] systemd[1]: Starting First Boot Home Area Wizard...1827sshClient # [ 6.566075] systemd[1]: Started User Login Management.1828sshClient # [ 6.578378] systemd[1]: Starting linger-users.service...1829sshClient # [ 6.588134] systemd[1]: Starting Virtual Console Setup...1830sshClient # [ 6.600955] systemd-logind[535]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1831machine # [ 6.674338] ppdev: user-space parallel port driver1832sshClient # [ 6.610519] nsncd[586]: Oct 21 03:09:08.043 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1833machine # [ 6.773853] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1834sshClient # [ 6.624097] systemd[1]: Started Name Service Cache Daemon (nsncd).1835machine # [ 6.785058] Console: switching to colour frame buffer device 160x501836machine # [ 6.796880] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1837machine # [ 6.840009] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1838sshClient # [ 6.637582] systemd[1]: Reached target Host and Network Name Lookups.1839sshClient # [ 6.638611] systemd[1]: Reached target User and Group Name Lookups.1840machine # [ 6.526078] systemd-logind[551]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1841machine # [ 6.703634] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1842machine # [ 6.706257] dbus-broker-launch[548]: NSS returned no entry for 'systemd-timesync'1843machine # [ 6.709578] dbus-broker-launch[548]: Invalid user-name in /nix/store/9j21bzmfzjjl35x68zka679wqnnhc5zi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1844machine # [ 6.712726] systemd[1]: Started D-Bus System Message Bus.1845sshClient # [ 6.652407] systemd[1]: Finished resolvconf update.1846sshClient # [ 6.653282] systemd[1]: Reached target Preparation for Network.1847machine # [ 6.717301] dbus-broker-launch[548]: Ready1848machine # [ 6.719709] nsncd[607]: Oct 21 03:09:08.260 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1849machine # [ 6.723205] systemd[1]: Started Home Area Manager.1850machine # [ 6.724122] systemd[1]: Finished Home Area Activation.1851sshClient # [ 6.662990] systemd[1]: Starting DHCP Client...1852machine # [ 6.728798] systemd[1]: Starting First Boot Home Area Wizard...1853machine # [ 6.729658] systemd[1]: Started Name Service Cache Daemon (nsncd).1854sshClient # [ 6.668294] systemd[1]: Starting Address configuration of eth1...1855machine # [ 6.730518] systemd[1]: Reached target Host and Network Name Lookups.1856machine # [ 6.731357] systemd[1]: Reached target User and Group Name Lookups.1857machine # [ 6.732151] systemd[1]: Finished resolvconf update.1858machine # [ 6.732800] systemd[1]: Reached target Preparation for Network.1859machine # [ 6.735275] systemd[1]: Starting DHCP Client...1860machine # [ 6.735920] systemd[1]: Starting Address configuration of eth1...1861machine # [ 6.738363] systemd[1]: Starting Extra networking commands....1862machine # [ 6.740142] systemd-logind[551]: New seat seat0.1863sshClient # [ 6.681256] systemd[1]: Starting Extra networking commands....1864machine # [ 6.745769] systemd[1]: Started User Login Management.1865machine # [ 6.747867] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1866machine # [ 6.751223] systemd[1]: Stopped Virtual Console Setup.1867machine # [ 6.782181] systemd[1]: Starting linger-users.service...1868machine # [ 6.792368] systemd[1]: Starting Virtual Console Setup...1869machine # [ 6.842713] systemd[1]: Created slice Slice /system/systemd-mute-console.1870machine # [ 6.850159] systemd[1]: Started Console Output Muting Service (PID 619/UID 0).1871machine # [ 6.885063] systemd[1]: linger-users.service: Deactivated successfully.1872sshClient # [ 6.921784] Console: switching to colour frame buffer device 160x501873sshClient # [ 6.944260] ppdev: user-space parallel port driver1874machine # [ 6.893679] systemd[1]: Finished linger-users.service.1875sshClient # [ 6.956832] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1876machine # [ 6.936990] network-addresses-eth1-start[634]: adding address 192.168.1.1/24... done1877sshClient # [ 6.965334] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1878sshClient # [ 7.039778] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1879sshClient # [ 6.691068] systemd[1]: linger-users.service: Deactivated successfully.1880sshClient # [ 6.899935] systemd[1]: Finished linger-users.service.1881sshClient # [ 6.900877] network-addresses-eth1-start[615]: adding address 192.168.1.2/24... done1882sshClient # [ 6.905433] network-addresses-eth1-start[615]: adding address 2001:db8:1::2/64... done1883sshClient # [ 6.906513] systemd-logind[535]: Watching system buttons on /dev/input/event2 (QEMU Virtio Keyboard)1884sshClient # [ 6.908580] systemd[1]: Finished Address configuration of eth1.1885sshClient # [ 6.910483] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1886sshClient # [ 6.914508] systemd[1]: Stopped Virtual Console Setup.1887sshClient # [ 6.917890] systemd[1]: Finished First Boot Home Area Wizard.1888sshClient # [ 6.926592] dhcpcd[625]: dhcpcd-10.3.2 starting1889sshClient # [ 6.931992] systemd[1]: Reached target First Boot Complete.1890sshClient # [ 6.934976] dhcpcd[680]: dev: loaded udev1891machine # [ 6.996146] network-addresses-eth1-start[634]: adding address 2001:db8:1::1/64... done1892sshClient # [ 6.939974] systemd[1]: Starting Save Transient machine-id to Disk...1893sshClient # [ 6.945327] systemd[1]: Starting Virtual Console Setup...1894machine # [ 7.033427] systemd[1]: Finished Address configuration of eth1.1895sshClient # [ 7.115797] 8021q: 802.1Q VLAN Support v1.81896sshClient # [ 7.116345] 8021q: adding VLAN 0 to HW filter on device eth11897sshClient # [ 6.978226] systemd[1]: Finished Extra networking commands..1898sshClient # [ 6.980290] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1899sshClient # [ 6.983294] systemd[1]: Stopped Virtual Console Setup.1900sshClient # [ 6.991323] systemd[1]: Reached target Network.1901sshClient # [ 6.996304] systemd[1]: Starting Permit User Sessions...1902sshClient # [ 7.000131] systemd[1]: Starting Virtual Console Setup...1903sshClient # [ 7.068742] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1904sshClient # [ 7.070852] systemd[1]: Finished Permit User Sessions.1905machine # [ 7.134420] dhcpcd[665]: dhcpcd-10.3.2 starting1906machine # [ 7.136479] systemd[1]: Finished Extra networking commands..1907machine # [ 7.139471] systemd[1]: Reached target Network.1908machine # [ 7.147653] dhcpcd[706]: dev: loaded udev1909sshClient # [ 7.114444] systemd[1]: Started Getty on tty1.1910sshClient # [ 7.115331] systemd[1]: Reached target Login Prompts.1911sshClient # [ 7.296133] cfg80211: Loading compiled-in X.509 certificates for regulatory database1912sshClient # [ 7.298762] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1913sshClient # [ 7.302330] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1914sshClient # [ 7.306308] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21915sshClient # [ 7.307184] cfg80211: failed to load regulatory.db1916sshClient # [ 7.316786] kvm_amd: TSC scaling supported1917sshClient # [ 7.317347] kvm_amd: Nested Virtualization enabled1918sshClient # [ 7.317833] kvm_amd: Nested Paging enabled1919sshClient # [ 7.318821] kvm_amd: LBR virtualization supported1920sshClient # [ 7.319512] kvm_amd: Virtual VMLOAD VMSAVE supported1921sshClient # [ 7.320001] kvm_amd: Virtual GIF supported1922sshClient # [ 7.320712] kvm_amd: Virtual NMI enabled1923sshClient # [ 7.353435] EDAC MC: Ver: 3.0.01924sshClient # [ 7.362868] 8021q: adding VLAN 0 to HW filter on device eth01925sshClient # [ 7.221879] dhcpcd[680]: eth0: waiting for carrier1926sshClient # [ 7.222863] dhcpcd[680]: eth0: carrier acquired1927sshClient # [ 7.230794] dhcpcd[680]: DUID 00:01:00:01:32:6a:e9:54:52:54:00:12:34:561928sshClient # [ 7.231812] dhcpcd[680]: eth0: IAID 00:12:34:561929sshClient # [ 7.232659] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:34561930machine # [ 7.299507] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1931sshClient # [ 7.296867] systemd-vconsole-setup[691]: Configuration of first virtual console was skipped, ignoring remaining ones.1932sshClient # [ 7.300329] systemd[1]: Finished Virtual Console Setup.1933sshClient # [ 7.340866] systemd[1]: Finished Save Transient machine-id to Disk.1934machine: (finished: waiting for unit systemd-homed.service, in 8.15 seconds)1935machine # [ 7.482104] dhcpcd[706]: eth0: waiting for carrier1936machine: waiting for Please enter user name to create to appear on tty 11937machine # [ 7.483296] dhcpcd[706]: eth0: carrier acquired1938machine # [ 7.496239] dhcpcd[706]: DUID 00:01:00:01:32:6a:e9:55:52:54:00:12:34:561939machine # [ 7.498334] dhcpcd[706]: eth0: IAID 00:12:34:561940machine # [ 7.499051] dhcpcd[706]: eth0: adding address fe80::5054:ff:fe12:34561941sshClient # [ 7.592849] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1942machine # [ 7.780869] sshd-keygen-start[562]: Generating public/private rsa key pair.1943machine # [ 7.782001] sshd-keygen-start[562]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1944machine # [ 7.783159] sshd-keygen-start[562]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1945machine # [ 7.784358] sshd-keygen-start[562]: The key fingerprint is:1946machine # [ 7.785088] sshd-keygen-start[562]: SHA256:wLhS6vLPCy8sXExajVDEj9oiTgsQuc1/yLYCleARlOg root@machine1947machine # [ 7.786261] sshd-keygen-start[562]: The key's randomart image is:1948machine # [ 7.787019] sshd-keygen-start[562]: +---[RSA 4096]----+1949machine # [ 7.787673] sshd-keygen-start[562]: |o+*o |1950machine # [ 7.788375] sshd-keygen-start[562]: |=+ . o |1951machine # [ 7.789103] sshd-keygen-start[562]: |o*o.B o |1952machine # [ 7.789741] sshd-keygen-start[562]: |oE=B + . |1953machine # [ 7.790469] sshd-keygen-start[562]: |..Xo.. S |1954machine # [ 7.791140] sshd-keygen-start[562]: |+* == . |1955machine # [ 7.791783] sshd-keygen-start[562]: |Bo*. o |1956machine # [ 7.792523] sshd-keygen-start[562]: |.*++. |1957machine # [ 7.793221] sshd-keygen-start[562]: | ..+=. |1958machine # [ 7.793881] sshd-keygen-start[562]: +----[SHA256]-----+1959machine # [ 7.815318] systemd-vconsole-setup[638]: Configuration of first virtual console was skipped, ignoring remaining ones.1960machine # [ 7.821346] systemd[1]: Finished Virtual Console Setup.1961machine # [ 7.826986] sshd-keygen-start[735]: Generating public/private ed25519 key pair.1962machine # [ 7.827963] sshd-keygen-start[735]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1963machine # [ 7.829080] sshd-keygen-start[735]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1964machine # [ 7.830211] sshd-keygen-start[735]: The key fingerprint is:1965machine # [ 7.830896] sshd-keygen-start[735]: SHA256:Tj+PtNksq3ocNfypR1Gvd010Ii9RfJVVktaXe0fXxp4 root@machine1966machine # [ 7.831977] sshd-keygen-start[735]: The key's randomart image is:1967machine # [ 7.832856] sshd-keygen-start[735]: +--[ED25519 256]--+1968machine # [ 7.834063] sshd-keygen-start[735]: | oo+@|1969machine # [ 7.834739] sshd-keygen-start[735]: | o *+%|1970machine # [ 7.835446] sshd-keygen-start[735]: | . * O*|1971machine # [ 7.836376] sshd-keygen-start[735]: | + o .E*|1972machine # [ 7.837069] sshd-keygen-start[735]: | S. o + o+|1973machine # [ 7.837715] sshd-keygen-start[735]: | o.. + . +|1974machine # [ 7.838624] sshd-keygen-start[735]: | ...+o ..|1975machine # [ 7.840080] sshd-keygen-start[735]: | o.oO. |1976machine # [ 7.840740] sshd-keygen-start[735]: | .o..=++ |1977machine # [ 7.841444] sshd-keygen-start[735]: +----[SHA256]-----+1978machine # [ 7.842218] systemd[1]: sshd-keygen.service: Deactivated successfully.1979machine # [ 7.843197] systemd[1]: Finished SSH Host Keys Generation.1980machine # [ 7.846385] systemd[1]: Starting SSH Daemon...1981machine # [ 7.868774] sshd[738]: Server listening on 0.0.0.0 port 22.1982machine # [ 7.870159] sshd[738]: Server listening on :: port 22.1983machine # [ 7.870865] systemd[1]: Started SSH Daemon.1984sshClient # [ 8.283354] dhcpcd[680]: eth0: soliciting a DHCP lease1985sshClient # [ 8.442629] NET: Registered PF_PACKET protocol family1986sshClient # [ 8.307898] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.21987sshClient # [ 8.310459] dhcpcd[680]: eth0: probing address 10.0.2.15/241988machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 1.16 seconds)1989machine: sending keys 'test-homed-user\n'1990machine: (finished: sending keys 'test-homed-user\n', in 0.16 seconds)1991machine: waiting for Please enter new password for user test-homed-user: to appear on tty 11992machine # [ 9.211138] dhcpcd[706]: eth0: soliciting a DHCP lease1993machine # [ 9.222458] dhcpcd[706]: eth0: offered 10.0.2.15 from 10.0.2.21994machine # [ 9.224208] dhcpcd[706]: eth0: probing address 10.0.2.15/241995machine # [ 9.449666] dhcpcd[706]: eth0: soliciting an IPv6 router1996machine # [ 9.450902] dhcpcd[706]: eth0: Router Advertisement from fe80::21997machine # [ 9.452051] dhcpcd[706]: eth0: adding address fec0::5054:ff:fe12:3456/641998machine # [ 9.452930] dhcpcd[706]: eth0: adding route to fec0::/641999machine # [ 9.453694] dhcpcd[706]: 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.10 seconds)2001machine: sending keys 'foobarfoo\n'2002machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2003machine: waiting for (repeat) to appear on tty 12004sshClient # [ 10.096599] dhcpcd[680]: eth0: soliciting an IPv6 router2005sshClient # [ 10.098196] dhcpcd[680]: eth0: Router Advertisement from fe80::22006sshClient # [ 10.099423] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/642007sshClient # [ 10.100539] dhcpcd[680]: eth0: adding route to fec0::/642008sshClient # [ 10.101541] dhcpcd[680]: eth0: adding default route via fe80::22009machine: (finished: waiting for (repeat) to appear on tty 1, in 1.04 seconds)2010machine: sending keys 'foobarfoo\n'2011machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2012machine: waiting for unit systemd-homed-firstboot.service2013sshClient # [ 13.490812] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds2014sshClient # [ 13.491739] dhcpcd[680]: eth0: adding route to 10.0.2.0/242015sshClient # [ 13.492449] dhcpcd[680]: eth0: adding default route via 10.0.2.22016sshClient # [ 13.572867] systemd[1]: Started DHCP Client.2017sshClient # [ 13.576917] systemd[1]: Reached target Multi-User System.2018sshClient # [ 13.578189] systemd[1]: Startup finished in 850ms (kernel) + 3.134s (initrd) + 9.592s (userspace) = 13.577s.2019machine # [ 14.039731] dhcpcd[706]: eth0: leased 10.0.2.15 for 86400 seconds2020machine # [ 14.042305] dhcpcd[706]: eth0: adding route to 10.0.2.0/242021machine # [ 14.045551] dhcpcd[706]: eth0: adding default route via 10.0.2.22022machine # [ 14.121267] systemd[1]: Started DHCP Client.2023machine # [ 21.316784] systemd-homed[525]: Generating key pair for signing local user identity records.2024machine # [ 21.319150] systemd-homed[525]: Successfully created Ed25519 key pair.2025machine # [ 21.333167] systemd-homed[525]: test-homed-user: changing state absent → creating2026machine # [ 21.389893] systemd-homework[876]: Using automatic default storage of 'luks'.2027machine # [ 21.394664] systemd-homework[876]: Sizing home to 83% of available disk space, which is 743M.2028machine # [ 21.395897] systemd-homework[876]: Allocating image file completed.2029machine # [ 21.417498] systemd-homework[876]: Writing of partition table completed.2030machine # [ 21.420129] systemd-homework[876]: Setting up loopback device /dev/loop0 completed.2031machine # [ 22.705767] systemd-homework[876]: LUKS formatting completed.2032machine # [ 24.489423] systemd-homework[876]: Writing password to LUKS keyslot 0 completed.2033machine # [ 24.702928] systemd-homework[876]: LUKS activation by volume key succeeded.2034machine # [ 24.720379] systemd-homework[876]: Writing user record as LUKS token completed.2035machine # [ 24.721462] systemd-homework[876]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2036machine # [ 24.722792] systemd-homework[876]: Formatting /dev/mapper/home-test-homed-user as btrfs2037machine # [ 25.042790] systemd[1]: proc-910-mounts.mount: Deactivated successfully.2038machine # [ 25.044191] systemd-homework[876]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid c2ae627e-424d-45f5-803a-163e9f21ab91)2039machine # [ 25.047316] systemd-homework[876]: Formatting file system completed.2040machine # [ 25.083038] systemd-homework[876]: Mounting file system completed.2041machine # [ 25.085039] systemd-homework[876]: Skeleton directory /etc/skel missing, ignoring.2042machine # [ 25.086236] systemd-homework[876]: Wrote embedded .identity file.2043machine # [ 25.087332] systemd-homework[876]: Replaced embedded blob dir with contents of system blob dir.2044machine # [ 25.088753] systemd-homework[876]: Recursive changing of ownership completed.2045machine # [ 25.090066] systemd-homework[876]: Changed top-level directory access mode to 0700.2046machine # [ 25.097785] systemd-homework[876]: Synchronized disk.2047machine # [ 25.098507] systemd-homework[876]: Discarded unused 651.8M.2048machine # [ 25.106206] systemd-homed[525]: block device /sys/devices/virtual/block/dm-0 has been removed.2049machine # [ 25.117133] systemd-homed[525]: block device /sys/devices/virtual/block/dm-0 has been removed.2050machine # [ 25.128893] (udev-worker)[907]: loop0: Failed to add device watch, ignoring: No such file or directory2051machine # [ 25.131576] (udev-worker)[907]: loop0: Failed to add device watch, ignoring: No such file or directory2052machine # [ 25.134565] (udev-worker)[907]: loop0: Failed to add device watch, ignoring: No such file or directory2053machine # [ 25.136977] (udev-worker)[907]: loop0: Failed to add device watch, ignoring: No such file or directory2054machine # [ 25.139114] systemd-homework[876]: Moved image file into place.2055machine # [ 25.142060] systemd-homework[876]: Creation completed.2056machine # [ 25.142798] systemd-homework[876]: Image size is 743M, file system size is 725M, file system payload size is 725M, file system free is 718.9M.2057machine # [ 25.144652] systemd-homed[525]: block device /sys/devices/virtual/block/loop0 has been removed.2058machine # [ 25.154369] systemd-homed[525]: test-homed-user: changing state creating → inactive2059machine # [ 25.156567] systemd[1]: systemd-mute-console@0-1-619_620-0.service: Deactivated successfully.2060machine # [ 25.159940] systemd[1]: Finished First Boot Home Area Wizard.2061machine # [ 25.163849] systemd[1]: Reached target First Boot Complete.2062machine # [ 25.166343] systemd[1]: Starting Save Transient machine-id to Disk...2063machine # [ 25.170167] systemd[1]: Starting Permit User Sessions...2064machine # [ 25.192987] systemd[1]: Finished Permit User Sessions.2065machine # [ 25.197540] systemd[1]: Started Getty on tty1.2066machine # [ 25.199375] systemd[1]: Reached target Login Prompts.2067machine # [ 25.201297] systemd[1]: Reached target Multi-User System.2068machine # [ 25.557299] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2069machine # [ 25.560289] systemd[1]: Finished Save Transient machine-id to Disk.2070machine # [ 25.564888] systemd[1]: Startup finished in 850ms (kernel) + 2.972s (initrd) + 21.740s (userspace) = 25.564s.2071machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.56 seconds)2072(finished: subtest: create systemd-homed user on first boot prompt, in 26.39 seconds)2073machine: must succeed: homectl update test-homed-user --offline -G wheel2074machine # [ 25.743876] systemd-homed[525]: test-homed-user: changing state inactive → updating2075machine # [ 25.747947] systemd-homework[952]: Offline update requested. Not touching embedded records.2076machine # [ 25.750093] systemd-homed[525]: Home test-homed-user is signed exclusively by our key, accepting.2077machine # [ 25.756075] systemd-homed[525]: test-homed-user: changing state updating → inactive2078machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.04 seconds)2079subtest: login as homed user2080machine: waiting for login: to appear on tty 12081machine: (finished: waiting for login: to appear on tty 1, in 0.02 seconds)2082machine: sending keys 'test-homed-user\n'2083machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)2084machine: waiting for Password: to appear on tty 12085machine # [ 26.114192] systemd-homed[525]: test-homed-user: changing state inactive → activating-for-acquire2086machine # [ 26.118521] systemd-homework[967]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2087machine # [ 26.124735] systemd-homed[525]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2088machine # [ 26.126685] systemd-homed[525]: test-homed-user: changing state activating-for-acquire → inactive2089machine # [ 26.127899] systemd-homed[525]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2090machine # [ 26.129307] systemd-homed[525]: Home test-homed-user already deactivated, no automatic deactivation needed.2091machine: (finished: waiting for Password: to appear on tty 1, in 1.05 seconds)2092machine: sending keys 'foobarfoo\n'2093machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2094machine: waiting for success: pgrep -u test-homed-user -t tty1 bash2095machine # [ 27.180910] systemd-homed[525]: test-homed-user: changing state inactive → activating-for-acquire2096machine # [ 27.205826] systemd-homework[979]: Provided password unlocks user record.2097machine # [ 27.209523] systemd-homework[979]: Successfully locked image file '/home/test-homed-user.home'.2098machine # [ 27.214925] systemd-homework[979]: Allocated additional 651.8M.2099machine # [ 27.362128] loop1: detected capacity change from 0 to 15175682100machine # [ 27.219671] systemd-homework[979]: Setting up loopback device /dev/loop1 completed.2101machine # [ 28.058342] systemd-homework[979]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2102machine # [ 28.083563] systemd-homework[979]: Provided password unlocks user record.2103machine # [ 28.088503] systemd-homework[979]: Probing file system completed (found btrfs).2104machine # [ 28.092631] systemd-homework[979]: No fsck for file system btrfs installed, ignoring.2105machine # [ 28.238409] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (979)2106machine # [ 28.241198] BTRFS info (device dm-0): first mount of filesystem c2ae627e-424d-45f5-803a-163e9f21ab912107machine # [ 28.242161] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2108machine # [ 28.246171] BTRFS info (device dm-0): enabling free space tree2109machine # [ 28.246899] BTRFS info (device dm-0): use zstd compression, level 12110machine # [ 28.104585] systemd-homework[979]: Mounting file system completed.2111machine # [ 28.106092] systemd-homework[979]: Discovered used loopback device /dev/loop1.2112machine # [ 28.107128] systemd-homework[979]: offset = 1048576, size = 776994816, image = 7790919682113machine # [ 28.114900] systemd-homework[979]: Ready to resize image size 743M → 896M, partition size 741M → 894M, file system size 725M → 878M.2114machine # [ 28.116688] systemd-homework[979]: Growing of image file from 743M to 896M completed.2115machine # [ 28.263241] loop1: detected capacity change from 1517568 to 18309122116machine # [ 28.120733] systemd-homework[979]: Refreshing loop device size completed.2117machine # [ 28.136831] systemd-homework[979]: Growing of partition completed.2118machine # [ 28.309946] async_tx: api initialized (async)2119machine # [ 28.205189] systemd-homework[979]: LUKS device growing completed.2120machine # [ 28.355921] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 760217600 to 9206497282121machine # [ 28.214118] systemd-homework[979]: File system resizing from 725M to 878M completed.2122machine # [ 28.216062] systemd-homework[979]: Synchronized disk.2123machine # [ 28.216803] systemd-homework[979]: Synchronized disk.2124machine # [ 28.217497] systemd-homework[979]: Resizing completed.2125machine # [ 28.218273] systemd-homework[979]: Image size is 896M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2126machine # [ 28.219860] systemd-homework[979]: Read embedded .identity file.2127machine # [ 28.239079] systemd-homework[979]: Provided password unlocks user record.2128machine # [ 28.240157] systemd-homework[979]: Reconciling header user identity completed (host version was newer).2129machine # [ 28.241467] systemd-homework[979]: Reconciling embedded user identity completed (host version was newer).2130machine # [ 28.257356] systemd-homework[979]: Wrote LUKS header user record.2131machine # [ 28.258671] systemd-homework[979]: Wrote embedded .identity file.2132machine # [ 28.259512] systemd-homework[979]: Replaced embedded blob dir with contents of system blob dir.2133machine # [ 28.260623] systemd-homework[979]: Recursive changing of ownership not necessary, skipped.2134machine # [ 28.265564] systemd-homework[979]: Synchronized disk.2135machine # [ 28.267531] systemd-homework[979]: Moving to final mount point /home/test-homed-user completed.2136machine # [ 28.285961] systemd-homework[979]: Activation completed.2137machine # [ 28.287152] systemd-homework[979]: Image size is 894M, file system size is 878M, file system payload size is 878M, file system free is 871.9M.2138machine # [ 28.297527] systemd-homed[525]: Home test-homed-user is signed exclusively by our key, accepting.2139machine # [ 28.303422] login[943]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired.2140machine # [ 28.304804] systemd-homed[525]: test-homed-user: changing state activating-for-acquire → active2141machine # [ 28.311472] systemd-homed[525]: test-homed-user: changing state active → resizing-while-active2142machine # [ 28.321306] systemd-homework[1022]: Successfully acquired home volume key from kernel keyring.2143machine # [ 28.323767] systemd-homework[1022]: LUKS volume key from keyring unlocks user record.2144machine # [ 28.377153] login[943]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0)2145machine # [ 28.406084] systemd-homework[1022]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2146machine # [ 28.435318] systemd[1]: Created slice Slice /user/60388.2147machine # [ 28.438456] systemd[1]: Starting User Runtime Directory /run/user/60388...2148machine # [ 28.451455] systemd-logind[551]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'.2149machine # [ 28.501070] systemd[1]: Finished User Runtime Directory /run/user/60388.2150machine # [ 28.516130] systemd[1]: Starting User Manager for UID 60388...2151machine # [ 28.561552] (systemd)[1027]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2152machine # [ 28.613247] (systemd)[1027]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2153machine # [ 28.620726] systemd-logind[551]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2154machine # [ 28.669189] systemd-homework[1022]: Successfully re-activated LUKS device.2155machine # [ 28.671250] systemd-homework[1022]: LUKS volume key from keyring unlocks user record.2156machine # [ 28.672586] systemd-homework[1022]: Discovered used loopback device /dev/loop1.2157machine # [ 28.673931] systemd-homework[1022]: Read embedded .identity file.2158machine # [ 28.675161] systemd-homework[1022]: LUKS volume key from keyring unlocks user record.2159machine # [ 28.676206] systemd-homework[1022]: Reconciling header user identity completed (host version was newer).2160machine # [ 28.677810] systemd-homework[1022]: Reconciling embedded user identity completed (host version was newer).2161machine # [ 28.679088] systemd-homework[1022]: offset = 1048576, size = 937426944, image = 9395240962162machine # [ 28.683595] systemd[1027]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2163machine # [ 28.699105] systemd-homework[1022]: Ready to resize image size 896M → 764M, partition size 894M → 762M, file system size 878M → 746M.2164machine # [ 28.701121] systemd-homework[1022]: Wrote embedded .identity file.2165machine # [ 28.703070] systemd-homework[1022]: Replaced embedded blob dir with contents of system blob dir.2166machine # [ 28.704400] systemd-homework[1022]: Backing file is fully allocated already.2167machine # [ 28.854520] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 920649728 to 7822376962168machine # [ 28.713177] systemd-homework[1022]: File system resizing from 878M to 746M completed.2169machine # [ 28.719145] systemd-homework[1022]: Synchronized disk.2170machine # [ 28.752780] systemd-homework[1022]: LUKS device shrinking completed.2171machine # [ 28.900263] loop1: detected capacity change from 1830912 to 15605762172machine # [ 28.760203] systemd-homework[1022]: Refreshing loop device size completed.2173machine # [ 28.761250] systemd-homework[1022]: Shrinking of image file completed.2174machine # [ 28.783257] systemd-homework[1022]: Shrinking of partition completed.2175machine # [ 28.801492] systemd-homework[1022]: Wrote LUKS header user record.2176machine # [ 28.803842] systemd-homework[1022]: Synchronized disk.2177machine # [ 28.808259] systemd-homework[1022]: Resizing completed.2178machine # [ 28.809096] systemd-homework[1022]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2179machine # [ 28.822571] systemd-homed[525]: Home test-homed-user is signed exclusively by our key, accepting.2180machine # [ 28.829041] systemd-homed[525]: test-homed-user: changing state resizing-while-active → active2181machine # [ 28.830750] systemd-homed[525]: Rebalancing complete.2182machine # [ 28.842519] systemd[1027]: Queued start job for default target Main User Target.2183machine # [ 28.844875] systemd[1027]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2184machine # [ 28.850508] systemd[1027]: Created slice User Application Slice.2185machine # [ 28.851683] systemd[1027]: Started Daily Cleanup of User's Temporary Directories.2186machine # [ 28.853472] systemd[1027]: Reached target Paths.2187machine # [ 28.854343] systemd[1027]: Reached target Timers.2188machine # [ 28.857066] systemd[1027]: Starting D-Bus User Message Bus Socket...2189machine # [ 28.858691] systemd[1027]: Starting Create User Files and Directories...2190machine # [ 28.882121] systemd[1027]: Finished Create User Files and Directories.2191machine # [ 28.893200] systemd[1027]: Listening on D-Bus User Message Bus Socket.2192machine # [ 28.895541] systemd[1027]: Reached target Sockets.2193machine # [ 28.896298] systemd[1027]: Reached target Basic System.2194machine # [ 28.897092] systemd[1]: Started User Manager for UID 60388.2195machine # [ 28.900254] systemd[1027]: Starting Run user-specific NixOS activation...2196machine # [ 28.903509] systemd[1]: Started Session 1 of User test-homed-user.2197machine # [ 28.934399] systemd[1027]: Finished Run user-specific NixOS activation.2198machine # [ 28.935371] systemd[1027]: Reached target Main User Target.2199machine # [ 28.936491] systemd[1027]: Startup finished in 272ms.2200machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 2.11 seconds)2201machine: sending keys 'whoami > /tmp/2\n'2202machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.16 seconds)2203machine: waiting for file '/tmp/2'2204machine: (finished: waiting for file '/tmp/2', in 1.04 seconds)2205machine: must succeed: cat /tmp/22206machine: (finished: must succeed: cat /tmp/2, in 0.03 seconds)2207(finished: subtest: login as homed user, in 4.69 seconds)2208subtest: login as regular user2209sshClient: waiting for login: to appear on tty 12210sshClient: waiting for the VM to finish booting2211sshClient: Guest shell says: b'Spawning backdoor root shell...\n'2212sshClient: connected to guest root shell2213sshClient: (connecting took 0.00 seconds)2214sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds)2215sshClient: (finished: waiting for login: to appear on tty 1, in 0.05 seconds)2216sshClient: sending keys 'test-normal-user\n'2217sshClient: (finished: sending keys 'test-normal-user\n', in 0.17 seconds)2218sshClient: waiting for Password: to appear on tty 12219sshClient: (finished: waiting for Password: to appear on tty 1, in 1.08 seconds)2220sshClient: sending keys 'foobarfoo\n'2221sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2222sshClient: waiting for success: pgrep -u test-normal-user bash2223sshClient # [ 31.903271] login[694]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0)2224sshClient # [ 31.935981] systemd-logind[535]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'.2225sshClient # [ 31.949699] systemd[1]: Created slice Slice /user/1000.2226sshClient # [ 31.952189] systemd[1]: Starting User Runtime Directory /run/user/1000...2227sshClient # [ 31.998907] systemd[1]: Finished User Runtime Directory /run/user/1000.2228sshClient # [ 32.007915] systemd[1]: Starting User Manager for UID 1000...2229sshClient # [ 32.036624] (systemd)[810]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0)2230sshClient # [ 32.043202] systemd-logind[535]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'.2231sshClient # [ 32.063675] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2232sshClient # [ 32.163862] systemd[810]: Queued start job for default target Main User Target.2233sshClient # [ 32.167847] systemd[810]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2234sshClient # [ 32.170587] systemd[810]: Created slice User Application Slice.2235sshClient # [ 32.172074] systemd[810]: Started Daily Cleanup of User's Temporary Directories.2236sshClient # [ 32.173150] systemd[810]: Reached target Paths.2237sshClient # [ 32.173867] systemd[810]: Reached target Timers.2238sshClient # [ 32.176282] systemd[810]: Starting D-Bus User Message Bus Socket...2239sshClient # [ 32.179406] systemd[810]: Starting Create User Files and Directories...2240sshClient # [ 32.209870] systemd[810]: Finished Create User Files and Directories.2241sshClient # [ 32.223855] systemd[810]: Listening on D-Bus User Message Bus Socket.2242sshClient # [ 32.226077] systemd[810]: Reached target Sockets.2243sshClient # [ 32.226800] systemd[810]: Reached target Basic System.2244sshClient # [ 32.228259] systemd[1]: Started User Manager for UID 1000.2245sshClient # [ 32.231920] systemd[810]: Starting Run user-specific NixOS activation...2246sshClient # [ 32.233799] systemd[1]: Started Session 1 of User test-normal-user.2247sshClient # [ 32.281219] systemd[810]: Finished Run user-specific NixOS activation.2248sshClient # [ 32.284244] systemd[810]: Reached target Main User Target.2249sshClient # [ 32.285288] systemd[810]: Startup finished in 226ms.2250sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.08 seconds)2251sshClient: sending keys 'whoami > /tmp/1\n'2252sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.17 seconds)2253sshClient: waiting for file '/tmp/1'2254sshClient: (finished: waiting for file '/tmp/1', in 1.04 seconds)2255sshClient: must succeed: cat /tmp/12256sshClient: (finished: must succeed: cat /tmp/1, in 0.03 seconds)2257(finished: subtest: login as regular user, in 3.73 seconds)2258subtest: add homed ssh authorized key2259sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n'2260sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.49 seconds)2261sshClient: waiting for file '/tmp/id_ed25519.pub'2262sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.06 seconds)2263sshClient: must succeed: cat /tmp/id_ed25519.pub2264sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.03 seconds)2265machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIE6ElKWZN+RxNAuSBAF8NDAxfXIH9iAPm2aGUaw6a4R7 test-normal-user@sshClient'2266machine # [ 35.772586] systemd-homed[525]: test-homed-user: changing state active → updating-while-active2267machine # [ 35.780713] systemd-homework[1075]: Offline update requested. Not touching embedded records.2268machine # [ 35.789980] systemd-homed[525]: test-homed-user: changing state updating-while-active → active2269machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIE6ElKWZN+RxNAuSBAF8NDAxfXIH9iAPm2aGUaw6a4R7 test-normal-user@sshClient', in 0.05 seconds)2270machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed255192271machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.02 seconds)2272(finished: subtest: add homed ssh authorized key, in 1.65 seconds)2273subtest: change homed user password2274machine: sending keys 'passwd; echo $? > /tmp/3\n'2275machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds)2276machine: waiting for New password: to appear on tty 12277machine: (finished: waiting for New password: to appear on tty 1, in 1.07 seconds)2278machine: sending keys 'barfoobar\n'2279machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2280machine: waiting for Retype new password: to appear on tty 12281machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.07 seconds)2282machine: sending keys 'barfoobar\n'2283machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2284??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead.2285 File "/nix/store/9a17m19ckncxr4bg1lfalvqxs7gnfj0f-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 5732286machine: must succeed: sleep 4.02287machine # [ 38.560550] systemd-homed[525]: test-homed-user: changing state active → passwd-while-active2288machine # [ 39.254680] systemd-homework[1114]: No valid password for LUKS superblock.2289machine # [ 41.576302] systemd-homed[525]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2290machine # [ 41.578672] systemd-homed[525]: test-homed-user: changing state passwd-while-active → active2291machine: (finished: must succeed: sleep 4.0, in 4.02 seconds)2292machine: sending keys 'foobarfoo\n'2293machine: (finished: sending keys 'foobarfoo\n', in 0.11 seconds)2294machine: waiting for file '/tmp/3'2295machine # [ 42.676794] systemd-homed[525]: test-homed-user: changing state active → passwd-while-active2296machine # [ 44.018443] systemd-homework[1120]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2297machine # [ 44.150085] systemd-homework[1120]: Successfully re-activated LUKS device.2298machine # [ 44.188499] systemd-homework[1120]: Provided password unlocks user record.2299machine # [ 44.189960] systemd-homework[1120]: Discovered used loopback device /dev/loop1.2300machine # [ 44.191049] systemd-homework[1120]: Read embedded .identity file.2301machine # [ 44.228354] systemd-homework[1120]: Provided password unlocks user record.2302machine # [ 44.230161] systemd-homework[1120]: Reconciling header user identity completed (host version was newer).2303machine # [ 44.231426] systemd-homework[1120]: Reconciling embedded user identity completed (host version was newer).2304machine # [ 47.219778] systemd-homework[1120]: Added LUKS key slot 1.2305machine # [ 47.256751] systemd-homework[1120]: Destroyed LUKS key slot 0.2306machine # [ 47.269025] systemd-homework[1120]: Wrote LUKS header user record.2307machine # [ 47.270279] systemd-homework[1120]: Wrote embedded .identity file.2308machine # [ 47.271486] systemd-homework[1120]: Replaced embedded blob dir with contents of system blob dir.2309machine # [ 47.277844] systemd-homework[1120]: Synchronized disk.2310machine # [ 47.280188] systemd-homework[1120]: Everything completed.2311machine # [ 47.294083] passwd[1089]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user.2312machine # [ 47.296967] systemd-homed[525]: test-homed-user: changing state passwd-while-active → active2313machine: (finished: waiting for file '/tmp/3', in 5.12 seconds)2314machine: must succeed: cat /tmp/32315machine: (finished: must succeed: cat /tmp/3, in 0.01 seconds)2316(finished: subtest: change homed user password, in 11.87 seconds)2317subtest: escalate to root from homed user2318machine: sending keys 'sudo id | tee /tmp/4\n'2319machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds)2320machine: waiting for password for test-homed-user to appear on tty 12321machine # [ 48.150437] systemd-homed[525]: test-homed-user: changing state active → authenticating-for-acquire2322machine # [ 48.157599] systemd-homework[1156]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2323machine # [ 48.165488] systemd-homed[525]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2324machine # [ 48.167733] systemd-homed[525]: test-homed-user: changing state authenticating-for-acquire → active2325machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.07 seconds)2326machine: sending keys 'barfoobar\n'2327machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2328machine: waiting for file '/tmp/4'2329machine: (finished: waiting for file '/tmp/4', in 0.01 seconds)2330machine: waiting for success: grep uid=0 /tmp/42331machine # [ 49.202597] systemd-homed[525]: test-homed-user: changing state active → authenticating-for-acquire2332machine # [ 49.250315] systemd-homework[1172]: Provided password unlocks user record.2333machine # [ 49.896690] systemd-homework[1172]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2334machine # [ 50.028106] systemd-homework[1172]: Successfully re-activated LUKS device.2335machine # [ 50.049098] systemd-homework[1172]: Provided password unlocks user record.2336machine # [ 50.050455] systemd-homework[1172]: Discovered used loopback device /dev/loop1.2337machine # [ 50.051541] systemd-homework[1172]: Read embedded .identity file.2338machine # [ 50.070875] systemd-homework[1172]: Provided password unlocks user record.2339machine # [ 50.071986] systemd-homework[1172]: Reconciling user identities completed (host and header version were identical).2340machine # [ 50.073346] systemd-homework[1172]: Reconciling embedded user identity completed (host and embedded version were identical).2341machine # [ 50.080509] systemd-homework[1172]: Everything completed.2342machine # [ 50.086929] systemd-homed[525]: Home test-homed-user is signed exclusively by our key, accepting.2343machine # [ 50.095079] systemd-homed[525]: test-homed-user: changing state authenticating-for-acquire → active2344machine # [ 50.096492] sudo[1154]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired.2345machine # [ 50.101579] sudo[1154]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id2346machine # [ 50.118650] sudo[1154]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388)2347machine # [ 50.128569] sudo[1154]: pam_unix(sudo:session): session closed for user root2348machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.05 seconds)2349(finished: subtest: escalate to root from homed user, in 2.45 seconds)2350subtest: log out and deactivate homed user's home area2351machine: sending keys 'exit\n'2352machine: (finished: sending keys 'exit\n', in 0.05 seconds)2353machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive'2354machine # [ 50.217667] login[943]: pam_unix(login:session): session closed for user test-homed-user2355machine # [ 50.219467] login[943]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used.2356machine # [ 50.223738] systemd[1]: getty@tty1.service: Deactivated successfully.2357machine # [ 50.229923] systemd[1]: session-1.scope: Deactivated successfully.2358machine # [ 50.233277] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2359machine # [ 50.236305] systemd-logind[551]: Session 1 logged out. Waiting for processes to exit.2360machine # [ 50.238695] systemd[1]: Started Getty on tty1.2361machine # [ 50.240659] systemd-logind[551]: Removed session 1.2362machine # [ 60.329668] systemd[1]: Stopping User Manager for UID 60388...2363machine # [ 60.333686] systemd[1027]: Activating special unit Exit the Session...2364machine # [ 60.335739] systemd[1027]: Stopped target Main User Target.2365machine # [ 60.336648] systemd[1027]: Stopped Run user-specific NixOS activation.2366machine # [ 60.339183] systemd[1027]: Stopped target Basic System.2367machine # [ 60.340081] systemd[1027]: Stopped target Paths.2368machine # [ 60.340860] systemd[1027]: Stopped target Sockets.2369machine # [ 60.341960] systemd[1027]: Stopped target Timers.2370machine # [ 60.343321] systemd[1027]: Stopped Daily Cleanup of User's Temporary Directories.2371machine # [ 60.344793] systemd[1027]: Closed D-Bus User Message Bus Socket.2372machine # [ 60.346163] systemd[1027]: Stopped Create User Files and Directories.2373machine # [ 60.347872] systemd[1027]: Removed slice User Application Slice.2374machine # [ 60.349163] systemd[1027]: Reached target Shutdown.2375machine # [ 60.349971] systemd[1027]: Finished Exit the Session.2376machine # [ 60.351209] systemd[1027]: Reached target Exit the Session.2377machine # [ 60.355798] systemd-homed[525]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2378machine # [ 60.358508] systemd-homed[525]: test-homed-user: changing state active → deactivating2379machine # [ 60.360566] systemd-logind[551]: Removed session 2.2380machine # [ 60.362249] systemd[1]: user@60388.service: Deactivated successfully.2381machine # [ 60.367237] systemd[1]: Stopped User Manager for UID 60388.2382machine # [ 60.369397] systemd-homework[1252]: Successfully acquired home volume key from kernel keyring.2383machine # [ 60.371549] systemd-homework[1252]: Discarded unused 673.3M.2384machine # [ 60.381639] systemd-homework[1252]: Syncing completed.2385machine # [ 60.383854] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully.2386machine # [ 60.393254] systemd[1]: Stopping User Runtime Directory /run/user/60388...2387machine # [ 60.428558] systemd[1]: run-user-60388.mount: Deactivated successfully.2388machine # [ 60.433061] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully.2389machine # [ 60.434444] systemd[1]: Stopped User Runtime Directory /run/user/60388.2390machine # [ 60.450882] systemd-homework[1252]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2391machine # [ 60.599359] systemd-homework[1252]: Successfully re-activated LUKS device.2392machine # [ 60.600938] systemd-homework[1252]: Discovered used loopback device /dev/loop1.2393machine # [ 60.602146] systemd-homework[1252]: offset = 1048576, size = 799014912, image = 8011120642394machine # [ 60.611965] systemd-homework[1252]: Ready to resize image size 764M → 274M, partition size 762M → 272M, file system size 746M → 256M.2395machine # [ 60.614305] systemd-homework[1252]: Allocated additional 673.3M.2396machine # [ 60.764219] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 782237696 to 2684354562397machine # [ 60.622328] systemd-homework[1252]: File system resizing from 746M to 256M completed.2398machine # [ 60.624160] systemd-homework[1252]: Synchronized disk.2399machine # [ 60.712505] systemd-homework[1252]: LUKS device shrinking completed.2400machine # [ 60.858520] loop1: detected capacity change from 1560576 to 5570562401machine # [ 60.717146] systemd-homework[1252]: Refreshing loop device size completed.2402machine # [ 60.719199] systemd-homework[1252]: Shrinking of image file completed.2403machine # [ 60.812900] systemd-homework[1252]: Shrinking of partition completed.2404machine # [ 60.815210] systemd-homework[1252]: Synchronized disk.2405machine # [ 60.816923] systemd-homework[1252]: Resizing completed.2406machine # [ 60.962113] BTRFS info (device dm-0): last unmount of filesystem c2ae627e-424d-45f5-803a-163e9f21ab912407machine # [ 60.821489] systemd-homework[1252]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M.2408machine # [ 60.829284] systemd-homework[1252]: Unmounting completed.2409machine # [ 60.831695] systemd-homework[1252]: Discovered used LUKS device /dev/mapper/home-test-homed-user.2410machine # [ 60.835358] systemd-homework[1252]: Device home-test-homed-user is not active.2411machine # [ 60.846737] systemd-homed[525]: block device /sys/devices/virtual/block/dm-0 has been removed.2412machine # [ 60.852682] systemd-homework[1252]: Everything completed.2413machine # [ 60.864332] systemd-homed[525]: test-homed-user: changing state deactivating → inactive2414machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.44 seconds)2415(finished: subtest: log out and deactivate homed user's home area, in 11.49 seconds)2416subtest: ssh as homed user2417sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n'2418sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.77 seconds)2419sshClient: waiting for Please enter password for user to appear on tty 12420machine # [ 63.342706] systemd-homed[525]: test-homed-user: changing state inactive → activating-for-acquire2421machine # [ 63.346549] systemd-homework[1285]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2422machine # [ 63.416206] systemd-homed[525]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2423machine # [ 63.421445] systemd-homed[525]: test-homed-user: changing state activating-for-acquire → inactive2424machine # [ 63.427237] sshd-session[1281]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error2425machine # [ 63.431653] systemd-homed[525]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2426machine # [ 63.435524] sshd-session[1281]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation.2427machine # [ 63.441497] systemd-homed[525]: Home test-homed-user already deactivated, no automatic deactivation needed.2428machine # [ 63.445298] sshd-session[1281]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 56654 ssh2: ED25519 SHA256:zwE//QVnzR5Awj3yv/DwXJJsVgf7eZw/ZOcp95D2HO42429machine # [ 63.493252] sshd-session[1281]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0)2430machine # [ 63.505241] systemd-logind[551]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'.2431machine # [ 63.508749] systemd[1]: Starting User Runtime Directory /run/user/60388...2432machine # [ 63.526869] systemd[1]: Finished User Runtime Directory /run/user/60388.2433machine # [ 63.532558] systemd[1]: Started Session 3 of User test-homed-user.2434machine # [ 63.547072] sshd-session[1281]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2435machine # [ 63.550051] sshd-session[1281]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2436machine # [ 63.566294] systemd-homed[525]: test-homed-user: changing state inactive → activating2437machine # [ 63.570124] systemd-homework[1290]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2438machine # [ 63.576816] systemd-homed[525]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2439machine # [ 63.578962] systemd-homed[525]: test-homed-user: changing state activating → inactive2440sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.15 seconds)2441sshClient: sending keys 'barfoobar\n'2442sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2443machine: waiting for success: pgrep -u test-homed-user bash2444machine # [ 64.743375] systemd-homed[525]: test-homed-user: changing state inactive → activating2445machine # [ 64.785245] systemd-homework[1295]: Provided password unlocks user record.2446machine # [ 64.788434] systemd-homework[1295]: Successfully locked image file '/home/test-homed-user.home'.2447machine # [ 64.792360] systemd-homework[1295]: Backing file is fully allocated already.2448machine # [ 64.938693] loop1: detected capacity change from 0 to 5570562449machine # [ 64.796517] systemd-homework[1295]: Setting up loopback device /dev/loop1 completed.2450machine # [ 65.636090] systemd-homework[1295]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2451machine # [ 65.660406] systemd-homework[1295]: Provided password unlocks user record.2452machine # [ 65.665842] systemd-homework[1295]: Probing file system completed (found btrfs).2453machine # [ 65.667170] systemd-homework[1295]: No fsck for file system btrfs installed, ignoring.2454machine # [ 65.812833] BTRFS: device label test-homed-user devid 1 transid 17 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1295)2455machine # [ 65.814863] BTRFS info (device dm-0): first mount of filesystem c2ae627e-424d-45f5-803a-163e9f21ab912456machine # [ 65.816210] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2457machine # [ 65.820536] BTRFS info (device dm-0): enabling free space tree2458machine # [ 65.821098] BTRFS info (device dm-0): use zstd compression, level 12459machine # [ 65.678621] systemd-homework[1295]: Mounting file system completed.2460machine # [ 65.680163] systemd-homework[1295]: Discovered used loopback device /dev/loop1.2461machine # [ 65.681148] systemd-homework[1295]: offset = 1048576, size = 285212672, image = 2873098242462machine # [ 65.691050] systemd-homework[1295]: Ready to resize image size 274M → 764M, partition size 272M → 762M, file system size 256M → 746M.2463machine # [ 65.692979] systemd-homework[1295]: Growing of image file from 274M to 764M completed.2464machine # [ 65.839354] loop1: detected capacity change from 557056 to 15605762465machine # [ 65.696748] systemd-homework[1295]: Refreshing loop device size completed.2466machine # [ 65.712804] systemd-homework[1295]: Growing of partition completed.2467machine # [ 65.757239] systemd-homework[1295]: LUKS device growing completed.2468machine # [ 65.907298] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 7822376962469machine # [ 65.765218] systemd-homework[1295]: File system resizing from 256M to 746M completed.2470machine # [ 65.767133] systemd-homework[1295]: Synchronized disk.2471machine # [ 65.767930] systemd-homework[1295]: Synchronized disk.2472machine # [ 65.768637] systemd-homework[1295]: Resizing completed.2473machine # [ 65.769341] systemd-homework[1295]: Image size is 764M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2474machine # [ 65.770927] systemd-homework[1295]: Read embedded .identity file.2475machine # [ 65.790386] systemd-homework[1295]: Provided password unlocks user record.2476machine # [ 65.791458] systemd-homework[1295]: Reconciling user identities completed (host and header version were identical).2477machine # [ 65.792848] systemd-homework[1295]: Reconciling embedded user identity completed (host and embedded version were identical).2478machine # [ 65.795031] systemd-homework[1295]: Recursive changing of ownership not necessary, skipped.2479machine # [ 65.796472] systemd-homework[1295]: Synchronized disk.2480machine # [ 65.798580] systemd-homework[1295]: Moving to final mount point /home/test-homed-user completed.2481machine # [ 65.821280] systemd-homework[1295]: Activation completed.2482machine # [ 65.822512] systemd-homework[1295]: Image size is 762M, file system size is 746M, file system payload size is 746M, file system free is 739.9M.2483machine # [ 65.833365] systemd-homed[525]: Home test-homed-user is signed exclusively by our key, accepting.2484machine # [ 65.839825] systemd-homed[525]: test-homed-user: changing state activating → active2485machine # [ 65.849884] systemd[1]: Starting User Manager for UID 60388...2486machine # [ 65.874631] (systemd)[1338]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2487machine # [ 65.912586] (systemd)[1338]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2488machine # [ 65.918191] systemd-logind[551]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2489machine # [ 65.935178] systemd[1338]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2490machine # [ 66.006825] systemd[1338]: Queued start job for default target Main User Target.2491machine # [ 66.009692] systemd[1338]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2492machine # [ 66.012187] systemd[1338]: Created slice User Application Slice.2493machine # [ 66.014174] systemd[1338]: Started Daily Cleanup of User's Temporary Directories.2494machine # [ 66.015161] systemd[1338]: Reached target Paths.2495machine # [ 66.015885] systemd[1338]: Reached target Timers.2496machine # [ 66.018051] systemd[1338]: Starting D-Bus User Message Bus Socket...2497machine # [ 66.020170] systemd[1338]: Starting Create User Files and Directories...2498machine # [ 66.046109] systemd[1338]: Finished Create User Files and Directories.2499machine # [ 66.049356] systemd[1338]: Listening on D-Bus User Message Bus Socket.2500machine # [ 66.050425] systemd[1338]: Reached target Sockets.2501machine # [ 66.051743] systemd[1338]: Reached target Basic System.2502machine # [ 66.053564] systemd[1]: Started User Manager for UID 60388.2503machine # [ 66.056030] systemd[1338]: Starting Run user-specific NixOS activation...2504machine # [ 66.090449] systemd[1338]: Finished Run user-specific NixOS activation.2505machine # [ 66.091518] systemd[1338]: Reached target Main User Target.2506machine # [ 66.092938] systemd[1338]: Startup finished in 161ms.2507machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.16 seconds)2508sshClient: sending keys 'whoami > /tmp/5\n'2509sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.16 seconds)2510machine: waiting for file '/tmp/5'2511machine: (finished: waiting for file '/tmp/5', in 1.04 seconds)2512machine: must succeed: cat /tmp/52513machine: (finished: must succeed: cat /tmp/5, in 0.03 seconds)2514sshClient: sending keys 'exit\n'2515sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2516sshClient: sending keys 'exit\n'2517machine # [ 68.132579] sshd-session[1288]: Received disconnect from 2001:db8:1::2 port 56654:11: disconnected by user2518machine # [ 68.138339] sshd-session[1288]: Disconnected from user test-homed-user 2001:db8:1::2 port 566542519sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2520(finished: subtest: ssh as homed user, in 6.52 seconds)2521(finished: run the VM test script, in 69.46 seconds)2522machine # [ 68.143969] sshd-session[1281]: pam_unix(sshd:session): session closed for user test-homed-user2523machine # [ 68.150668] sshd-session[1281]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used.2524machine # [ 68.162705] systemd[1]: session-3.scope: Deactivated successfully.2525machine # [ 68.166728] systemd-logind[551]: Session 3 logged out. Waiting for processes to exit.2526machine # [ 68.173487] systemd-logind[551]: Removed session 3.2527sshClient # [ 68.168456] login[694]: pam_unix(login:session): session closed for user test-normal-user2528sshClient # [ 68.178762] systemd[1]: getty@tty1.service: Deactivated successfully.2529sshClient # [ 68.197117] systemd[1]: session-1.scope: Deactivated successfully.2530sshClient # [ 68.201412] systemd[1]: session-1.scope: Consumed 125ms CPU time over 35.966s wall clock time, 8.4M memory peak, 12K written to disk, 25.5K incoming IP traffic, 24.4K outgoing IP traffic.2531sshClient # [ 68.212566] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2532sshClient # [ 68.218480] systemd-logind[535]: Session 1 logged out. Waiting for processes to exit.2533sshClient # [ 68.225116] systemd[1]: Started Getty on tty1.2534sshClient # [ 68.228363] systemd-logind[535]: Removed session 1.2535test script finished in 69.86s2536cleanup2537kill QemuMachine (pid 47)2538machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2539machine # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2540machine # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2541machine # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2542kill QemuMachine (pid 48)2543sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/xahxrjs30p3mw0a42bqg9ikgkikskw8m-python3-3.14.8/bin/python3.14)2544sshClient # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2545sshClient # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2546sshClient # [2026-10-21T03:10:11Z INFO virtiofsd] Client disconnected, shutting down2547(finished: cleanup, in 0.32 seconds)2548additionally exposed symbols:2549 machine, sshClient,2550 vlan1,2551 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