vm-test-run-systemd-homed
checks.x86_64-linux.systemd-homed
· build #31
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7start all VMs8machine: starting vm9sshClient: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 48)12machine # Formatting '/build/vm-state-machine/tmp.z4X0bel94O', 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: 64900161-190e-4c06-aa87-ad9af5e870d917machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26sshClient # Disk image does not exist, creating the virtualisation disk image...27sshClient: QEMU running (pid 47)28sshClient # Formatting '/build/vm-state-sshClient/tmp.rHJaRUwkVb', fmt=raw size=107374182429sshClient # mke2fs 1.47.4 (6-Mar-2025)30sshClient # Discarding device blocks: 0/262144 done31sshClient # Creating filesystem with 262144 4k blocks and 65536 inodes32sshClient # Filesystem UUID: b9b842cc-39bc-4776-b2e3-9978102748a733sshClient # Superblock backups stored on blocks:34(finished: start all VMs, in 0.25 seconds)35sshClient # 32768, 98304, 163840, 22937636subtest: create systemd-homed user on first boot prompt37sshClient # 38machine: waiting for unit systemd-homed.service39sshClient # Allocating group tables: 0/8 done40machine: waiting for the VM to finish booting41sshClient # Writing inode tables: 0/8 done42sshClient # Creating journal (8192 blocks): done43sshClient # Writing superblocks and filesystem accounting information: 0/8 done44sshClient # 45sshClient # Virtualisation disk image created.46machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)47sshClient # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)48machine # 49machine # 50sshClient # 51sshClient # 52machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0053sshClient # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0054machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...55machine # 56machine # 57machine # 58machine # 59sshClient # Press Ctrl-B to configure iPXE (PCI 00:02.0)...60sshClient # 61sshClient # 62sshClient # 63sshClient # 64machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0065sshClient # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0066machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...67machine # 68machine # 69sshClient # Press Ctrl-B to configure iPXE (PCI 00:08.0)...70sshClient # 71sshClient # 72machine # Booting from ROM...73sshClient # Booting from ROM...74machine # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 7 15:23:00 UTC 202675machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/mf9d0lbxm1kvk46cqcp8ba1b8hk9q787-nixos-system-machine-test/init regInfo=/nix/store/12ws0g42idhvfbmb46ph035jqn9fvvy8-closure-info/registration console=ttyS0,115200n8 console=tty076machine # [ 0.000000] BIOS-provided physical RAM map:77machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable78machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved79machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved80machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable81machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved82machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved83machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved84machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved85machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved86machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved87machine # [ 0.000000] NX (Execute Disable) protection: active88machine # [ 0.000000] APIC: Static calls initialized89machine # [ 0.000000] SMBIOS 2.8 present.90machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201491machine # [ 0.000000] DMI: Memory slots populated: 1/192machine # [ 0.000000] Hypervisor detected: KVM93machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000094machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0095machine # [ 0.000001] kvm-clock: using sched offset of 540876101 cycles96sshClient # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 7 15:23:00 UTC 202697machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns98machine # [ 0.000005] tsc: Detected 2400.010 MHz processor99machine # [ 0.000813] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000100machine # [ 0.000851] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs101sshClient # [ 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/hqila2ch7l8gg9lqg7y9sk29i52vpcnw-nixos-system-sshClient-test/init regInfo=/nix/store/ysmwdjv9d3v8xpxhw1abw24wwsqh1jrv-closure-info/registration console=ttyS0,115200n8 console=tty0102machine # [ 0.000854] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT103sshClient # [ 0.000000] BIOS-provided physical RAM map:104machine # [ 0.002772] found SMP MP-table at [mem 0x000f5450-0x000f545f]105sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable106machine # [ 0.002784] Using GB pages for direct mapping107machine # [ 0.002825] RAMDISK: [mem 0x3e427000-0x3ffcffff]108sshClient # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved109machine # [ 0.002835] ACPI: Early table checksum verification disabled110sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved111machine # [ 0.002838] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )112sshClient # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable113machine # [ 0.002842] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)114sshClient # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved115sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved116machine # [ 0.002846] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)117sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved118machine # [ 0.002853] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)119sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved120machine # [ 0.002856] ACPI: FACS 0x000000003FFE0000 000040121sshClient # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved122machine # [ 0.002857] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)123sshClient # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved124machine # [ 0.002858] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)125sshClient # [ 0.000000] NX (Execute Disable) protection: active126sshClient # [ 0.000000] APIC: Static calls initialized127machine # [ 0.002860] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)128sshClient # [ 0.000000] SMBIOS 2.8 present.129machine # [ 0.002862] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)130sshClient # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014131sshClient # [ 0.000000] DMI: Memory slots populated: 1/1132machine # [ 0.002863] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]133sshClient # [ 0.000000] Hypervisor detected: KVM134machine # [ 0.002864] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]135sshClient # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000136sshClient # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00137machine # [ 0.002864] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]138sshClient # [ 0.000000] kvm-clock: using sched offset of 562552491 cycles139machine # [ 0.002865] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]140machine # [ 0.002865] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]141sshClient # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns142sshClient # [ 0.000005] tsc: Detected 2400.010 MHz processor143machine # [ 0.002866] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]144sshClient # [ 0.000812] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000145machine # [ 0.002866] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]146machine # [ 0.003363] No NUMA configuration found147sshClient # [ 0.000849] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs148machine # [ 0.003365] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]149sshClient # [ 0.000853] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT150machine # [ 0.003368] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]151sshClient # [ 0.002758] found SMP MP-table at [mem 0x000f5450-0x000f545f]152machine # [ 0.006684] Zone ranges:153sshClient # [ 0.002769] Using GB pages for direct mapping154machine # [ 0.006684] DMA [mem 0x0000000000001000-0x0000000000ffffff]155sshClient # [ 0.002873] RAMDISK: [mem 0x3e428000-0x3ffcffff]156machine # [ 0.006686] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]157sshClient # [ 0.002880] ACPI: Early table checksum verification disabled158machine # [ 0.006687] Normal empty159machine # [ 0.006688] Device empty160sshClient # [ 0.002882] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )161machine # [ 0.006689] Movable zone start for each node162machine # [ 0.006689] Early memory node ranges163sshClient # [ 0.002886] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)164machine # [ 0.006690] node 0: [mem 0x0000000000001000-0x000000000009efff]165sshClient # [ 0.002890] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)166machine # [ 0.006691] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]167machine # [ 0.006692] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]168sshClient # [ 0.002897] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)169sshClient # [ 0.002899] ACPI: FACS 0x000000003FFE0000 000040170machine # [ 0.006714] On node 0, zone DMA: 1 pages in unavailable ranges171machine # [ 0.007020] On node 0, zone DMA: 97 pages in unavailable ranges172sshClient # [ 0.002900] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)173machine # [ 0.028233] On node 0, zone DMA32: 40 pages in unavailable ranges174sshClient # [ 0.002902] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)175machine # [ 0.029368] ACPI: PM-Timer IO Port: 0x608176machine # [ 0.029382] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])177sshClient # [ 0.002903] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)178machine # [ 0.029416] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23179sshClient # [ 0.002905] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)180machine # [ 0.029419] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)181sshClient # [ 0.002906] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]182machine # [ 0.029421] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)183sshClient # [ 0.002907] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]184machine # [ 0.029422] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)185sshClient # [ 0.002908] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]186machine # [ 0.029423] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)187sshClient # [ 0.002908] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]188machine # [ 0.029423] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)189sshClient # [ 0.002909] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]190machine # [ 0.029426] ACPI: Using ACPI (MADT) for SMP configuration information191machine # [ 0.029426] ACPI: HPET id: 0x8086a201 base: 0xfed00000192sshClient # [ 0.002909] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]193machine # [ 0.029430] TSC deadline timer available194machine # [ 0.029435] CPU topo: Max. logical packages: 1195sshClient # [ 0.002910] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]196sshClient # [ 0.003391] No NUMA configuration found197machine # [ 0.029436] CPU topo: Max. logical dies: 1198machine # [ 0.029436] CPU topo: Max. dies per package: 1199sshClient # [ 0.003392] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]200machine # [ 0.029440] CPU topo: Max. threads per core: 1201sshClient # [ 0.003395] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]202machine # [ 0.029440] CPU topo: Num. cores per package: 1203sshClient # [ 0.005958] Zone ranges:204machine # [ 0.029440] CPU topo: Num. threads per package: 1205sshClient # [ 0.005959] DMA [mem 0x0000000000001000-0x0000000000ffffff]206machine # [ 0.029441] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs207sshClient # [ 0.005960] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]208sshClient # [ 0.005962] Normal empty209machine # [ 0.029460] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()210sshClient # [ 0.005962] Device empty211sshClient # [ 0.005963] Movable zone start for each node212machine # [ 0.029501] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]213sshClient # [ 0.005964] Early memory node ranges214sshClient # [ 0.005964] node 0: [mem 0x0000000000001000-0x000000000009efff]215machine # [ 0.029503] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]216sshClient # [ 0.005965] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]217machine # [ 0.029504] [mem 0x40000000-0xafffffff] available for PCI devices218machine # [ 0.029506] Booting paravirtualized kernel on KVM219sshClient # [ 0.005966] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]220sshClient # [ 0.005987] On node 0, zone DMA: 1 pages in unavailable ranges221machine # [ 0.029508] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns222sshClient # [ 0.006275] On node 0, zone DMA: 97 pages in unavailable ranges223machine # [ 0.033979] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1224sshClient # [ 0.025816] On node 0, zone DMA32: 40 pages in unavailable ranges225sshClient # [ 0.026926] ACPI: PM-Timer IO Port: 0x608226machine # [ 0.036540] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152227sshClient # [ 0.026939] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])228machine # [ 0.036590] kvm-guest: PV spinlocks disabled, single CPU229sshClient # [ 0.026967] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23230sshClient # [ 0.026970] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)231sshClient # [ 0.026972] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)232sshClient # [ 0.026973] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)233machine # [ 0.036592] 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/mf9d0lbxm1kvk46cqcp8ba1b8hk9q787-nixos-system-machine-test/init regInfo=/nix/store/12ws0g42idhvfbmb46ph035jqn9fvvy8-closure-info/registration console=ttyS0,115200n8 console=tty0234sshClient # [ 0.026974] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)235sshClient # [ 0.026974] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)236machine # [ 0.036686] Unknown kernel command line parameters "regInfo=/nix/store/12ws0g42idhvfbmb46ph035jqn9fvvy8-closure-info/registration", will be passed to user space.237sshClient # [ 0.026977] ACPI: Using ACPI (MADT) for SMP configuration information238machine # [ 0.036699] random: crng init done239sshClient # [ 0.026978] ACPI: HPET id: 0x8086a201 base: 0xfed00000240sshClient # [ 0.026982] TSC deadline timer available241machine # [ 0.036700] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes242sshClient # [ 0.026985] CPU topo: Max. logical packages: 1243machine # [ 0.036722] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)244sshClient # [ 0.026986] CPU topo: Max. logical dies: 1245sshClient # [ 0.026987] CPU topo: Max. dies per package: 1246machine # [ 0.036734] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)247sshClient # [ 0.026990] CPU topo: Max. threads per core: 1248machine # [ 0.036767] Fallback order for Node 0: 0249sshClient # [ 0.026991] CPU topo: Num. cores per package: 1250machine # [ 0.036770] Built 1 zonelists, mobility grouping on. Total pages: 262006251sshClient # [ 0.026991] CPU topo: Num. threads per package: 1252machine # [ 0.036771] Policy zone: DMA32253sshClient # [ 0.026991] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs254machine # [ 0.039666] mem auto-init: stack:all(zero), heap alloc:on, heap free:off255sshClient # [ 0.027010] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()256machine # [ 0.042223] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1257machine # [ 0.045282] allocated 2097152 bytes of page_ext258sshClient # [ 0.027048] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]259machine # [ 0.055389] ftrace: allocating 48731 entries in 192 pages260sshClient # [ 0.027050] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]261machine # [ 0.055391] ftrace: allocated 192 pages with 2 groups262machine # [ 0.056375] Dynamic Preempt: lazy263sshClient # [ 0.027051] [mem 0x40000000-0xafffffff] available for PCI devices264machine # [ 0.056523] rcu: Preemptible hierarchical RCU implementation.265sshClient # [ 0.027052] Booting paravirtualized kernel on KVM266machine # [ 0.056524] rcu: RCU event tracing is enabled.267sshClient # [ 0.027055] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns268machine # [ 0.056525] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.269machine # [ 0.056527] Trampoline variant of Tasks RCU enabled.270sshClient # [ 0.031513] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1271machine # [ 0.056527] Rude variant of Tasks RCU enabled.272sshClient # [ 0.034176] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152273machine # [ 0.056527] Tracing variant of Tasks RCU enabled.274sshClient # [ 0.034224] kvm-guest: PV spinlocks disabled, single CPU275machine # [ 0.056528] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.276machine # [ 0.056529] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1277machine # [ 0.056584] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.278machine # [ 0.056586] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.279sshClient # [ 0.034226] 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/hqila2ch7l8gg9lqg7y9sk29i52vpcnw-nixos-system-sshClient-test/init regInfo=/nix/store/ysmwdjv9d3v8xpxhw1abw24wwsqh1jrv-closure-info/registration console=ttyS0,115200n8 console=tty0280machine # [ 0.056587] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.281machine # [ 0.061041] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16282sshClient # [ 0.034315] Unknown kernel command line parameters "regInfo=/nix/store/ysmwdjv9d3v8xpxhw1abw24wwsqh1jrv-closure-info/registration", will be passed to user space.283machine # [ 0.061341] rcu: srcu_init: Setting srcu_struct sizes based on contention.284sshClient # [ 0.034327] random: crng init done285sshClient # [ 0.034328] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes286machine # [ 0.061348] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns287sshClient # [ 0.034348] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)288machine # [ 0.061458] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)289sshClient # [ 0.034361] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)290machine # [ 0.068823] Console: colour VGA+ 80x25291sshClient # [ 0.034392] Fallback order for Node 0: 0292machine # [ 0.068827] printk: legacy console [tty0] enabled293machine # [ 0.111970] printk: legacy console [ttyS0] enabled294sshClient # [ 0.034395] Built 1 zonelists, mobility grouping on. Total pages: 262006295sshClient # [ 0.034396] Policy zone: DMA32296machine # [ 0.312174] ACPI: Core revision 20250807297sshClient # [ 0.037126] mem auto-init: stack:all(zero), heap alloc:on, heap free:off298sshClient # [ 0.039546] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1299machine # [ 0.313750] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns300sshClient # [ 0.041985] allocated 2097152 bytes of page_ext301machine # [ 0.316660] APIC: Switch to symmetric I/O mode setup302sshClient # [ 0.051697] ftrace: allocating 48731 entries in 192 pages303machine # [ 0.318420] x2apic enabled304sshClient # [ 0.051699] ftrace: allocated 192 pages with 2 groups305sshClient # [ 0.052548] Dynamic Preempt: lazy306machine # [ 0.319667] APIC: Switched APIC routing to: physical x2apic307sshClient # [ 0.052737] rcu: Preemptible hierarchical RCU implementation.308sshClient # [ 0.052737] rcu: RCU event tracing is enabled.309machine # [ 0.322500] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1310sshClient # [ 0.052738] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.311sshClient # [ 0.052740] Trampoline variant of Tasks RCU enabled.312sshClient # [ 0.052740] Rude variant of Tasks RCU enabled.313machine # [ 0.324339] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns314sshClient # [ 0.052740] Tracing variant of Tasks RCU enabled.315machine # [ 0.327495] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)316sshClient # [ 0.052741] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.317sshClient # [ 0.052742] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1318machine # [ 0.329614] x86/cpu: User Mode Instruction Prevention (UMIP) activated319sshClient # [ 0.052767] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.320machine # [ 0.330668] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127321machine # [ 0.331493] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0322sshClient # [ 0.052769] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.323sshClient # [ 0.052770] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.324machine # [ 0.332498] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto325sshClient # [ 0.057265] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16326sshClient # [ 0.057845] rcu: srcu_init: Setting srcu_struct sizes based on contention.327machine # [ 0.333494] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl328sshClient # [ 0.057851] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns329machine # [ 0.335494] Transient Scheduler Attacks: Mitigation: Clear CPU buffers330machine # [ 0.336493] Spectre V2 : Mitigation: Enhanced / Automatic IBRS331sshClient # [ 0.057952] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)332sshClient # [ 0.065300] Console: colour VGA+ 80x25333machine # [ 0.337493] Speculative Return Stack Overflow: Mitigation: Safe RET334sshClient # [ 0.065303] printk: legacy console [tty0] enabled335sshClient # [ 0.108812] printk: legacy console [ttyS0] enabled336sshClient # [ 0.308995] ACPI: Core revision 20250807337sshClient # [ 0.310597] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns338machine # [ 0.338493] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization339sshClient # [ 0.313466] APIC: Switch to symmetric I/O mode setup340sshClient # [ 0.315317] x2apic enabled341machine # [ 0.340503] Spectre V2 : Enabling IBPB for BPF342sshClient # [ 0.316584] APIC: Switched APIC routing to: physical x2apic343machine # [ 0.342495] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier344machine # [ 0.343495] active return thunk: srso_alias_return_thunk345sshClient # [ 0.319452] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1346machine # [ 0.345533] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'347sshClient # [ 0.321329] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns348machine # [ 0.347493] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'349machine # [ 0.349493] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'350sshClient # [ 0.324486] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)351machine # [ 0.351493] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'352sshClient # [ 0.325606] x86/cpu: User Mode Instruction Prevention (UMIP) activated353machine # [ 0.353493] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'354sshClient # [ 0.326667] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127355machine # [ 0.355493] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'356sshClient # [ 0.328484] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0357machine # [ 0.356493] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'358sshClient # [ 0.329489] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto359machine # [ 0.358493] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'360sshClient # [ 0.331484] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl361machine # [ 0.360493] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'362sshClient # [ 0.333485] Transient Scheduler Attacks: Mitigation: Clear CPU buffers363machine # [ 0.361493] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256364sshClient # [ 0.334484] Spectre V2 : Mitigation: Enhanced / Automatic IBRS365machine # [ 0.363493] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64366sshClient # [ 0.335484] Speculative Return Stack Overflow: Mitigation: Safe RET367machine # [ 0.365493] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512368machine # [ 0.366493] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024369machine # [ 0.367493] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8370machine # [ 0.368493] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16371machine # [ 0.369494] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24372sshClient # [ 0.336484] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization373sshClient # [ 0.338493] Spectre V2 : Enabling IBPB for BPF374machine # [ 0.370493] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.375sshClient # [ 0.340485] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier376sshClient # [ 0.341485] active return thunk: srso_alias_return_thunk377sshClient # [ 0.343512] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'378sshClient # [ 0.344484] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'379sshClient # [ 0.346485] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'380sshClient # [ 0.347486] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'381sshClient # [ 0.348484] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'382sshClient # [ 0.349484] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'383sshClient # [ 0.350484] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'384sshClient # [ 0.351484] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'385sshClient # [ 0.353484] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'386sshClient # [ 0.354484] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256387sshClient # [ 0.356484] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64388sshClient # [ 0.357484] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512389sshClient # [ 0.358484] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024390sshClient # [ 0.359484] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8391sshClient # [ 0.360484] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16392sshClient # [ 0.361484] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24393machine # [ 0.405598] Freeing SMP alternatives memory: 44K394machine # [ 0.406496] pid_max: default: 32768 minimum: 301395sshClient # [ 0.362484] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.396machine # [ 0.408587] LSM: initializing lsm=capability,landlock,yama,bpf,ima397machine # [ 0.410512] landlock: Up and running.398machine # [ 0.411493] Yama: becoming mindful.399machine # [ 0.412709] LSM support for eBPF active400machine # [ 0.413619] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)401machine # [ 0.415524] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)402machine # [ 0.418164] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)403machine # [ 0.419068] Performance Events: Fam17h+ core perfctr, AMD PMU driver.404machine # [ 0.419498] ... version: 2405machine # [ 0.420495] ... bit width: 48406machine # [ 0.421566] ... generic counters: 6407machine # [ 0.422495] ... generic bitmap: 000000000000003f408machine # [ 0.423495] ... fixed-purpose counters: 0409machine # [ 0.424495] ... fixed-purpose bitmap: 0000000000000000410machine # [ 0.425495] ... value mask: 0000ffffffffffff411machine # [ 0.426495] ... max period: 00007fffffffffff412machine # [ 0.427494] ... global_ctrl mask: 000000000000003f413machine # [ 0.428627] signal: max sigframe size: 3376414machine # [ 0.429598] rcu: Hierarchical SRCU implementation.415machine # [ 0.430499] rcu: Max phase no-delay instances is 400.416sshClient # [ 0.398686] Freeing SMP alternatives memory: 44K417sshClient # [ 0.399486] pid_max: default: 32768 minimum: 301418sshClient # [ 0.400591] LSM: initializing lsm=capability,landlock,yama,bpf,ima419sshClient # [ 0.401592] landlock: Up and running.420machine # [ 0.436184] smp: Bringing up secondary CPUs ...421sshClient # [ 0.402484] Yama: becoming mindful.422machine # [ 0.436512] smp: Brought up 1 node, 1 CPU423sshClient # [ 0.403704] LSM support for eBPF active424machine # [ 0.437498] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)425sshClient # [ 0.405522] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)426sshClient # [ 0.406523] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)427machine # [ 0.438682] Memory: 941800K/1048024K available (17223K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98848K reserved, 0K cma-reserved)428machine # [ 0.439773] devtmpfs: initialized429machine # [ 0.440734] x86/mm: Memory block size: 128MB430sshClient # [ 0.409134] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)431sshClient # [ 0.409997] Performance Events: Fam17h+ core perfctr, AMD PMU driver.432machine # [ 0.442554] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)433sshClient # [ 0.410489] ... version: 2434sshClient # [ 0.411486] ... bit width: 48435machine # [ 0.443534] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).436sshClient # [ 0.412539] ... generic counters: 6437sshClient # [ 0.413485] ... generic bitmap: 000000000000003f438machine # [ 0.444580] pinctrl core: initialized pinctrl subsystem439sshClient # [ 0.414485] ... fixed-purpose counters: 0440sshClient # [ 0.415486] ... fixed-purpose bitmap: 0000000000000000441machine # [ 0.446943] PM: RTC time: 02:49:49, date: 2026-09-10442sshClient # [ 0.416486] ... value mask: 0000ffffffffffff443sshClient # [ 0.417485] ... max period: 00007fffffffffff444machine # [ 0.450657] NET: Registered PF_NETLINK/PF_ROUTE protocol family445sshClient # [ 0.418485] ... global_ctrl mask: 000000000000003f446machine # [ 0.451874] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations447sshClient # [ 0.419604] signal: max sigframe size: 3376448sshClient # [ 0.420589] rcu: Hierarchical SRCU implementation.449machine # [ 0.452519] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations450sshClient # [ 0.421490] rcu: Max phase no-delay instances is 400.451machine # [ 0.453666] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations452machine # [ 0.454507] audit: initializing netlink subsys (disabled)453machine # [ 0.455790] thermal_sys: Registered thermal governor 'fair_share'454sshClient # [ 0.427114] smp: Bringing up secondary CPUs ...455machine # [ 0.455792] thermal_sys: Registered thermal governor 'bang_bang'456sshClient # [ 0.427502] smp: Brought up 1 node, 1 CPU457machine # [ 0.456498] audit: type=2000 audit(1789008589.028:1): state=initialized audit_enabled=0 res=1458sshClient # [ 0.428488] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)459machine # [ 0.458497] thermal_sys: Registered thermal governor 'step_wise'460machine # [ 0.458499] thermal_sys: Registered thermal governor 'user_space'461sshClient # [ 0.429723] Memory: 941800K/1048024K available (17223K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98844K reserved, 0K cma-reserved)462machine # [ 0.459495] thermal_sys: Registered thermal governor 'power_allocator'463sshClient # [ 0.430721] devtmpfs: initialized464machine # [ 0.460521] cpuidle: using governor menu465sshClient # [ 0.431710] x86/mm: Memory block size: 128MB466machine # [ 0.463700] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5467sshClient # [ 0.433510] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)468machine # [ 0.464816] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]469sshClient # [ 0.434529] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).470machine # [ 0.465499] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry471sshClient # [ 0.435577] pinctrl core: initialized pinctrl subsystem472machine # [ 0.466509] PCI: Using configuration type 1 for base access473sshClient # [ 0.436826] PM: RTC time: 02:49:49, date: 2026-09-10474machine # [ 0.467736] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.475sshClient # [ 0.440383] NET: Registered PF_NETLINK/PF_ROUTE protocol family476sshClient # [ 0.441887] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations477machine # [ 0.472808] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages478sshClient # [ 0.442508] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations479machine # [ 0.473496] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page480sshClient # [ 0.443648] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations481sshClient # [ 0.444500] audit: initializing netlink subsys (disabled)482sshClient # [ 0.445840] thermal_sys: Registered thermal governor 'fair_share'483machine # [ 0.478496] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages484sshClient # [ 0.445842] thermal_sys: Registered thermal governor 'bang_bang'485machine # [ 0.479495] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page486sshClient # [ 0.446490] audit: type=2000 audit(1789008589.057:1): state=initialized audit_enabled=0 res=1487sshClient # [ 0.448489] thermal_sys: Registered thermal governor 'step_wise'488sshClient # [ 0.448490] thermal_sys: Registered thermal governor 'user_space'489sshClient # [ 0.449486] thermal_sys: Registered thermal governor 'power_allocator'490sshClient # [ 0.450507] cpuidle: using governor menu491machine # [ 0.490541] ACPI: Added _OSI(Module Device)492sshClient # [ 0.453723] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5493machine # [ 0.491496] ACPI: Added _OSI(Processor Device)494sshClient # [ 0.454799] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]495sshClient # [ 0.455489] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry496machine # [ 0.496495] ACPI: Added _OSI(Processor Aggregator Device)497sshClient # [ 0.456506] PCI: Using configuration type 1 for base access498sshClient # [ 0.457712] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.499machine # [ 0.502070] ACPI: 1 ACPI AML tables successfully acquired and loaded500sshClient # [ 0.462847] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages501sshClient # [ 0.463487] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page502machine # [ 0.507928] ACPI: Interpreter enabled503sshClient # [ 0.464487] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages504machine # [ 0.508515] ACPI: PM: (supports S0 S3 S4 S5)505machine # [ 0.511494] ACPI: Using IOAPIC for interrupt routing506machine # [ 0.512583] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug507sshClient # [ 0.471486] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page508machine # [ 0.515494] PCI: Using E820 reservations for host bridge windows509machine # [ 0.516661] ACPI: Enabled 2 GPEs in block 00 to 3F510sshClient # [ 0.479924] ACPI: Added _OSI(Module Device)511sshClient # [ 0.480486] ACPI: Added _OSI(Processor Device)512machine # [ 0.522696] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])513machine # [ 0.523501] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]514sshClient # [ 0.484845] ACPI: Added _OSI(Processor Aggregator Device)515machine # [ 0.524578] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]516machine # [ 0.525626] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]517machine # [ 0.527190] PCI host bridge to bus 0000:00518machine # [ 0.527501] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]519sshClient # [ 0.492132] ACPI: 1 ACPI AML tables successfully acquired and loaded520machine # [ 0.528501] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]521machine # [ 0.529496] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]522sshClient # [ 0.495747] ACPI: Interpreter enabled523machine # [ 0.530528] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]524sshClient # [ 0.496503] ACPI: PM: (supports S0 S3 S4 S5)525machine # [ 0.531498] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]526sshClient # [ 0.497487] ACPI: Using IOAPIC for interrupt routing527machine # [ 0.532496] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]528sshClient # [ 0.498596] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug529machine # [ 0.533497] pci_bus 0000:00: root bus resource [bus 00-ff]530machine # [ 0.534628] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint531sshClient # [ 0.504485] PCI: Using E820 reservations for host bridge windows532machine # [ 0.536441] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint533sshClient # [ 0.505646] ACPI: Enabled 2 GPEs in block 00 to 3F534machine # [ 0.539593] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]535sshClient # [ 0.512654] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])536machine # [ 0.540524] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]537sshClient # [ 0.513492] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]538machine # [ 0.541549] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]539sshClient # [ 0.514566] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]540machine # [ 0.542754] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]541sshClient # [ 0.515617] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]542sshClient # [ 0.517132] PCI host bridge to bus 0000:00543machine # [ 0.544623] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint544sshClient # [ 0.517492] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]545sshClient # [ 0.518492] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]546machine # [ 0.547578] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]547sshClient # [ 0.519488] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]548machine # [ 0.548510] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]549sshClient # [ 0.520514] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]550machine # [ 0.549549] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]551sshClient # [ 0.521487] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]552machine # [ 0.550510] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]553sshClient # [ 0.522487] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]554machine # [ 0.552709] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555sshClient # [ 0.523487] pci_bus 0000:00: root bus resource [bus 00-ff]556sshClient # [ 0.524644] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint557machine # [ 0.555514] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]558sshClient # [ 0.526437] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint559machine # [ 0.556510] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]560machine # [ 0.557549] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]561machine # [ 0.559818] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint562sshClient # [ 0.529578] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]563sshClient # [ 0.530542] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]564machine # [ 0.562513] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]565sshClient # [ 0.531539] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]566machine # [ 0.563510] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]567sshClient # [ 0.532734] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]568machine # [ 0.564549] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]569sshClient # [ 0.534529] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint570machine # [ 0.566920] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint571sshClient # [ 0.537521] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]572machine # [ 0.569513] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]573sshClient # [ 0.538501] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]574machine # [ 0.570512] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]575sshClient # [ 0.539540] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]576machine # [ 0.571549] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]577sshClient # [ 0.540500] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]578machine # [ 0.573760] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint579sshClient # [ 0.542727] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint580machine # [ 0.575524] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]581machine # [ 0.576511] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]582sshClient # [ 0.545630] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]583machine # [ 0.577553] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]584sshClient # [ 0.546501] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]585sshClient # [ 0.547539] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]586machine # [ 0.579788] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint587sshClient # [ 0.549711] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint588machine # [ 0.582380] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]589machine # [ 0.583511] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]590sshClient # [ 0.552519] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]591machine # [ 0.584549] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]592sshClient # [ 0.553500] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]593sshClient # [ 0.554539] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]594machine # [ 0.586764] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint595sshClient # [ 0.556724] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint596machine # [ 0.589100] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]597machine # [ 0.589511] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]598sshClient # [ 0.559225] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]599machine # [ 0.590550] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]600sshClient # [ 0.560500] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]601machine # [ 0.591510] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]602sshClient # [ 0.561539] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]603machine # [ 0.593709] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint604sshClient # [ 0.563813] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint605machine # [ 0.595543] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]606sshClient # [ 0.566386] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]607machine # [ 0.596549] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]608sshClient # [ 0.567500] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]609sshClient # [ 0.568548] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]610machine # [ 0.598721] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint611sshClient # [ 0.570711] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint612machine # [ 0.601708] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]613machine # [ 0.602511] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]614sshClient # [ 0.573125] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]615machine # [ 0.603549] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]616sshClient # [ 0.573501] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]617sshClient # [ 0.574540] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]618machine # [ 0.605801] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint619sshClient # [ 0.576947] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint620machine # [ 0.608044] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]621machine # [ 0.608510] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]622sshClient # [ 0.578521] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]623machine # [ 0.609549] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]624sshClient # [ 0.579501] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]625sshClient # [ 0.580539] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]626sshClient # [ 0.581500] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]627sshClient # [ 0.583732] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint628sshClient # [ 0.585514] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]629sshClient # [ 0.586540] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]630machine # [ 0.611767] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint631sshClient # [ 0.589030] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint632sshClient # [ 0.591032] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]633machine # [ 0.615362] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]634sshClient # [ 0.591501] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]635machine # [ 0.616886] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint636sshClient # [ 0.592539] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]637machine # [ 0.618562] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]638sshClient # [ 0.594755] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint639machine # [ 0.619858] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint640sshClient # [ 0.596525] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]641machine # [ 0.621576] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]642sshClient # [ 0.597500] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]643machine # [ 0.622962] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint644sshClient # [ 0.598539] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]645machine # [ 0.624514] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]646machine # [ 0.625987] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint647machine # [ 0.627168] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO648machine # [ 0.629013] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint649sshClient # [ 0.600776] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint650machine # [ 0.630562] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]651sshClient # [ 0.604037] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]652machine # [ 0.631510] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]653sshClient # [ 0.604847] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint654machine # [ 0.633245] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint655sshClient # [ 0.606552] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]656machine # [ 0.636252] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]657sshClient # [ 0.607846] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint658sshClient # [ 0.609538] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]659sshClient # [ 0.610886] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint660machine # [ 0.644067] ACPI: PCI: Interrupt link LNKA configured for IRQ 10661machine # [ 0.644660] ACPI: PCI: Interrupt link LNKB configured for IRQ 10662sshClient # [ 0.612501] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]663machine # [ 0.645651] ACPI: PCI: Interrupt link LNKC configured for IRQ 11664sshClient # [ 0.614281] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint665machine # [ 0.646654] ACPI: PCI: Interrupt link LNKD configured for IRQ 11666machine # [ 0.647654] ACPI: PCI: Interrupt link LNKE configured for IRQ 10667sshClient # [ 0.616175] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO668machine # [ 0.648653] ACPI: PCI: Interrupt link LNKF configured for IRQ 10669sshClient # [ 0.617984] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint670machine # [ 0.649655] ACPI: PCI: Interrupt link LNKG configured for IRQ 11671machine # [ 0.650648] ACPI: PCI: Interrupt link LNKH configured for IRQ 11672sshClient # [ 0.620565] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]673machine # [ 0.651560] ACPI: PCI: Interrupt link GSIA configured for IRQ 16674sshClient # [ 0.621501] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]675machine # [ 0.652517] ACPI: PCI: Interrupt link GSIB configured for IRQ 17676machine # [ 0.653512] ACPI: PCI: Interrupt link GSIC configured for IRQ 18677sshClient # [ 0.623252] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint678machine # [ 0.654513] ACPI: PCI: Interrupt link GSID configured for IRQ 19679sshClient # [ 0.625443] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]680machine # [ 0.655513] ACPI: PCI: Interrupt link GSIE configured for IRQ 20681machine # [ 0.656517] ACPI: PCI: Interrupt link GSIF configured for IRQ 21682machine # [ 0.657518] ACPI: PCI: Interrupt link GSIG configured for IRQ 22683machine # [ 0.658519] ACPI: PCI: Interrupt link GSIH configured for IRQ 23684machine # [ 0.660753] iommu: Default domain type: Translated685sshClient # [ 0.633218] ACPI: PCI: Interrupt link LNKA configured for IRQ 10686machine # [ 0.661506] iommu: DMA domain TLB invalidation policy: lazy mode687sshClient # [ 0.634647] ACPI: PCI: Interrupt link LNKB configured for IRQ 10688machine # [ 0.662806] ACPI: bus type USB registered689sshClient # [ 0.635649] ACPI: PCI: Interrupt link LNKC configured for IRQ 11690machine # [ 0.663584] usbcore: registered new interface driver usbfs691sshClient # [ 0.636642] ACPI: PCI: Interrupt link LNKD configured for IRQ 11692machine # [ 0.664518] usbcore: registered new interface driver hub693sshClient # [ 0.637641] ACPI: PCI: Interrupt link LNKE configured for IRQ 10694machine # [ 0.665525] usbcore: registered new device driver usb695sshClient # [ 0.638640] ACPI: PCI: Interrupt link LNKF configured for IRQ 10696machine # [ 0.667592] NetLabel: Initializing697machine # [ 0.668495] NetLabel: domain hash size = 128698sshClient # [ 0.639642] ACPI: PCI: Interrupt link LNKG configured for IRQ 11699machine # [ 0.669495] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO700sshClient # [ 0.640639] ACPI: PCI: Interrupt link LNKH configured for IRQ 11701machine # [ 0.670534] NetLabel: unlabeled traffic allowed by default702sshClient # [ 0.641559] ACPI: PCI: Interrupt link GSIA configured for IRQ 16703machine # [ 0.671512] PCI: Using ACPI for IRQ routing704sshClient # [ 0.642504] ACPI: PCI: Interrupt link GSIB configured for IRQ 17705sshClient # [ 0.643508] ACPI: PCI: Interrupt link GSIC configured for IRQ 18706sshClient # [ 0.644508] ACPI: PCI: Interrupt link GSID configured for IRQ 19707sshClient # [ 0.645507] ACPI: PCI: Interrupt link GSIE configured for IRQ 20708sshClient # [ 0.646503] ACPI: PCI: Interrupt link GSIF configured for IRQ 21709sshClient # [ 0.647502] ACPI: PCI: Interrupt link GSIG configured for IRQ 22710sshClient # [ 0.648509] ACPI: PCI: Interrupt link GSIH configured for IRQ 23711sshClient # [ 0.650624] iommu: Default domain type: Translated712sshClient # [ 0.651496] iommu: DMA domain TLB invalidation policy: lazy mode713sshClient # [ 0.652788] ACPI: bus type USB registered714sshClient # [ 0.653567] usbcore: registered new interface driver usbfs715sshClient # [ 0.654505] usbcore: registered new interface driver hub716sshClient # [ 0.655513] usbcore: registered new device driver usb717sshClient # [ 0.657540] NetLabel: Initializing718sshClient # [ 0.658485] NetLabel: domain hash size = 128719sshClient # [ 0.659486] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO720sshClient # [ 0.660525] NetLabel: unlabeled traffic allowed by default721sshClient # [ 0.661502] PCI: Using ACPI for IRQ routing722machine # [ 0.779258] pci 0000:00:01.0: vgaarb: setting as boot VGA device723machine # [ 0.779490] pci 0000:00:01.0: vgaarb: bridge control possible724machine # [ 0.779490] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none725machine # [ 0.779499] vgaarb: loaded726machine # [ 0.780681] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0727machine # [ 0.781495] hpet0: 3 comparators, 64-bit 100.000000 MHz counter728machine # [ 0.785798] clocksource: Switched to clocksource kvm-clock729machine # [ 0.790131] VFS: Disk quotas dquot_6.6.0730machine # [ 0.791431] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)731machine # [ 0.793735] pnp: PnP ACPI init732machine # [ 0.795012] ACPI: IRQ 4 override to edge(!), high(!)733machine # [ 0.796766] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved734machine # [ 0.799384] pnp: PnP ACPI: found 6 devices735sshClient # [ 0.773125] pci 0000:00:01.0: vgaarb: setting as boot VGA device736machine # [ 0.807672] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns737sshClient # [ 0.773481] pci 0000:00:01.0: vgaarb: bridge control possible738machine # [ 0.810256] clocksource: Switched to clocksource acpi_pm739sshClient # [ 0.773481] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none740machine # [ 0.811988] NET: Registered PF_INET protocol family741sshClient # [ 0.773490] vgaarb: loaded742sshClient # [ 0.774636] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0743machine # [ 0.813805] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)744sshClient # [ 0.775486] hpet0: 3 comparators, 64-bit 100.000000 MHz counter745sshClient # [ 0.781588] clocksource: Switched to clocksource kvm-clock746sshClient # [ 0.785953] VFS: Disk quotas dquot_6.6.0747sshClient # [ 0.787243] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)748sshClient # [ 0.789530] pnp: PnP ACPI init749sshClient # [ 0.790853] ACPI: IRQ 4 override to edge(!), high(!)750sshClient # [ 0.792574] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved751machine # [ 0.833692] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)752sshClient # [ 0.795298] pnp: PnP ACPI: found 6 devices753machine # [ 0.836368] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)754machine # [ 0.838709] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)755machine # [ 0.841030] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)756machine # [ 0.843269] TCP: Hash tables configured (established 8192 bind 8192)757sshClient # [ 0.803565] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns758machine # [ 0.845332] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)759sshClient # [ 0.806181] clocksource: Switched to clocksource acpi_pm760machine # [ 0.847579] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)761sshClient # [ 0.807941] NET: Registered PF_INET protocol family762machine # [ 0.849604] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)763sshClient # [ 0.809751] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)764machine # [ 0.851757] NET: Registered PF_UNIX/PF_LOCAL protocol family765machine # [ 0.853548] NET: Registered PF_XDP protocol family766machine # [ 0.855104] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]767machine # [ 0.856977] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]768machine # [ 0.858854] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]769machine # [ 0.860922] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]770machine # [ 0.862989] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]771machine # [ 0.865189] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]772machine # [ 0.868008] ACPI: \_SB_.GSIA: Enabled at IRQ 16773sshClient # [ 0.828435] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)774machine # [ 0.870960] ACPI: \_SB_.GSIB: Enabled at IRQ 17775sshClient # [ 0.831141] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)776machine # [ 0.873823] ACPI: \_SB_.GSIC: Enabled at IRQ 18777sshClient # [ 0.833535] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)778machine # [ 0.876678] ACPI: \_SB_.GSID: Enabled at IRQ 19779sshClient # [ 0.835932] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)780machine # [ 0.879810] PCI: CLS 0 bytes, default 64781sshClient # [ 0.838118] TCP: Hash tables configured (established 8192 bind 8192)782sshClient # [ 0.840078] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)783machine # [ 0.881417] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns784sshClient # [ 0.842341] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)785machine # [ 0.884490] Trying to unpack rootfs image as initramfs...786sshClient # [ 0.844480] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)787sshClient # [ 0.846771] NET: Registered PF_UNIX/PF_LOCAL protocol family788sshClient # [ 0.848587] NET: Registered PF_XDP protocol family789sshClient # [ 0.850206] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]790sshClient # [ 0.852128] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]791sshClient # [ 0.854068] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]792sshClient # [ 0.856126] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]793sshClient # [ 0.858169] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]794sshClient # [ 0.860200] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]795sshClient # [ 0.863116] ACPI: \_SB_.GSIA: Enabled at IRQ 16796sshClient # [ 0.866044] ACPI: \_SB_.GSIB: Enabled at IRQ 17797sshClient # [ 0.869053] ACPI: \_SB_.GSIC: Enabled at IRQ 18798sshClient # [ 0.871884] ACPI: \_SB_.GSID: Enabled at IRQ 19799sshClient # [ 0.874432] PCI: CLS 0 bytes, default 64800sshClient # [ 0.876059] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns801sshClient # [ 0.879140] Trying to unpack rootfs image as initramfs...802machine # [ 0.935625] Initialise system trusted keyrings803machine # [ 0.937345] workingset: timestamp_bits=40 max_order=18 bucket_order=0804machine # [ 0.963675] Key type asymmetric registered805machine # [ 0.965028] Asymmetric key parser 'x509' registered806sshClient # [ 0.929615] Initialise system trusted keyrings807machine # [ 0.970258] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)808sshClient # [ 0.933869] workingset: timestamp_bits=40 max_order=18 bucket_order=0809machine # [ 0.976255] io scheduler mq-deadline registered810machine # [ 0.977707] io scheduler kyber registered811machine # [ 0.981848] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled812machine # [ 0.986216] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A813machine # [ 0.994569] Linux agpgart interface v0.103814machine # [ 0.996031] ACPI: bus type drm_connector registered815sshClient # [ 0.960170] Key type asymmetric registered816machine # [ 1.001354] usbcore: registered new interface driver usbserial_generic817sshClient # [ 0.961566] Asymmetric key parser 'x509' registered818machine # [ 1.003341] usbserial: USB Serial support registered for generic819sshClient # [ 0.964755] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)820machine # [ 1.009200] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.821machine # [ 1.009200] Please enable it if your BIOS has the CPPC option.822sshClient # [ 0.971718] io scheduler mq-deadline registered823machine # [ 1.013256] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled824sshClient # [ 0.973160] io scheduler kyber registered825sshClient # [ 0.977282] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled826sshClient # [ 0.979530] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A827machine # [ 1.022335] drop_monitor: Initializing network drop monitor service828machine # [ 1.024389] NET: Registered PF_INET6 protocol family829sshClient # [ 0.987885] Linux agpgart interface v0.103830machine # [ 1.029776] Segment Routing with IPv6831sshClient # [ 0.989262] ACPI: bus type drm_connector registered832machine # [ 1.033210] In-situ OAM (IOAM) with IPv6833machine # [ 1.036486] IPI shorthand broadcast: enabled834sshClient # [ 0.995835] usbcore: registered new interface driver usbserial_generic835sshClient # [ 0.997821] usbserial: USB Serial support registered for generic836sshClient # [ 1.003689] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.837machine # [ 1.045429] sched_clock: Marking stable (786029948, 259142831)->(1266817813, -221645034)838sshClient # [ 1.003689] Please enable it if your BIOS has the CPPC option.839sshClient # [ 1.007727] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled840machine # [ 1.054446] registered taskstats version 1841machine # [ 1.056098] Loading compiled-in X.509 certificates842sshClient # [ 1.016841] drop_monitor: Initializing network drop monitor service843sshClient # [ 1.018906] NET: Registered PF_INET6 protocol family844sshClient # [ 1.024233] Segment Routing with IPv6845sshClient # [ 1.028716] In-situ OAM (IOAM) with IPv6846sshClient # [ 1.030386] IPI shorthand broadcast: enabled847machine # [ 1.077313] Demotion targets for Node 0: null848machine # [ 1.080246] Key type .fscrypt registered849sshClient # [ 1.039134] sched_clock: Marking stable (778030074, 260630848)->(1260859101, -222198179)850machine # [ 1.081521] Key type fscrypt-provisioning registered851machine # [ 1.086316] ima: No TPM chip found, activating TPM-bypass!852machine # [ 1.088008] ima: Allocated hash algorithm: sha1853sshClient # [ 1.046956] registered taskstats version 1854sshClient # [ 1.048553] Loading compiled-in X.509 certificates855machine # [ 1.093222] ima: No architecture policies found856machine # [ 1.094905] PM: Magic number: 10:765:813857machine # [ 1.099118] RAS: Correctable Errors collector initialized.858machine # [ 1.110024] clk: Disabling unused clocks859sshClient # [ 1.070735] Demotion targets for Node 0: null860sshClient # [ 1.072268] Key type .fscrypt registered861machine # [ 1.115205] PM: genpd: Disabling unused power domains862sshClient # [ 1.075690] Key type fscrypt-provisioning registered863sshClient # [ 1.077346] ima: No TPM chip found, activating TPM-bypass!864sshClient # [ 1.083682] ima: Allocated hash algorithm: sha1865sshClient # [ 1.085147] ima: No architecture policies found866sshClient # [ 1.088874] PM: Magic number: 10:765:813867sshClient # [ 1.093143] RAS: Correctable Errors collector initialized.868sshClient # [ 1.102917] clk: Disabling unused clocks869sshClient # [ 1.108688] PM: genpd: Disabling unused power domains870machine # [ 1.268981] Freeing initrd memory: 28324K871machine # [ 1.273066] Freeing unused decrypted memory: 2028K872machine # [ 1.276862] Freeing unused kernel image (initmem) memory: 3644K873machine # [ 1.278815] Write protecting the kernel read-only data: 32768k874machine # [ 1.281643] Freeing unused kernel image (text/rodata gap) memory: 1208K875machine # [ 1.284205] Freeing unused kernel image (rodata/data gap) memory: 752K876sshClient # [ 1.253937] Freeing initrd memory: 28320K877sshClient # [ 1.257949] Freeing unused decrypted memory: 2028K878sshClient # [ 1.261483] Freeing unused kernel image (initmem) memory: 3644K879sshClient # [ 1.263505] Write protecting the kernel read-only data: 32768k880sshClient # [ 1.266330] Freeing unused kernel image (text/rodata gap) memory: 1208K881sshClient # [ 1.268873] Freeing unused kernel image (rodata/data gap) memory: 752K882machine # [ 1.337818] x86/mm: Checked W+X mappings: passed, no W+X pages found.883machine # [ 1.339833] Run /init as init process884machine # [ 1.352262] systemd[1]: Inserted module 'autofs4'885sshClient # [ 1.322400] x86/mm: Checked W+X mappings: passed, no W+X pages found.886sshClient # [ 1.324466] Run /init as init process887machine # [ 1.370354] fuse: init (API version 7.45)888machine # [ 1.377086] ACPI: \_SB_.GSIG: Enabled at IRQ 22889sshClient # [ 1.336108] systemd[1]: Inserted module 'autofs4'890machine # [ 1.381052] ACPI: \_SB_.GSIH: Enabled at IRQ 23891machine # [ 1.385874] ACPI: \_SB_.GSIE: Enabled at IRQ 20892machine # [ 1.391551] ACPI: \_SB_.GSIF: Enabled at IRQ 21893sshClient # [ 1.354030] fuse: init (API version 7.45)894sshClient # [ 1.360745] ACPI: \_SB_.GSIG: Enabled at IRQ 22895sshClient # [ 1.364617] ACPI: \_SB_.GSIH: Enabled at IRQ 23896sshClient # [ 1.369446] ACPI: \_SB_.GSIE: Enabled at IRQ 20897sshClient # [ 1.373244] ACPI: \_SB_.GSIF: Enabled at IRQ 21898machine # [ 1.428323] systemd[1]: Successfully made /usr/ read-only.899sshClient # [ 1.409792] systemd[1]: Successfully made /usr/ read-only.900machine # [ 1.768485] systemd[1]: systemd 262-2ff84cf 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)901machine # [ 1.792924] systemd[1]: Detected virtualization kvm.902machine # [ 1.797525] systemd[1]: Detected architecture x86-64.903machine # [ 1.802021] systemd[1]: Running in initrd.904machine # [ 1.806923] systemd[1]: Initializing machine ID from random generator.905sshClient # [ 1.749220] systemd[1]: systemd 262-2ff84cf 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)906sshClient # [ 1.771801] systemd[1]: Detected virtualization kvm.907machine # [ 1.812810] systemd[1]: Hostname set to <machine>.908sshClient # [ 1.775870] systemd[1]: Detected architecture x86-64.909sshClient # [ 1.779852] systemd[1]: Running in initrd.910sshClient # [ 1.784256] systemd[1]: Initializing machine ID from random generator.911sshClient # [ 1.789539] systemd[1]: Hostname set to <sshClient>.912machine # [ 1.905329] systemd[1]: bpf-restrict-fs: LSM BPF program attached913sshClient # [ 1.878223] systemd[1]: bpf-restrict-fs: LSM BPF program attached914machine # [ 1.948843] systemd[1]: Queued start job for default target Initrd Default Target.915machine # [ 1.954954] systemd[1]: Created slice Slice /system/modprobe.916machine # [ 1.957088] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.917machine # [ 1.959629] systemd[1]: Expecting device /dev/disk/by-label/nixos...918machine # [ 1.961664] systemd[1]: Reached target Path Units.919machine # [ 1.963288] systemd[1]: Reached target Slice Units.920sshClient # [ 1.921475] systemd[1]: Queued start job for default target Initrd Default Target.921machine # [ 1.964958] systemd[1]: Reached target Swaps.922machine # [ 1.966554] systemd[1]: Reached target Timer Units.923machine # [ 1.968362] systemd[1]: Listening on D-Bus System Message Bus Socket.924sshClient # [ 1.927379] systemd[1]: Created slice Slice /system/modprobe.925machine # [ 1.970562] systemd[1]: Listening on Journal Socket (/dev/log).926sshClient # [ 1.929502] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.927machine # [ 1.972677] systemd[1]: Listening on Journal Sockets.928sshClient # [ 1.932052] systemd[1]: Expecting device /dev/disk/by-label/nixos...929machine # [ 1.974460] systemd[1]: Listening on udev Kernel Socket.930sshClient # [ 1.934050] systemd[1]: Reached target Path Units.931machine # [ 1.976286] systemd[1]: Reached target Socket Units.932sshClient # [ 1.935678] systemd[1]: Reached target Slice Units.933sshClient # [ 1.937283] systemd[1]: Reached target Swaps.934sshClient # [ 1.938777] systemd[1]: Reached target Timer Units.935sshClient # [ 1.940559] systemd[1]: Listening on D-Bus System Message Bus Socket.936sshClient # [ 1.942879] systemd[1]: Listening on Journal Socket (/dev/log).937sshClient # [ 1.945027] systemd[1]: Listening on Journal Sockets.938sshClient # [ 1.946840] systemd[1]: Listening on udev Kernel Socket.939sshClient # [ 1.948594] systemd[1]: Reached target Socket Units.940machine # [ 1.979065] systemd[1]: Starting Create List of Static Device Nodes...941machine # [ 2.000444] systemd[1]: Starting Load Kernel Module 9pnet_virtio...942sshClient # [ 1.951355] systemd[1]: Starting Create List of Static Device Nodes...943machine # [ 2.013271] systemd[1]: Starting Load Kernel Module configfs...944sshClient # [ 1.972501] systemd[1]: Starting Load Kernel Module 9pnet_virtio...945sshClient # [ 1.982862] systemd[1]: Starting Load Kernel Module configfs...946machine # [ 2.027273] systemd[1]: Starting Journal Service...947sshClient # [ 1.999181] systemd[1]: Starting Journal Service...948machine # [ 2.044285] systemd[1]: Starting Load Kernel Modules...949machine # [ 2.051737] netfs: FS-Cache loaded950sshClient # [ 2.013766] systemd[1]: Starting Load Kernel Modules...951machine # [ 2.055314] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os952sshClient # [ 2.023774] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os953machine # [ 2.068621] systemd[1]: Starting Coldplug All udev Devices...954sshClient # [ 2.028205] netfs: FS-Cache loaded955machine # [ 2.072915] 9pnet: Installing 9P2000 support956sshClient # [ 2.033922] systemd[1]: Starting Coldplug All udev Devices...957sshClient # [ 2.046073] 9pnet: Installing 9P2000 support958machine # [ 2.097557] systemd[1]: Finished Create List of Static Device Nodes.959machine # [ 2.101343] systemd-journald[67]: Collecting audit messages is disabled.960sshClient # [ 2.061194] systemd[1]: Finished Create List of Static Device Nodes.961sshClient # [ 2.064026] systemd-journald[67]: Collecting audit messages is disabled.962machine # [ 2.111201] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.963sshClient # [ 2.078967] systemd[1]: modprobe@configfs.service: Deactivated successfully.964machine # [ 2.122300] systemd[1]: Finished Load Kernel Module 9pnet_virtio.965sshClient # [ 2.089321] systemd[1]: Finished Load Kernel Module configfs.966machine # [ 2.131947] systemd[1]: modprobe@configfs.service: Deactivated successfully.967machine # [ 2.134441] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.968sshClient # [ 2.098313] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.969machine # [ 2.145030] systemd[1]: Finished Load Kernel Module configfs.970sshClient # [ 2.102910] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.971machine # [ 2.149207] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev972sshClient # [ 2.112313] systemd[1]: Finished Load Kernel Module 9pnet_virtio.973machine # [ 2.157209] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config974sshClient # [ 2.119511] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config975sshClient # [ 2.125706] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev976machine # [ 2.175451] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...977sshClient # [ 2.140906] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...978machine # [ 2.196398] systemd[1]: Finished Load Kernel Modules.979sshClient # [ 2.163821] systemd[1]: Finished Load Kernel Modules.980machine # [ 2.208773] systemd[1]: Starting Apply Kernel Variables...981sshClient # [ 2.175180] systemd[1]: Starting Apply Kernel Variables...982machine # [ 2.229296] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.983sshClient # [ 2.194852] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.984machine # [ 2.245101] systemd[1]: Starting Create Static Device Nodes in /dev...985sshClient # [ 2.209085] systemd[1]: Starting Create Static Device Nodes in /dev...986machine # [ 2.265852] systemd[1]: Finished Apply Kernel Variables.987sshClient # [ 2.228245] systemd[1]: Finished Apply Kernel Variables.988machine # [ 2.286317] systemd[1]: Finished Create Static Device Nodes in /dev.989sshClient # [ 2.250866] systemd[1]: Finished Create Static Device Nodes in /dev.990machine # [ 2.292579] systemd[1]: Reached target Preparation for Local File Systems.991sshClient # [ 2.257054] systemd[1]: Reached target Preparation for Local File Systems.992machine # [ 2.300356] systemd[1]: Reached target Local File Systems.993sshClient # [ 2.263777] systemd[1]: Reached target Local File Systems.994machine # [ 2.309544] systemd[1]: Starting Rule-based Manager for Device Events and Files...995sshClient # [ 2.272988] systemd[1]: Starting Rule-based Manager for Device Events and Files...996machine # [ 2.055867] systemd-modules-load[68]: Inserted module 'dm_mod'997machine # [ 2.059781] systemd-modules-load[68]: Inserted module 'virtio_balloon'998machine # [ 2.063497] systemd-modules-load[68]: Inserted module 'virtio_gpu'999sshClient # [ 2.019739] systemd-modules-load[68]: Inserted module 'dm_mod'1000sshClient # [ 2.024810] systemd-modules-load[68]: Inserted module 'virtio_balloon'1001machine # [ 2.329431] systemd[1]: Started Journal Service.1002sshClient # [ 2.028442] systemd-modules-load[68]: Inserted module 'virtio_gpu'1003sshClient # [ 2.294031] systemd[1]: Started Journal Service.1004machine # [ 2.095345] systemd[1]: Starting Create System Files and Directories...1005sshClient # [ 2.058863] systemd[1]: Starting Create System Files and Directories...1006machine # [ 2.129382] systemd-udevd[75]: Using default interface naming scheme 'v261'.1007machine # [ 2.135106] systemd[1]: Finished Create System Files and Directories.1008sshClient # [ 2.093548] systemd[1]: Finished Create System Files and Directories.1009sshClient # [ 2.098395] systemd-udevd[74]: Using default interface naming scheme 'v261'.1010machine # [ 2.167516] systemd[1]: Started Rule-based Manager for Device Events and Files.1011sshClient # [ 2.135190] systemd[1]: Started Rule-based Manager for Device Events and Files.1012machine # [ 2.216128] systemd[1]: Finished Coldplug All udev Devices.1013sshClient # [ 2.175160] systemd[1]: Finished Coldplug All udev Devices.1014sshClient # [ 2.176718] systemd[1]: Reached target System Initialization.1015machine # [ 2.220119] systemd[1]: Reached target System Initialization.1016machine # [ 2.221723] systemd[1]: Reached target Basic System.1017sshClient # [ 2.179810] systemd[1]: Reached target Basic System.1018machine # [ 2.766119] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121019machine # [ 2.775933] virtio_blk virtio5: 1/0/0 default/read/poll queues1020sshClient # [ 2.742475] virtio_blk virtio5: 1/0/0 default/read/poll queues1021sshClient # [ 2.748998] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121022machine # [ 2.806267] serio: i8042 KBD port at 0x60,0x64 irq 11023machine # [ 2.807507] serio: i8042 AUX port at 0x60,0x64 irq 121024machine # [ 2.815059] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1025sshClient # [ 2.777524] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1026sshClient # [ 2.780467] serio: i8042 KBD port at 0x60,0x64 irq 11027machine # [ 2.822686] ehci-pci 0000:00:1d.7: EHCI Host Controller1028machine # [ 2.824204] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11029machine # [ 2.829491] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001030sshClient # [ 2.791376] ehci-pci 0000:00:1d.7: EHCI Host Controller1031sshClient # [ 2.792744] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 11032sshClient # [ 2.796980] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001033machine # [ 2.839309] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001034sshClient # [ 2.800394] serio: i8042 AUX port at 0x60,0x64 irq 121035machine # [ 2.842309] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181036machine # [ 2.844221] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11037sshClient # [ 2.805711] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001038machine # [ 2.849993] usb usb1: Product: EHCI Host Controller1039sshClient # [ 2.809322] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181040machine # [ 2.851382] usb usb1: Manufacturer: Linux 6.18.50 ehci_hcd1041machine # [ 2.852897] usb usb1: SerialNumber: 0000:00:1d.71042machine # [ 2.854648] hub 1-0:1.0: USB hub found1043sshClient # [ 2.813331] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11044machine # [ 2.856257] hub 1-0:1.0: 6 ports detected1045sshClient # [ 2.817383] usb usb1: Product: EHCI Host Controller1046machine # [ 2.861205] uhci_hcd 0000:00:1d.0: UHCI Host Controller1047sshClient # [ 2.820157] usb usb1: Manufacturer: Linux 6.18.50 ehci_hcd1048machine # [ 2.862493] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21049sshClient # [ 2.823163] usb usb1: SerialNumber: 0000:00:1d.71050sshClient # [ 2.825849] hub 1-0:1.0: USB hub found1051sshClient # [ 2.828258] hub 1-0:1.0: 6 ports detected1052sshClient # [ 2.833200] uhci_hcd 0000:00:1d.0: UHCI Host Controller1053sshClient # [ 2.834596] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21054machine # [ 2.884290] uhci_hcd 0000:00:1d.0: detected 2 ports1055machine # [ 2.895128] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001056sshClient # [ 2.855066] uhci_hcd 0000:00:1d.0: detected 2 ports1057sshClient # [ 2.862739] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001058sshClient # [ 2.866587] SCSI subsystem initialized1059machine # [ 2.907202] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181060sshClient # [ 2.875806] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181061sshClient # [ 2.877785] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11062machine # [ 2.921085] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11063machine # [ 2.925660] SCSI subsystem initialized1064machine # [ 2.936281] usb usb2: Product: UHCI Host Controller1065sshClient # [ 2.901968] usb usb2: Product: UHCI Host Controller1066machine # [ 2.684228] systemd[1]: Starting Virtual Console Setup...1067sshClient # [ 2.648442] systemd[1]: Starting Virtual Console Setup...1068machine # [ 2.957463] usb usb2: Manufacturer: Linux 6.18.50 uhci_hcd1069sshClient # [ 2.920404] usb usb2: Manufacturer: Linux 6.18.50 uhci_hcd1070sshClient # [ 2.668967] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1071machine # [ 2.714215] (udev-worker)[88]: Network interface NamePolicy= disabled on kernel command line.1072sshClient # [ 2.675677] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1073machine # [ 2.979066] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01074sshClient # [ 2.681320] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1075machine # [ 2.728427] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.1076machine # [ 2.993289] usb usb2: SerialNumber: 0000:00:1d.01077sshClient # [ 2.953485] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01078machine # [ 2.736389] systemd[1]: Finished Virtual Console Setup.1079sshClient # [ 2.958921] usb usb2: SerialNumber: 0000:00:1d.01080sshClient # [ 2.700873] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.1081sshClient # [ 2.706443] systemd[1]: Finished Virtual Console Setup.1082machine # [ 2.749799] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1083machine # [ 2.753490] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1084machine # [ 3.015074] hub 2-0:1.0: USB hub found1085machine # [ 3.017195] hub 2-0:1.0: 2 ports detected1086sshClient # [ 2.982501] hub 2-0:1.0: USB hub found1087sshClient # [ 2.989700] hub 2-0:1.0: 2 ports detected1088machine # [ 3.038026] uhci_hcd 0000:00:1d.1: UHCI Host Controller1089sshClient # [ 3.001670] uhci_hcd 0000:00:1d.1: UHCI Host Controller1090machine # [ 3.047275] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31091machine # [ 3.049071] uhci_hcd 0000:00:1d.1: detected 2 ports1092sshClient # [ 3.010431] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31093machine # [ 3.058414] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201094sshClient # [ 3.017849] uhci_hcd 0000:00:1d.1: detected 2 ports1095machine # [ 2.802487] systemd[1]: Found device /dev/disk/by-label/nixos.1096machine # [ 2.804167] systemd[1]: Reached target Initrd Root Device.1097sshClient # [ 2.762238] systemd[1]: Found device /dev/disk/by-label/nixos.1098sshClient # [ 2.763937] systemd[1]: Reached target Initrd Root Device.1099machine # [ 2.808153] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1100sshClient # [ 3.026814] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201101sshClient # [ 2.768857] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1102machine # [ 3.074382] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181103machine # [ 3.082186] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11104sshClient # [ 3.043826] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181105machine # [ 3.090193] usb usb3: Product: UHCI Host Controller1106machine # [ 3.092112] usb usb3: Manufacturer: Linux 6.18.50 uhci_hcd1107sshClient # [ 3.052524] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11108machine # [ 3.097200] usb 1-1: new high-speed USB device number 2 using ehci-pci1109sshClient # [ 3.062266] usb usb3: Product: UHCI Host Controller1110sshClient # [ 3.063881] usb usb3: Manufacturer: Linux 6.18.50 uhci_hcd1111machine # [ 3.105343] usb usb3: SerialNumber: 0000:00:1d.11112machine # [ 2.848196] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1113sshClient # [ 3.066292] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1114sshClient # [ 3.068335] usb usb3: SerialNumber: 0000:00:1d.11115sshClient # [ 2.809819] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks1116sshClient # [ 3.072223] usb 1-1: new high-speed USB device number 2 using ehci-pci1117sshClient # [ 3.074119] hub 3-0:1.0: USB hub found1118machine # [ 2.856467] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1119sshClient # [ 3.077882] hub 3-0:1.0: 2 ports detected1120machine # [ 3.120067] hub 3-0:1.0: USB hub found1121machine # [ 3.121716] hub 3-0:1.0: 2 ports detected1122sshClient # [ 2.821362] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1123machine # [ 2.865115] systemd[1]: Mounting /sysroot...1124sshClient # [ 3.085530] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1125sshClient # [ 2.827955] systemd[1]: Mounting /sysroot...1126machine # [ 3.134317] uhci_hcd 0000:00:1d.2: UHCI Host Controller1127sshClient # [ 3.095540] ahci 0000:00:1f.2: flags: 64bit ncq only1128sshClient # [ 3.097440] uhci_hcd 0000:00:1d.2: UHCI Host Controller1129machine # [ 3.142398] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1130sshClient # [ 3.103755] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41131machine # [ 3.146303] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41132machine # [ 3.152248] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1133machine # [ 3.156517] uhci_hcd 0000:00:1d.2: detected 2 ports1134sshClient # [ 3.118559] uhci_hcd 0000:00:1d.2: detected 2 ports1135machine # [ 3.164240] ahci 0000:00:1f.2: flags: 64bit ncq only1136sshClient # [ 3.124448] scsi host0: ahci1137sshClient # [ 3.126816] scsi host1: ahci1138machine # [ 3.167571] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401139sshClient # [ 3.131810] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401140sshClient # [ 3.135096] scsi host2: ahci1141sshClient # [ 3.139747] scsi host3: ahci1142machine # [ 3.182300] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181143machine # [ 3.184278] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11144sshClient # [ 3.144813] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181145sshClient # [ 3.148747] scsi host4: ahci1146machine # [ 3.197405] scsi host0: ahci1147sshClient # [ 3.162872] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11148machine # [ 3.206961] scsi host1: ahci1149sshClient # [ 3.166829] scsi host5: ahci1150machine # [ 3.209192] usb usb4: Product: UHCI Host Controller1151sshClient # [ 3.174108] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11152machine # [ 3.217213] scsi host2: ahci1153sshClient # [ 3.180145] usb usb4: Product: UHCI Host Controller1154machine # [ 3.222180] usb usb4: Manufacturer: Linux 6.18.50 uhci_hcd1155sshClient # [ 3.181690] usb usb4: Manufacturer: Linux 6.18.50 uhci_hcd1156sshClient # [ 3.185902] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11157machine # [ 3.230276] usb usb4: SerialNumber: 0000:00:1d.21158machine # [ 3.231684] scsi host3: ahci1159sshClient # [ 3.190856] usb usb4: SerialNumber: 0000:00:1d.21160sshClient # [ 3.192435] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11161sshClient # [ 3.198175] hub 4-0:1.0: USB hub found1162machine # [ 3.239259] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001163machine # [ 3.241215] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101164machine # [ 3.243755] scsi host4: ahci1165machine # [ 3.247180] usb 1-1: Product: QEMU USB Tablet1166machine # [ 3.249551] usb 1-1: Manufacturer: QEMU1167machine # [ 3.250972] hub 4-0:1.0: USB hub found1168sshClient # [ 3.211690] hub 4-0:1.0: 2 ports detected1169machine # [ 3.255115] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11170sshClient # [ 3.213146] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11171sshClient # [ 3.218253] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001172machine # [ 3.260734] scsi host5: ahci1173sshClient # [ 3.220296] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101174machine # [ 3.264187] hub 4-0:1.0: 2 ports detected1175sshClient # [ 3.225303] usb 1-1: Product: QEMU USB Tablet1176sshClient # [ 3.228141] usb 1-1: Manufacturer: QEMU1177machine # [ 3.270706] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11178sshClient # [ 3.230532] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11179sshClient # [ 3.232308] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11180machine # [ 3.278558] EXT4-fs (vda): mounted filesystem 64900161-190e-4c06-aa87-ad9af5e870d9 r/w with ordered data mode. Quota mode: none.1181machine # [ 3.026528] systemd[1]: Mounted /sysroot.1182sshClient # [ 3.246116] EXT4-fs (vda): mounted filesystem b9b842cc-39bc-4776-b2e3-9978102748a7 r/w with ordered data mode. Quota mode: none.1183machine # [ 3.032717] systemd[1]: Reached target Initrd Root File System.1184machine # [ 3.295229] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11185sshClient # [ 2.994884] systemd[1]: Mounted /sysroot.1186machine # [ 3.039211] systemd[1]: Starting Mountpoints Configured in the Real Root...1187sshClient # [ 2.999114] systemd[1]: Reached target Initrd Root File System.1188sshClient # [ 3.003117] systemd[1]: Starting Mountpoints Configured in the Real Root...1189sshClient # [ 3.265519] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11190machine # [ 3.319018] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11191machine # [ 3.062178] systemd-sysroot-fstab-check[129]: /sysroot should be mounted in the initrd, will request daemon-reload.1192machine # [ 3.068093] systemd[1]: Reload requested from client PID 129 ('systemd-sysroot') (unit initrd-parse-etc.service)...1193machine # [ 3.070809] systemd[1]: Reloading...1194sshClient # [ 3.027258] systemd-sysroot-fstab-check[129]: /sysroot should be mounted in the initrd, will request daemon-reload.1195sshClient # [ 3.035103] systemd[1]: Reload requested from client PID 129 ('systemd-sysroot') (unit initrd-parse-etc.service)...1196sshClient # [ 3.037915] systemd[1]: Reloading...1197machine # [ 3.347658] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11198machine # [ 3.367208] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11199machine # [ 3.379332] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11200sshClient # [ 3.341753] hid: raw HID events driver (C) Jiri Kosina1201machine # [ 3.397735] hid: raw HID events driver (C) Jiri Kosina1202sshClient # [ 3.127469] systemd[1]: Reloading finished in 92 ms.1203machine # [ 3.175103] systemd[1]: Reloading finished in 108 ms.1204sshClient # [ 3.136929] systemd-sysroot-fstab-check[129]: Requesting initrd-fs.target/start/replace...1205machine # [ 3.183844] systemd-sysroot-fstab-check[129]: Requesting initrd-fs.target/start/replace...1206sshClient # [ 3.141147] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1207sshClient # [ 3.143984] systemd-sysroot-fstab-check[129]: Requesting swap.target/start/replace...1208machine # [ 3.189414] systemd-sysroot-fstab-check[129]: Requesting swap.target/start/replace...1209sshClient # [ 3.148970] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1210machine # [ 3.191516] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1211sshClient # [ 3.151570] systemd[1]: Finished Mountpoints Configured in the Real Root.1212machine # [ 3.194783] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1213sshClient # [ 3.153603] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1214machine # [ 3.197410] systemd[1]: Finished Mountpoints Configured in the Real Root.1215machine # [ 3.200280] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1216sshClient # [ 3.583979] ata1: SATA link down (SStatus 0 SControl 300)1217sshClient # [ 3.588215] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1218sshClient # [ 3.593168] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001219sshClient # [ 3.597082] ata3.00: applying bridge limits1220sshClient # [ 3.600853] ata4: SATA link down (SStatus 0 SControl 300)1221sshClient # [ 3.605105] ata2: SATA link down (SStatus 0 SControl 300)1222sshClient # [ 3.609585] ata5: SATA link down (SStatus 0 SControl 300)1223sshClient # [ 3.613932] ata6: SATA link down (SStatus 0 SControl 300)1224sshClient # [ 3.618066] ata3.00: configured for UDMA/1001225sshClient # [ 3.622061] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51226machine # [ 3.698803] ata1: SATA link down (SStatus 0 SControl 300)1227machine # [ 3.702961] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1228sshClient # [ 3.666292] usbcore: registered new interface driver usbhid1229machine # [ 3.707824] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001230sshClient # [ 3.670524] usbhid: USB HID core driver1231machine # [ 3.711727] ata3.00: applying bridge limits1232machine # [ 3.715446] ata5: SATA link down (SStatus 0 SControl 300)1233machine # [ 3.719745] ata2: SATA link down (SStatus 0 SControl 300)1234sshClient # [ 3.680472] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input21235machine # [ 3.724070] ata6: SATA link down (SStatus 0 SControl 300)1236sshClient # [ 3.684327] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01237machine # [ 3.728260] ata4: SATA link down (SStatus 0 SControl 300)1238sshClient # [ 3.689927] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1239machine # [ 3.732514] ata3.00: configured for UDMA/1001240machine # [ 3.736551] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51241sshClient # [ 3.701687] cdrom: Uniform CD-ROM driver Revision: 3.201242machine # [ 3.787395] usbcore: registered new interface driver usbhid1243machine # [ 3.792052] usbhid: USB HID core driver1244machine # [ 3.799104] 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/input21245machine # [ 3.802545] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1246machine # [ 3.804694] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01247machine # [ 3.817378] cdrom: Uniform CD-ROM driver Revision: 3.201248machine # [ 3.831646] systemd[1]: Mounting /sysroot/nix/.ro-store...1249sshClient # [ 3.795607] systemd[1]: Mounting /sysroot/nix/.ro-store...1250machine # [ 3.841115] systemd[1]: Mounting /sysroot/nix/.rw-store...1251sshClient # [ 3.805469] systemd[1]: Mounting /sysroot/nix/.rw-store...1252machine # [ 3.853148] systemd[1]: Mounting /sysroot/run...1253sshClient # [ 3.817478] systemd[1]: Mounting /sysroot/run...1254machine # [ 3.868754] systemd[1]: Mounting /sysroot/tmp/shared...1255sshClient # [ 3.828911] systemd[1]: Mounting /sysroot/tmp/shared...1256machine # [ 3.887166] systemd[1]: Mounting /sysroot/tmp/xchg...1257sshClient # [ 3.845465] systemd[1]: Mounting /sysroot/tmp/xchg...1258machine # [ 4.172787] 9p: Installing v9fs 9p2000 file system support1259machine # [ 3.921919] systemd[1]: Mounted /sysroot/nix/.rw-store.1260sshClient # [ 4.142950] 9p: Installing v9fs 9p2000 file system support1261machine # [ 3.928061] systemd[1]: Mounted /sysroot/nix/.ro-store.1262sshClient # [ 3.887494] systemd[1]: Mounted /sysroot/nix/.rw-store.1263machine # [ 3.931950] systemd[1]: Mounted /sysroot/run.1264machine # [ 3.935209] systemd[1]: Mounted /sysroot/tmp/shared.1265machine # [ 3.939180] systemd[1]: Mounted /sysroot/tmp/xchg.1266sshClient # [ 3.897815] systemd[1]: Starting rw-sysroot-nix-store.service...1267sshClient # [ 3.903077] systemd[1]: Mounted /sysroot/nix/.ro-store.1268machine # [ 3.945687] systemd[1]: Starting rw-sysroot-nix-store.service...1269sshClient # [ 3.908116] systemd[1]: Mounted /sysroot/run.1270sshClient # [ 3.912104] systemd[1]: Mounted /sysroot/tmp/shared.1271sshClient # [ 3.913606] systemd[1]: Mounted /sysroot/tmp/xchg.1272machine # [ 3.958548] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1273machine # [ 3.961264] systemd[1]: Finished rw-sysroot-nix-store.service.1274sshClient # [ 3.922967] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1275sshClient # [ 3.925136] systemd[1]: Finished rw-sysroot-nix-store.service.1276sshClient # [ 3.928666] systemd[1]: Mounting /sysroot/nix/store...1277sshClient # [ 3.950405] systemd[1]: Mounted /sysroot/nix/store.1278sshClient # [ 3.952579] systemd[1]: Reached target Initrd File Systems.1279sshClient # [ 3.955438] systemd[1]: Starting Find NixOS closure...1280sshClient # [ 3.959101] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1281sshClient # [ 3.981363] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1282sshClient # [ 3.992359] systemd[1]: Finished Find NixOS closure.1283sshClient # [ 3.994648] systemd[1]: Reached target Initrd Default Target.1284sshClient # [ 3.997559] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1285sshClient # [ 4.014510] systemd[1]: Stopped target Initrd Default Target.1286sshClient # [ 4.016467] systemd[1]: Stopped target Basic System.1287sshClient # [ 4.018367] systemd[1]: Stopped target Initrd Root Device.1288sshClient # [ 4.020328] systemd[1]: Stopped target Path Units.1289sshClient # [ 4.022143] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1290sshClient # [ 4.024523] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1291sshClient # [ 4.027340] systemd[1]: Stopped target Slice Units.1292sshClient # [ 4.028761] systemd[1]: Stopped target Socket Units.1293sshClient # [ 4.030545] systemd[1]: Stopped target System Initialization.1294sshClient # [ 4.033334] systemd[1]: Stopped target Swaps.1295sshClient # [ 4.034632] systemd[1]: Stopped target Timer Units.1296sshClient # [ 4.036072] systemd[1]: dbus.socket: Deactivated successfully.1297sshClient # [ 4.038103] systemd[1]: Closed D-Bus System Message Bus Socket.1298sshClient # [ 4.039880] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1299sshClient # [ 4.042203] systemd[1]: Stopped Find NixOS closure.1300sshClient # [ 4.044185] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1301sshClient # [ 4.046985] systemd[1]: Starting rw-sysroot-nix-store.service...1302sshClient # [ 4.049469] systemd[1]: systemd-sysctl.service: Deactivated successfully.1303sshClient # [ 4.052275] systemd[1]: Stopped Apply Kernel Variables.1304sshClient # [ 4.053791] systemd[1]: systemd-modules-load.service: Deactivated successfully.1305sshClient # [ 4.055763] systemd[1]: Stopped Load Kernel Modules.1306sshClient # [ 4.058231] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1307sshClient # [ 4.060444] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1308sshClient # [ 4.062473] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1309sshClient # [ 4.065179] systemd[1]: Stopped Create System Files and Directories.1310sshClient # [ 4.066883] systemd[1]: Stopped target Local File Systems.1311sshClient # [ 4.068562] systemd[1]: Stopped target Preparation for Local File Systems.1312sshClient # [ 4.072162] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1313sshClient # [ 4.074143] systemd[1]: Stopped Coldplug All udev Devices.1314sshClient # [ 4.076902] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1315sshClient # [ 4.078896] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1316sshClient # [ 4.082162] systemd[1]: Stopped Virtual Console Setup.1317sshClient # [ 4.096841] systemd[1]: initrd-cleanup.service: Deactivated successfully.1318sshClient # [ 4.100313] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1319sshClient # [ 4.103186] systemd[1]: systemd-udevd.service: Deactivated successfully.1320sshClient # [ 4.105566] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1321sshClient # [ 4.108254] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1322sshClient # [ 4.110910] systemd[1]: Finished rw-sysroot-nix-store.service.1323sshClient # [ 4.116675] systemd[1]: Starting Cleanup udev Database...1324sshClient # [ 4.119245] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1325sshClient # [ 4.121301] systemd[1]: Stopped Create Static Device Nodes in /dev.1326sshClient # [ 4.122997] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1327sshClient # [ 4.126204] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1328sshClient # [ 4.128141] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1329sshClient # [ 4.129932] systemd[1]: Stopped Create List of Static Device Nodes.1330sshClient # [ 4.147448] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1331sshClient # [ 4.150330] systemd[1]: Finished Cleanup udev Database.1332sshClient # [ 4.152635] systemd[1]: Reached target Switch Root.1333sshClient # [ 4.155693] systemd[1]: Starting NixOS Activation...1334sshClient # [ 4.327572] initrd-nixos-activation-start[192]: booting system configuration /nix/store/hqila2ch7l8gg9lqg7y9sk29i52vpcnw-nixos-system-sshClient-test1335sshClient # [ 4.399458] initrd-nixos-activation-start[192]: running activation script...1336machine # [ 4.831735] systemd[1]: Mounting /sysroot/nix/store...1337machine # [ 4.885270] systemd[1]: Mounted /sysroot/nix/store.1338machine # [ 4.886733] systemd[1]: Reached target Initrd File Systems.1339machine # [ 4.889367] systemd[1]: Starting Find NixOS closure...1340machine # [ 4.895114] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1341sshClient # [ 4.866634] initrd-nixos-activation-start[215]: setting up /etc...1342machine # [ 4.918906] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1343machine # [ 4.924183] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1344machine # [ 4.932886] systemd[1]: Finished Find NixOS closure.1345machine # [ 4.935379] systemd[1]: Reached target Initrd Default Target.1346machine # [ 4.937689] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1347machine # [ 4.954052] systemd[1]: Stopped target Initrd Default Target.1348machine # [ 4.956557] systemd[1]: Stopped target Basic System.1349machine # [ 4.959348] systemd[1]: Stopped target Initrd Root Device.1350machine # [ 4.960851] systemd[1]: Stopped target Path Units.1351machine # [ 4.962227] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1352machine # [ 4.964215] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1353machine # [ 4.966738] systemd[1]: Stopped target Slice Units.1354machine # [ 4.968719] systemd[1]: Stopped target Socket Units.1355machine # [ 4.970645] systemd[1]: Stopped target System Initialization.1356machine # [ 4.973250] systemd[1]: Stopped target Swaps.1357machine # [ 4.974745] systemd[1]: Stopped target Timer Units.1358machine # [ 4.976224] systemd[1]: dbus.socket: Deactivated successfully.1359machine # [ 4.978244] systemd[1]: Closed D-Bus System Message Bus Socket.1360machine # [ 4.980196] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1361machine # [ 4.983222] systemd[1]: Stopped Find NixOS closure.1362machine # [ 4.984601] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1363machine # [ 4.987640] systemd[1]: Starting rw-sysroot-nix-store.service...1364machine # [ 4.989475] systemd[1]: systemd-sysctl.service: Deactivated successfully.1365machine # [ 4.991868] systemd[1]: Stopped Apply Kernel Variables.1366machine # [ 4.993957] systemd[1]: systemd-modules-load.service: Deactivated successfully.1367machine # [ 4.996289] systemd[1]: Stopped Load Kernel Modules.1368machine # [ 4.998240] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1369machine # [ 5.001174] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1370machine # [ 5.003239] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1371machine # [ 5.005297] systemd[1]: Stopped Create System Files and Directories.1372machine # [ 5.008208] systemd[1]: Stopped target Local File Systems.1373machine # [ 5.009723] systemd[1]: Stopped target Preparation for Local File Systems.1374machine # [ 5.011508] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1375machine # [ 5.013391] systemd[1]: Stopped Coldplug All udev Devices.1376machine # [ 5.015619] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1377machine # [ 5.018926] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1378machine # [ 5.021228] systemd[1]: Stopped Virtual Console Setup.1379machine # [ 5.032078] systemd[1]: initrd-cleanup.service: Deactivated successfully.1380machine # [ 5.038167] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1381machine # [ 5.043736] systemd[1]: systemd-udevd.service: Deactivated successfully.1382machine # [ 5.047111] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1383machine # [ 5.049386] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1384machine # [ 5.051975] systemd[1]: Finished rw-sysroot-nix-store.service.1385machine # [ 5.056679] systemd[1]: Starting Cleanup udev Database...1386machine # [ 5.058912] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1387machine # [ 5.060897] systemd[1]: Stopped Create Static Device Nodes in /dev.1388machine # [ 5.063275] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1389machine # [ 5.065367] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1390machine # [ 5.067295] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1391machine # [ 5.070224] systemd[1]: Stopped Create List of Static Device Nodes.1392machine # [ 5.086725] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1393machine # [ 5.090131] systemd[1]: Finished Cleanup udev Database.1394machine # [ 5.092115] systemd[1]: Reached target Switch Root.1395machine # [ 5.095110] systemd[1]: Starting NixOS Activation...1396sshClient # [ 5.158600] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1397sshClient # [ 5.162096] systemd[1]: Finished NixOS Activation.1398sshClient # [ 5.164280] systemd[1]: Starting Switch Root...1399sshClient # [ 5.178457] systemd[1]: Switching root.1400machine # [ 5.233626] initrd-nixos-activation-start[193]: booting system configuration /nix/store/mf9d0lbxm1kvk46cqcp8ba1b8hk9q787-nixos-system-machine-test1401machine # [ 5.291129] initrd-nixos-activation-start[193]: running activation script...1402sshClient # [ 5.577806] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1403sshClient # [ 5.733214] NET: Registered PF_VSOCK protocol family1404machine # [ 5.690993] initrd-nixos-activation-start[216]: setting up /etc...1405sshClient # [ 6.118746] systemd[1]: systemd 262-2ff84cf 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)1406sshClient # [ 6.134754] systemd[1]: Detected virtualization kvm.1407sshClient # [ 6.137918] systemd[1]: Detected architecture x86-64.1408sshClient # [ 6.141259] systemd[1]: Detected first boot.1409sshClient # [ 6.149565] systemd[1]: Initializing machine ID from random generator.1410machine # [ 5.978188] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1411machine # [ 5.981110] systemd[1]: Finished NixOS Activation.1412machine # [ 5.984180] systemd[1]: Starting Switch Root...1413machine # [ 6.000920] systemd[1]: Switching root.1414sshClient # [ 6.311812] systemd[1]: bpf-restrict-fs: LSM BPF program attached1415machine # [ 6.395790] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).1416sshClient # [ 6.426693] systemd[1]: Applying preset policy.1417machine # [ 6.551067] NET: Registered PF_VSOCK protocol family1418machine # [ 6.937955] systemd[1]: systemd 262-2ff84cf 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)1419machine # [ 6.954370] systemd[1]: Detected virtualization kvm.1420machine # [ 6.957616] systemd[1]: Detected architecture x86-64.1421machine # [ 6.960923] systemd[1]: Detected first boot.1422machine # [ 6.968676] systemd[1]: Initializing machine ID from random generator.1423sshClient # [ 6.929983] systemd[1]: Populated /etc with preset unit settings.1424machine # [ 7.171956] systemd[1]: bpf-restrict-fs: LSM BPF program attached1425machine # [ 7.305332] systemd[1]: Applying preset policy.1426sshClient # [ 7.422231] systemd[1]: initrd-switch-root.service: Deactivated successfully.1427sshClient # [ 7.424717] systemd[1]: Stopped initrd-switch-root.service.1428sshClient # [ 7.428734] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1429sshClient # [ 7.431894] systemd[1]: Created slice Slice /system/getty.1430sshClient # [ 7.433999] systemd[1]: Created slice User and Session Slice.1431sshClient # [ 7.435792] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1432sshClient # [ 7.437844] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1433sshClient # [ 7.439716] systemd[1]: Expecting device /dev/hvc0...1434sshClient # [ 7.453394] systemd[1]: Expecting device /dev/ttyS0...1435sshClient # [ 7.454792] systemd[1]: Reached target Local Encrypted Volumes.1436sshClient # [ 7.456257] systemd[1]: Stopped target initrd-fs.target.1437sshClient # [ 7.457613] systemd[1]: Stopped target initrd-root-fs.target.1438sshClient # [ 7.459144] systemd[1]: Stopped target initrd-switch-root.target.1439sshClient # [ 7.460718] systemd[1]: Reached target Virtual Machines and Containers.1440sshClient # [ 7.462339] systemd[1]: Reached target Path Units.1441sshClient # [ 7.463701] systemd[1]: Reached target Remote File Systems.1442sshClient # [ 7.465120] systemd[1]: Reached target Slice Units.1443sshClient # [ 7.466431] systemd[1]: Reached target Swaps.1444sshClient # [ 7.470176] systemd[1]: Listening on Query the User Interactively for a Password.1445sshClient # [ 7.474776] systemd[1]: Listening on Process Core Dump Socket.1446sshClient # [ 7.478273] systemd[1]: Listening on Credential Encryption/Decryption.1447sshClient # [ 7.481662] systemd[1]: Listening on Factory Reset Management.1448sshClient # [ 7.483318] systemd[1]: Listening on Hostname Service Socket.1449sshClient # [ 7.488154] systemd[1]: Starting Journal Log Access Socket...1450sshClient # [ 7.490544] systemd[1]: Listening on Journal Audit Socket.1451sshClient # [ 7.494455] systemd[1]: Listening on Console Output Muting Service Socket.1452sshClient # [ 7.496409] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1453sshClient # [ 7.498726] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1454sshClient # [ 7.500982] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1455sshClient # [ 7.511536] systemd[1]: Listening on Disk Repartitioning Service Socket.1456sshClient # [ 7.513423] systemd[1]: Listening on udev Varlink Socket.1457sshClient # [ 7.515088] systemd[1]: Listening on User Database Manager Socket.1458sshClient # [ 7.519992] systemd[1]: Mounting Huge Pages File System...1459sshClient # [ 7.524225] systemd[1]: Mounting POSIX Message Queue File System...1460sshClient # [ 7.532497] systemd[1]: Mounting Kernel Debug File System...1461sshClient # [ 7.539809] systemd[1]: Mounting Kernel Trace File System...1462sshClient # [ 7.547158] systemd[1]: Starting Create List of Static Device Nodes...1463sshClient # [ 7.554032] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1464sshClient # [ 7.562788] systemd[1]: Starting Load Kernel Module configfs...1465sshClient # [ 7.565130] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1466sshClient # [ 7.568101] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1467sshClient # [ 7.575605] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1468sshClient # [ 7.589934] systemd[1]: Mounting FUSE Control File System...1469sshClient # [ 7.591657] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671470sshClient # [ 7.616026] systemd[1]: Starting Journal Service...1471sshClient # [ 7.642821] systemd[1]: Starting Load Kernel Modules...1472sshClient # [ 7.660126] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1473sshClient # [ 7.677256] systemd[1]: Starting Remount Root and Kernel File Systems...1474sshClient # [ 7.693887] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1475sshClient # [ 7.696175] systemd-journald[286]: Collecting audit messages is enabled.1476sshClient # [ 7.712339] systemd[1]: Starting Coldplug All udev Devices...1477sshClient # [ 7.732832] loop: module loaded1478sshClient # [ 7.743029] systemd[1]: Listening on Journal Log Access Socket.1479sshClient # [ 7.487718] systemd[1]: Queued start job for default target Multi-User System.1480sshClient # [ 7.753284] systemd[1]: Started Journal Service.1481sshClient # [ 7.494149] systemd[1]: systemd-journald.service: Deactivated successfully.1482sshClient # [ 7.497841] systemd-modules-load[287]: Inserted module 'loop'1483sshClient # [ 7.506698] systemd[1]: Mounted Huge Pages File System.1484sshClient # [ 7.768755] EXT4-fs (vda): re-mounted b9b842cc-39bc-4776-b2e3-9978102748a7.1485sshClient # [ 7.511628] systemd[1]: Mounted POSIX Message Queue File System.1486sshClient # [ 7.516754] systemd[1]: Mounted Kernel Debug File System.1487sshClient # [ 7.521542] systemd[1]: Mounted Kernel Trace File System.1488sshClient # [ 7.525648] systemd[1]: Finished Create List of Static Device Nodes.1489sshClient # [ 7.530097] systemd[1]: modprobe@configfs.service: Deactivated successfully.1490sshClient # [ 7.533492] systemd[1]: Finished Load Kernel Module configfs.1491sshClient # [ 7.535400] systemd[1]: Mounted FUSE Control File System.1492machine # [ 7.837697] systemd[1]: Populated /etc with preset unit settings.1493sshClient # [ 7.542317] systemd[1]: Finished Load Kernel Modules.1494sshClient # [ 7.544804] systemd[1]: Finished Remount Root and Kernel File Systems.1495sshClient # [ 7.570113] systemd[1]: Listening on Disk Image Download Service Socket.1496sshClient # [ 7.578321] systemd[1]: Mounting Kernel Configuration File System...1497sshClient # [ 7.584751] systemd[1]: Starting Firewall...1498sshClient # [ 7.597336] systemd-oomd[289]: No swap; memory pressure usage will be degraded1499sshClient # [ 7.604147] systemd[1]: Starting Flush Journal to Persistent Storage...1500sshClient # [ 7.608281] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1501sshClient # [ 7.620583] systemd[1]: Starting Load/Save OS Random Seed...1502sshClient # [ 7.643961] systemd[1]: Starting Apply Kernel Variables...1503sshClient # [ 7.665492] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1504sshClient # [ 7.668361] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1505sshClient # [ 7.687354] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1506sshClient # [ 7.968278] systemd-journald[286]: Received client request to flush runtime journal.1507sshClient # [ 8.053524] systemd[1]: Finished Load/Save OS Random Seed.1508sshClient # [ 8.056864] systemd[1]: Mounted Kernel Configuration File System.1509sshClient # [ 8.062342] systemd[1]: Finished Apply Kernel Variables.1510sshClient # [ 8.067675] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1511machine # [ 8.374617] systemd[1]: initrd-switch-root.service: Deactivated successfully.1512sshClient # [ 8.073078] systemd[1]: Starting Create Static Device Nodes in /dev...1513machine # [ 8.377074] systemd[1]: Stopped initrd-switch-root.service.1514sshClient # [ 8.075421] systemd[1]: Finished Create Static Device Nodes in /dev.1515sshClient # [ 8.078352] systemd[1]: Reached target Preparation for Local File Systems.1516machine # [ 8.380638] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1517sshClient # [ 8.080820] systemd[1]: Starting Rule-based Manager for Device Events and Files...1518machine # [ 8.384004] systemd[1]: Created slice Slice /system/getty.1519sshClient # [ 8.083841] systemd[1]: Finished Flush Journal to Persistent Storage.1520machine # [ 8.386247] systemd[1]: Created slice User and Session Slice.1521machine # [ 8.387945] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1522machine # [ 8.390049] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1523sshClient # [ 8.098311] systemd-udevd[326]: Using default interface naming scheme 'v261'.1524machine # [ 8.391923] systemd[1]: Expecting device /dev/hvc0...1525machine # [ 8.405618] systemd[1]: Expecting device /dev/ttyS0...1526machine # [ 8.406959] systemd[1]: Reached target Local Encrypted Volumes.1527machine # [ 8.408476] systemd[1]: Stopped target initrd-fs.target.1528machine # [ 8.409825] systemd[1]: Stopped target initrd-root-fs.target.1529machine # [ 8.411293] systemd[1]: Stopped target initrd-switch-root.target.1530machine # [ 8.412827] systemd[1]: Reached target Virtual Machines and Containers.1531machine # [ 8.414491] systemd[1]: Reached target Path Units.1532machine # [ 8.415822] systemd[1]: Reached target Remote File Systems.1533machine # [ 8.417287] systemd[1]: Reached target Slice Units.1534machine # [ 8.418597] systemd[1]: Reached target Swaps.1535sshClient # [ 8.118173] systemd[1]: Finished Coldplug All udev Devices.1536machine # [ 8.422308] systemd[1]: Listening on Query the User Interactively for a Password.1537machine # [ 8.426823] systemd[1]: Listening on Process Core Dump Socket.1538machine # [ 8.430369] systemd[1]: Listening on Credential Encryption/Decryption.1539machine # [ 8.433707] systemd[1]: Listening on Factory Reset Management.1540machine # [ 8.435386] systemd[1]: Listening on Hostname Service Socket.1541machine # [ 8.440093] systemd[1]: Starting Journal Log Access Socket...1542machine # [ 8.442564] systemd[1]: Listening on Journal Audit Socket.1543machine # [ 8.446747] systemd[1]: Listening on Console Output Muting Service Socket.1544machine # [ 8.448701] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1545machine # [ 8.450934] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1546machine # [ 8.453254] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1547machine # [ 8.464212] systemd[1]: Listening on Disk Repartitioning Service Socket.1548machine # [ 8.466056] systemd[1]: Listening on udev Varlink Socket.1549machine # [ 8.467671] systemd[1]: Listening on User Database Manager Socket.1550sshClient # [ 8.166356] systemd[1]: Mounting /run/wrappers...1551machine # [ 8.472250] systemd[1]: Mounting Huge Pages File System...1552machine # [ 8.476638] systemd[1]: Mounting POSIX Message Queue File System...1553sshClient # [ 8.175901] systemd[1]: Starting User Database Manager...1554machine # [ 8.484942] systemd[1]: Mounting Kernel Debug File System...1555machine # [ 8.492450] systemd[1]: Mounting Kernel Trace File System...1556machine # [ 8.500783] systemd[1]: Starting Create List of Static Device Nodes...1557machine # [ 8.503921] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1558sshClient # [ 8.210464] systemd[1]: Mounted /run/wrappers.1559sshClient # [ 8.214127] systemd[1]: Reached target Local File Systems.1560machine # [ 8.517190] systemd[1]: Starting Load Kernel Module configfs...1561machine # [ 8.518854] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1562sshClient # [ 8.220196] systemd[1]: Listening on Boot Loader Control Service Socket.1563machine # [ 8.521683] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1564machine # [ 8.524782] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1565sshClient # [ 8.225363] systemd[1]: Starting Create SUID/SGID Wrappers...1566sshClient # [ 8.228714] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1567sshClient # [ 8.235794] systemd[1]: Starting Create System Files and Directories...1568machine # [ 8.566677] systemd[1]: Mounting FUSE Control File System...1569sshClient # [ 8.276280] systemd[1]: Started User Database Manager.1570machine # [ 8.580453] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671571machine # [ 8.602556] systemd[1]: Starting Journal Service...1572machine # [ 8.614367] systemd[1]: Starting Load Kernel Modules...1573machine # [ 8.625269] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1574machine # [ 8.636585] systemd[1]: Starting Remount Root and Kernel File Systems...1575machine # [ 8.648421] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1576machine # [ 8.663600] systemd[1]: Starting Coldplug All udev Devices...1577sshClient # [ 8.360339] systemd[1]: Finished Create System Files and Directories.1578machine # [ 8.671670] systemd-journald[287]: Collecting audit messages is enabled.1579sshClient # [ 8.372213] systemd[1]: Starting Rebuild Journal Catalog...1580sshClient # [ 8.378695] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1581machine # [ 8.691014] systemd[1]: Listening on Journal Log Access Socket.1582machine # [ 8.704339] systemd[1]: Mounted Huge Pages File System.1583machine # [ 8.711079] systemd[1]: Mounted POSIX Message Queue File System.1584machine # [ 8.719252] EXT4-fs (vda): re-mounted 64900161-190e-4c06-aa87-ad9af5e870d9.1585machine # [ 8.721368] systemd[1]: Mounted Kernel Debug File System.1586sshClient # [ 8.422129] systemd[1]: Started Rule-based Manager for Device Events and Files.1587machine # [ 8.730952] systemd[1]: Mounted Kernel Trace File System.1588machine # [ 8.734388] loop: module loaded1589machine # [ 8.476530] systemd[1]: Queued start job for default target Multi-User System.1590machine # [ 8.481912] systemd[1]: systemd-journald.service: Deactivated successfully.1591machine # [ 8.485851] systemd-modules-load[288]: Inserted module 'loop'1592machine # [ 8.746557] systemd[1]: Started Journal Service.1593machine # [ 8.498736] systemd[1]: Finished Create List of Static Device Nodes.1594sshClient # [ 8.457878] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1595machine # [ 8.502744] systemd[1]: modprobe@configfs.service: Deactivated successfully.1596machine # [ 8.506666] systemd[1]: Finished Load Kernel Module configfs.1597machine # [ 8.509486] systemd[1]: Mounted FUSE Control File System.1598machine # [ 8.517145] systemd[1]: Finished Load Kernel Modules.1599machine # [ 8.519167] systemd[1]: Finished Remount Root and Kernel File Systems.1600machine # [ 8.540143] systemd[1]: Listening on Disk Image Download Service Socket.1601machine # [ 8.550261] systemd[1]: Mounting Kernel Configuration File System...1602machine # [ 8.554126] systemd-oomd[290]: No swap; memory pressure usage will be degraded1603sshClient # [ 8.514908] systemd[1]: Finished Rebuild Journal Catalog.1604machine # [ 8.558290] systemd[1]: Starting Firewall...1605sshClient # [ 8.524250] systemd[1]: Starting Update is Completed...1606machine # [ 8.569250] systemd[1]: Starting Flush Journal to Persistent Storage...1607machine # [ 8.571191] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1608machine # [ 8.584113] systemd[1]: Starting Load/Save OS Random Seed...1609machine # [ 8.603218] systemd[1]: Starting Apply Kernel Variables...1610sshClient # [ 8.575293] systemd[1]: Finished Update is Completed.1611machine # [ 8.624245] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1612machine # [ 8.627949] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1613machine # [ 8.633301] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1614machine # [ 8.919835] systemd-journald[287]: Received client request to flush runtime journal.1615sshClient # [ 8.784719] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1616sshClient # [ 8.856724] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1617sshClient # [ 8.862172] systemd[1]: Finished Create SUID/SGID Wrappers.1618sshClient # [ 8.865777] systemd[1]: Reached target System Initialization.1619sshClient # [ 8.868478] systemd[1]: Started Discard unused filesystem blocks once a week.1620sshClient # [ 8.872240] systemd[1]: Started Daily Cleanup of Temporary Directories.1621sshClient # [ 8.874639] systemd[1]: Reached target Timer Units.1622sshClient # [ 8.877256] systemd[1]: Listening on D-Bus System Message Bus Socket.1623sshClient # [ 8.879803] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1624sshClient # [ 8.883047] systemd[1]: Reached target Socket Units.1625sshClient # [ 8.888594] systemd[1]: Reached target Basic System.1626machine # [ 8.932562] systemd[1]: Finished Load/Save OS Random Seed.1627machine # [ 8.935502] systemd[1]: Mounted Kernel Configuration File System.1628sshClient # [ 8.893286] systemd[1]: Starting Import lastlog data into lastlog2 database...1629machine # [ 8.940224] systemd[1]: Finished Apply Kernel Variables.1630machine # [ 8.945241] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1631sshClient # [ 8.903760] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1632machine # [ 8.947329] systemd[1]: Starting Create Static Device Nodes in /dev...1633machine # [ 8.949171] systemd[1]: Finished Create Static Device Nodes in /dev.1634machine # [ 8.951973] systemd[1]: Finished Flush Journal to Persistent Storage.1635machine # [ 8.957440] systemd[1]: Reached target Preparation for Local File Systems.1636sshClient # [ 8.919282] systemd[1]: Starting Post-Boot Actions...1637machine # [ 8.964417] systemd[1]: Starting Rule-based Manager for Device Events and Files...1638sshClient # [ 8.933133] systemd[1]: Started Reset console on configuration changes.1639sshClient # [ 8.955652] systemd[1]: Starting resolvconf update...1640sshClient # [ 9.001323] systemd[1]: Starting Home Area Manager...1641machine # [ 9.057369] systemd[1]: Finished Coldplug All udev Devices.1642machine # [ 9.070553] systemd-udevd[331]: Using default interface naming scheme 'v261'.1643sshClient # [ 9.060274] nsncd[475]: Sep 10 02:49:57.931 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1644sshClient # [ 9.070441] systemd[1]: Started Name Service Cache Daemon (nsncd).1645machine # [ 9.120873] systemd[1]: Mounting /run/wrappers...1646sshClient # [ 9.078390] systemd[1]: Finished Post-Boot Actions.1647machine # [ 9.149248] systemd[1]: Starting User Database Manager...1648sshClient # [ 9.113217] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1649sshClient # [ 9.120251] systemd[1]: Reached target Host and Network Name Lookups.1650machine # [ 9.164661] systemd[1]: Mounted /run/wrappers.1651sshClient # [ 9.122195] systemd[1]: Reached target User and Group Name Lookups.1652machine # [ 9.166519] systemd[1]: Reached target Local File Systems.1653machine # [ 9.171114] systemd[1]: Listening on Boot Loader Control Service Socket.1654sshClient # [ 9.134129] systemd[1]: Starting D-Bus System Message Bus...1655machine # [ 9.177119] systemd[1]: Starting Create SUID/SGID Wrappers...1656machine # [ 9.178832] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1657machine # [ 9.186565] systemd[1]: Starting Create System Files and Directories...1658sshClient # [ 9.162912] systemd[1]: Starting User Login Management...1659sshClient # [ 9.171813] systemd[1]: Finished Import lastlog data into lastlog2 database.1660sshClient # [ 9.187061] systemd-homed[486]: Watching /home.1661sshClient # [ 9.201580] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1662machine # [ 9.258205] systemd[1]: Started User Database Manager.1663sshClient # [ 9.235955] systemd[1]: Started backdoor.service.1664machine # [ 9.304382] systemd[1]: Finished Create System Files and Directories.1665machine # [ 9.316884] systemd[1]: Starting Rebuild Journal Catalog...1666machine # [ 9.320593] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1667sshClient # [ 9.308931] (udev-worker)[424]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1668sshClient # [ 9.322648] (udev-worker)[424]: Network interface NamePolicy= disabled on kernel command line.1669sshClient # [ 9.329363] (udev-worker)[425]: Network interface NamePolicy= disabled on kernel command line.1670sshClient # [ 9.351187] systemd[1]: Finished Firewall.1671sshClient # [ 9.356727] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'...1672machine # [ 9.399868] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1673sshClient # [ 9.373076] systemd[1]: Stopped target Host and Network Name Lookups.1674sshClient # [ 9.376626] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync'1675sshClient # [ 9.381493] dbus-broker-launch[512]: Invalid user-name in /nix/store/x96zc7s37zc7zhq1bbh8shbx7z7y4dhx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1676sshClient # [ 9.386217] systemd[1]: Stopping Host and Network Name Lookups...1677machine # [ 9.430640] systemd[1]: Started Rule-based Manager for Device Events and Files.1678sshClient # [ 9.389303] systemd[1]: Stopped target User and Group Name Lookups.1679sshClient # [ 9.393324] systemd[1]: Stopping User and Group Name Lookups...1680sshClient # connecting to host...1681sshClient # [ 9.396236] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1682sshClient # [ 9.400330] systemd[1]: nscd.service: Deactivated successfully.1683sshClient # [ 9.404085] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1684machine # [ 9.449784] systemd[1]: Finished Rebuild Journal Catalog.1685machine # [ 9.457300] systemd[1]: Starting Update is Completed...1686sshClient # [ 9.425887] systemd[1]: Started D-Bus System Message Bus.1687sshClient # [ 9.451139] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1688sshClient # [ 9.455718] systemd-logind[516]: New seat seat0.1689sshClient # [ 9.462653] systemd[1]: Started User Login Management.1690machine # [ 9.510827] systemd[1]: Finished Update is Completed.1691sshClient # [ 9.478833] systemd[1]: Starting linger-users.service...1692sshClient # [ 9.484518] dbus-broker-launch[512]: Ready1693sshClient # [ 9.507228] systemd[1]: Started Home Area Manager.1694sshClient # [ 9.531231] systemd[1]: Finished Home Area Activation.1695sshClient # [ 9.542234] systemd[1]: Starting First Boot Home Area Wizard...1696sshClient # [ 9.559521] nsncd[581]: Sep 10 02:49:58.430 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1697sshClient # [ 9.564947] systemd[1]: Started Name Service Cache Daemon (nsncd).1698sshClient # [ 9.567463] systemd[1]: Reached target Host and Network Name Lookups.1699sshClient # [ 9.574620] systemd[1]: Reached target User and Group Name Lookups.1700sshClient # [ 9.587810] systemd[1]: linger-users.service: Deactivated successfully.1701sshClient # [ 9.592215] systemd[1]: Finished linger-users.service.1702sshClient # [ 9.616653] systemd[1]: Finished resolvconf update.1703sshClient # [ 9.618115] systemd[1]: Reached target Preparation for Network.1704sshClient # [ 9.628593] systemd[1]: Starting DHCP Client...1705sshClient # [ 9.635107] systemd[1]: Starting Extra networking commands....1706sshClient # [ 9.659282] systemd[1]: Condition check resulted in Virtio network device being skipped.1707sshClient # [ 9.679349] systemd[1]: Starting Address configuration of eth1...1708sshClient # [ 9.685747] systemd[1]: Finished First Boot Home Area Wizard.1709sshClient # [ 9.703610] systemd[1]: Reached target First Boot Complete.1710machine # [ 9.751310] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1711sshClient # [ 9.711785] systemd[1]: Starting Save Transient machine-id to Disk...1712machine # [ 9.854348] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1713sshClient # [ 9.813827] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1714machine # [ 9.858154] systemd[1]: Finished Create SUID/SGID Wrappers.1715machine # [ 9.860851] systemd[1]: Reached target System Initialization.1716machine # [ 9.863845] systemd[1]: Started Discard unused filesystem blocks once a week.1717machine # [ 9.867169] systemd[1]: Started Daily Cleanup of Temporary Directories.1718machine # [ 9.870246] systemd[1]: Reached target Timer Units.1719machine # [ 9.872263] systemd[1]: Listening on D-Bus System Message Bus Socket.1720sshClient # [ 9.831748] systemd[1]: Finished Save Transient machine-id to Disk.1721machine # [ 9.876887] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1722machine # [ 9.880252] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1723machine # [ 9.882848] systemd[1]: Reached target Socket Units.1724machine # [ 9.885264] systemd[1]: Reached target Basic System.1725machine # [ 9.890138] systemd[1]: Starting Import lastlog data into lastlog2 database...1726machine # [ 9.897539] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1727sshClient # [ 9.862051] network-addresses-eth1-start[613]: adding address 192.168.1.2/24... done1728machine # [ 9.911611] systemd[1]: Starting Post-Boot Actions...1729sshClient # [ 9.885499] network-addresses-eth1-start[613]: adding address 2001:db8:1::2/64... done1730machine # [ 9.929617] systemd[1]: Started Reset console on configuration changes.1731machine # [ 9.952126] systemd[1]: Starting resolvconf update...1732sshClient # [ 9.917241] systemd[1]: Finished Address configuration of eth1.1733machine # [ 9.977116] systemd[1]: Starting SSH Host Keys Generation...1734sshClient # [ 9.975307] systemd[1]: Finished Extra networking commands..1735sshClient # [ 9.978266] systemd[1]: Reached target Network.1736machine # [ 10.022197] systemd[1]: Starting Home Area Manager...1737sshClient # [ 9.987729] systemd[1]: Starting Permit User Sessions...1738sshClient # [ 10.001347] dhcpcd[626]: dhcpcd-10.3.2 starting1739sshClient # [ 10.013990] dhcpcd[680]: dev: loaded udev1740machine # [ 10.072980] nsncd[482]: Sep 10 02:49:58.899 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1741machine # [ 10.080228] systemd[1]: Started Name Service Cache Daemon (nsncd).1742sshClient # [ 10.039338] systemd[1]: Finished Permit User Sessions.1743sshClient # [ 10.305108] 8021q: 802.1Q VLAN Support v1.81744sshClient # [ 10.310161] 8021q: adding VLAN 0 to HW filter on device eth11745sshClient # [ 10.053131] systemd[1]: Started Getty on tty1.1746sshClient # [ 10.054550] systemd[1]: Reached target Login Prompts.1747machine # [ 10.100155] systemd[1]: Finished Post-Boot Actions.1748sshClient # [ 10.334192] mousedev: PS/2 mouse device common for all mice1749sshClient # [ 10.339687] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31750sshClient # [ 10.341815] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1751machine # [ 10.143705] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1752machine # [ 10.152644] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1753machine # [ 10.163377] systemd[1]: Reached target Host and Network Name Lookups.1754machine # [ 10.167758] systemd[1]: Reached target User and Group Name Lookups.1755machine # [ 10.176570] systemd[1]: Started backdoor.service.1756machine # [ 10.189400] (udev-worker)[433]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1757machine # [ 10.204138] systemd[1]: Starting D-Bus System Message Bus...1758machine # [ 10.207751] (udev-worker)[433]: Network interface NamePolicy= disabled on kernel command line.1759machine # [ 10.213616] (udev-worker)[434]: Network interface NamePolicy= disabled on kernel command line.1760machine # [ 10.229196] systemd-homed[495]: Watching /home.1761machine # [ 10.255396] systemd[1]: Starting User Login Management...1762machine # [ 10.285390] systemd[1]: Finished Import lastlog data into lastlog2 database.1763sshClient # [ 10.369811] ACPI: button: Power Button [PWRF]1764sshClient # [ 10.473188] cfg80211: Loading compiled-in X.509 certificates for regulatory database1765sshClient # [ 10.476247] rtc_cmos 00:04: RTC can wake from S41766sshClient # [ 10.494140] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1767sshClient # [ 10.494258] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1768sshClient # [ 10.305421] dhcpcd[680]: eth0: waiting for carrier1769sshClient # [ 10.308385] dhcpcd[680]: libudev: received NULL device1770sshClient # [ 10.309814] dhcpcd[680]: libudev: received NULL device1771sshClient # [ 10.312313] dhcpcd[680]: eth0: carrier acquired1772machine # connecting to host...1773sshClient # [ 10.324204] dhcpcd[680]: DUID 00:01:00:01:32:34:d7:57:52:54:00:12:34:561774sshClient # [ 10.326235] dhcpcd[680]: eth0: IAID 00:12:34:561775sshClient # [ 10.495959] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21776sshClient # [ 10.329271] dhcpcd[680]: eth0: adding address fe80::5054:ff:fe12:34561777sshClient # [ 10.495964] cfg80211: failed to load regulatory.db1778sshClient # [ 10.498818] rtc_cmos 00:04: registered as rtc01779sshClient # [ 10.498946] rtc_cmos 00:04: setting system clock to 2026-09-10T02:49:59 UTC (1789008599)1780machine # [ 10.405485] systemd[1]: Finished Firewall.1781sshClient # [ 10.499067] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1782sshClient # [ 10.506675] parport_pc 00:02: reported by Plug and Play ACPI1783machine: Guest shell says: b'Spawning backdoor root shell...\n'1784sshClient # [ 10.506801] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1785machine # [ 10.428111] systemd[1]: Stopped target Host and Network Name Lookups.1786sshClient # [ 10.512947] Console: switching to colour dummy device 80x251787machine # [ 10.429785] systemd[1]: Stopping Host and Network Name Lookups...1788sshClient # [ 10.558520] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1789machine # [ 10.431553] systemd[1]: Stopped target User and Group Name Lookups.1790sshClient # [ 10.565757] 8021q: adding VLAN 0 to HW filter on device eth01791machine # [ 10.437666] systemd[1]: Stopping User and Group Name Lookups...1792machine: connected to guest root shell1793machine # [ 10.441471] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1794machine: (connecting took 11.47 seconds)1795machine # [ 10.446371] systemd[1]: nscd.service: Deactivated successfully.1796machine: (finished: waiting for the VM to finish booting, in 11.47 seconds)1797machine # [ 10.452091] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1798sshClient # [ 10.425651] dhcpcd[680]: eth0: soliciting a DHCP lease1799sshClient # [ 10.592402] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41800sshClient # [ 10.647296] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1801machine # [ 10.488965] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1802machine # [ 10.495978] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'...1803sshClient # [ 10.647434] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1804sshClient # [ 10.693001] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61805sshClient # [ 10.459694] dhcpcd[680]: eth0: offered 10.0.2.15 from 10.0.2.21806sshClient # [ 10.462240] dhcpcd[680]: eth0: probing address 10.0.2.15/241807machine # [ 10.525344] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync'1808sshClient # [ 10.693455] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51809sshClient # [ 10.711937] NET: Registered PF_PACKET protocol family1810machine # [ 10.527835] dbus-broker-launch[530]: Invalid user-name in /nix/store/4ibzvz16qxd9s1952yq2zsi2sxxjv3q5-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1811sshClient # [ 10.492510] systemd[1]: Starting Virtual Console Setup...1812sshClient # [ 10.782305] [drm] Found bochs VGA, ID 0xb0c5.1813machine # [ 10.575700] systemd[1]: Started D-Bus System Message Bus.1814sshClient # [ 10.801496] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1815machine # [ 10.582516] systemd-logind[545]: New seat seat0.1816machine # [ 10.589167] systemd[1]: Started User Login Management.1817sshClient # [ 10.820253] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1818machine # [ 10.602544] systemd[1]: Starting linger-users.service...1819sshClient # [ 10.821663] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01820sshClient # [ 10.565399] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1821machine # [ 10.621437] nsncd[599]: Sep 10 02:49:59.451 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1822sshClient # [ 10.595609] systemd-logind[516]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1823machine # [ 10.649407] dbus-broker-launch[530]: Ready1824sshClient # [ 10.622340] systemd-logind[516]: Watching system buttons on /dev/input/event2 (Power Button)1825sshClient # [ 10.631840] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1826sshClient # [ 10.636828] systemd[1]: Stopped Virtual Console Setup.1827sshClient # [ 10.645780] systemd[1]: Starting Virtual Console Setup...1828machine # [ 10.693107] systemd[1]: Started Name Service Cache Daemon (nsncd).1829machine # [ 10.697083] systemd[1]: linger-users.service: Deactivated successfully.1830machine # [ 10.704750] systemd[1]: Finished linger-users.service.1831machine # [ 10.708258] systemd[1]: Condition check resulted in Virtio network device being skipped.1832machine # [ 10.721892] systemd[1]: Reached target Host and Network Name Lookups.1833machine # [ 10.723571] systemd[1]: Reached target User and Group Name Lookups.1834machine # [ 10.734124] systemd[1]: Started Home Area Manager.1835machine # [ 10.743178] systemd[1]: Finished Home Area Activation.1836machine # [ 10.755488] systemd[1]: Starting First Boot Home Area Wizard...1837sshClient # [ 10.958772] ppdev: user-space parallel port driver1838sshClient # [ 10.982315] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1839machine # [ 10.804057] systemd[1]: Finished resolvconf update.1840machine # [ 10.812794] systemd[1]: Reached target Preparation for Network.1841sshClient # [ 10.988319] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1842sshClient # [ 10.997147] Console: switching to colour frame buffer device 160x501843machine # [ 10.826045] systemd[1]: Starting DHCP Client...1844sshClient # [ 11.046717] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1845sshClient # [ 10.742468] systemd-logind[516]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1846machine # [ 10.835321] systemd[1]: Starting Address configuration of eth1...1847sshClient # [ 10.793176] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1848sshClient # [ 10.796481] systemd[1]: Stopped Virtual Console Setup.1849sshClient # [ 10.805588] systemd[1]: Starting Virtual Console Setup...1850machine # [ 10.859321] systemd[1]: Starting Extra networking commands....1851machine # [ 10.907221] systemd[1]: Created slice Slice /system/systemd-mute-console.1852machine # [ 10.917388] systemd[1]: Started Console Output Muting Service (PID 626/UID 0).1853sshClient # [ 11.148241] kvm_amd: TSC scaling supported1854sshClient # [ 11.149221] kvm_amd: Nested Virtualization enabled1855sshClient # [ 11.150688] kvm_amd: Nested Paging enabled1856sshClient # [ 11.152475] kvm_amd: LBR virtualization supported1857sshClient # [ 11.154744] kvm_amd: Virtual VMLOAD VMSAVE supported1858sshClient # [ 11.155934] kvm_amd: Virtual GIF supported1859sshClient # [ 11.157055] kvm_amd: Virtual NMI enabled1860sshClient # [ 11.197827] EDAC MC: Ver: 3.0.01861machine # [ 11.053609] network-addresses-eth1-start[630]: adding address 192.168.1.1/24... done1862machine # [ 11.081556] network-addresses-eth1-start[630]: adding address 2001:db8:1::1/64... done1863machine # [ 11.138502] systemd[1]: Finished Address configuration of eth1.1864machine # [ 11.310704] dhcpcd[643]: dhcpcd-10.3.2 starting1865machine # [ 11.326192] dhcpcd[694]: dev: loaded udev1866machine # [ 11.337807] systemd[1]: Finished Extra networking commands..1867machine # [ 11.343114] systemd[1]: Reached target Network.1868sshClient # [ 11.310463] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones.1869sshClient # [ 11.315971] systemd[1]: Finished Virtual Console Setup.1870machine # [ 11.447681] sshd-keygen-start[543]: Generating public/private rsa key pair.1871machine # [ 11.450091] sshd-keygen-start[543]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1872machine # [ 11.452873] sshd-keygen-start[543]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1873machine # [ 11.456146] sshd-keygen-start[543]: The key fingerprint is:1874machine # [ 11.457557] sshd-keygen-start[543]: SHA256:yIgqiOc7KQ5i9kPgiy+s3fbL+wok6jStKUjSZ3TQYKs root@machine1875machine # [ 11.459672] sshd-keygen-start[543]: The key's randomart image is:1876machine # [ 11.462346] sshd-keygen-start[543]: +---[RSA 4096]----+1877machine # [ 11.464614] sshd-keygen-start[543]: | oo |1878machine # [ 11.466624] sshd-keygen-start[543]: | .... |1879machine # [ 11.469510] sshd-keygen-start[543]: | .. |1880machine # [ 11.470913] sshd-keygen-start[543]: | . o.o.. |1881machine # [ 11.473137] sshd-keygen-start[543]: |..E.o.o S |1882machine # [ 11.474489] sshd-keygen-start[543]: |+=o+o |1883machine # [ 11.477456] sshd-keygen-start[543]: |#=+=. |1884machine # [ 11.478885] sshd-keygen-start[543]: |#*Bo.o |1885machine # [ 11.480440] sshd-keygen-start[543]: |=O==o.*=. |1886machine # [ 11.482466] sshd-keygen-start[543]: +----[SHA256]-----+1887machine # [ 11.565367] sshd-keygen-start[704]: Generating public/private ed25519 key pair.1888machine # [ 11.567272] sshd-keygen-start[704]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1889machine # [ 11.569481] sshd-keygen-start[704]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1890machine # [ 11.573080] sshd-keygen-start[704]: The key fingerprint is:1891machine # [ 11.574543] sshd-keygen-start[704]: SHA256:dq889z484SgkSI85cBOic/1y4whRDji6dpplck/oRI4 root@machine1892machine # [ 11.576680] sshd-keygen-start[704]: The key's randomart image is:1893machine # [ 11.579246] sshd-keygen-start[704]: +--[ED25519 256]--+1894machine # [ 11.580887] sshd-keygen-start[704]: | . |1895machine # [ 11.584124] sshd-keygen-start[704]: | o o o |1896machine # [ 11.585519] sshd-keygen-start[704]: | . o * . |1897machine # [ 11.589399] sshd-keygen-start[704]: |. o.+ * |1898machine # [ 11.590750] sshd-keygen-start[704]: | .+o.= BS . |1899machine # [ 11.592142] sshd-keygen-start[704]: |.E O..*.*... . |1900machine # [ 11.593478] sshd-keygen-start[704]: |. @ o. * + .+ . |1901machine # [ 11.601267] sshd-keygen-start[704]: | o . .. ..o.o = |1902machine # [ 11.602616] sshd-keygen-start[704]: | o+ ooo |1903machine # [ 11.603976] sshd-keygen-start[704]: +----[SHA256]-----+1904machine # [ 11.605702] systemd[1]: sshd-keygen.service: Deactivated successfully.1905machine # [ 11.609254] systemd[1]: Finished SSH Host Keys Generation.1906machine # [ 11.621485] systemd[1]: Starting SSH Daemon...1907machine # [ 11.701744] sshd[707]: Server listening on 0.0.0.0 port 22.1908machine # [ 11.704914] sshd[707]: Server listening on :: port 22.1909machine # [ 11.707836] systemd[1]: Started SSH Daemon.1910machine # [ 11.755700] dhcpcd[694]: eth0: waiting for carrier1911machine # [ 11.757264] dhcpcd[694]: eth0: carrier acquired1912machine # [ 11.774103] dhcpcd[694]: DUID 00:01:00:01:32:34:d7:58:52:54:00:12:34:561913machine # [ 11.776392] dhcpcd[694]: eth0: IAID 00:12:34:561914machine # [ 11.779345] dhcpcd[694]: eth0: adding address fe80::5054:ff:fe12:34561915machine: (finished: waiting for unit systemd-homed.service, in 12.79 seconds)1916machine: waiting for Please enter user name to create to appear on tty 11917machine: (finished: waiting for Please enter user name to create to appear on tty 1, in 0.07 seconds)1918machine: sending keys 'test-homed-user\n'1919sshClient # [ 11.860814] dhcpcd[680]: eth0: soliciting an IPv6 router1920sshClient # [ 11.865443] dhcpcd[680]: eth0: Router Advertisement from fe80::21921sshClient # [ 11.869647] dhcpcd[680]: eth0: adding address fec0::5054:ff:fe12:3456/641922sshClient # [ 11.873969] dhcpcd[680]: eth0: adding route to fec0::/641923sshClient # [ 11.877625] dhcpcd[680]: eth0: adding default route via fe80::21924machine # [ 11.949901] systemd[1]: Starting Virtual Console Setup...1925machine # [ 12.018788] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1926machine # [ 12.020844] systemd[1]: Stopped Virtual Console Setup.1927machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)1928machine # [ 12.030876] systemd-logind[545]: Watching system buttons on /dev/input/event2 (Power Button)1929machine: waiting for Please enter new password for user test-homed-user: to appear on tty 11930machine # [ 12.044256] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1931machine # [ 12.053195] systemd[1]: Starting Virtual Console Setup...1932machine # [ 12.055387] systemd-logind[545]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1933machine # [ 12.387357] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1934machine # [ 12.391796] systemd[1]: Stopped Virtual Console Setup.1935machine # [ 12.403162] systemd[1]: Starting Virtual Console Setup...1936machine # [ 12.432945] systemd-logind[545]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1937machine # [ 12.709791] systemd-vconsole-setup[758]: Configuration of first virtual console was skipped, ignoring remaining ones.1938machine # [ 12.714580] systemd[1]: Finished Virtual Console Setup.1939machine # [ 13.053980] dhcpcd[694]: eth0: soliciting a DHCP lease1940machine # [ 13.095500] dhcpcd[694]: eth0: offered 10.0.2.15 from 10.0.2.21941machine # [ 13.101577] dhcpcd[694]: eth0: probing address 10.0.2.15/241942machine: (finished: waiting for Please enter new password for user test-homed-user: to appear on tty 1, in 1.18 seconds)1943machine: sending keys 'foobarfoo\n'1944machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1945machine: waiting for (repeat) to appear on tty 11946machine # [ 13.858684] dhcpcd[694]: eth0: soliciting an IPv6 router1947machine # [ 13.862868] dhcpcd[694]: eth0: Router Advertisement from fe80::21948machine # [ 13.867674] dhcpcd[694]: eth0: adding address fec0::5054:ff:fe12:3456/641949machine # [ 13.871851] dhcpcd[694]: eth0: adding route to fec0::/641950machine # [ 13.875722] dhcpcd[694]: eth0: adding default route via fe80::21951machine: (finished: waiting for (repeat) to appear on tty 1, in 1.12 seconds)1952machine: sending keys 'foobarfoo\n'1953machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)1954machine: waiting for unit systemd-homed-firstboot.service1955sshClient # [ 15.608595] dhcpcd[680]: eth0: leased 10.0.2.15 for 86400 seconds1956sshClient # [ 15.610302] dhcpcd[680]: eth0: adding route to 10.0.2.0/241957sshClient # [ 15.614412] dhcpcd[680]: eth0: adding default route via 10.0.2.21958sshClient # [ 15.749229] systemd[1]: Started DHCP Client.1959sshClient # [ 15.752468] systemd[1]: Reached target Multi-User System.1960sshClient # [ 15.754334] systemd[1]: Startup finished in 1.068s (kernel) + 4.339s (initrd) + 10.346s (userspace) = 15.753s.1961machine # [ 18.571833] dhcpcd[694]: eth0: leased 10.0.2.15 for 86400 seconds1962machine # [ 18.576505] dhcpcd[694]: eth0: adding route to 10.0.2.0/241963machine # [ 18.580761] dhcpcd[694]: eth0: adding default route via 10.0.2.21964machine # [ 18.723187] systemd[1]: Started DHCP Client.1965machine # [ 24.697813] systemd-homed[495]: Generating key pair for signing local user identity records.1966machine # [ 24.705180] systemd-homed[495]: Successfully created Ed25519 key pair.1967machine # [ 24.728663] systemd-homed[495]: test-homed-user: changing state absent → creating1968machine # [ 24.814878] systemd-homework[884]: Using automatic default storage of 'luks'.1969machine # [ 24.821822] systemd-homework[884]: Sizing home to 83% of available disk space, which is 744M.1970machine # [ 24.824569] systemd-homework[884]: Allocating image file completed.1971machine # [ 24.845281] systemd-homework[884]: Writing of partition table completed.1972machine # [ 24.849541] systemd-homework[884]: Setting up loopback device /dev/loop0 completed.1973machine # [ 26.296878] systemd-homework[884]: LUKS formatting completed.1974machine # [ 28.083486] systemd-homework[884]: Writing password to LUKS keyslot 0 completed.1975machine # [ 28.354853] systemd-homework[884]: LUKS activation by volume key succeeded.1976machine # [ 28.373491] systemd-homework[884]: Writing user record as LUKS token completed.1977machine # [ 28.375931] systemd-homework[884]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.1978machine # [ 28.378235] systemd-homework[884]: Formatting /dev/mapper/home-test-homed-user as btrfs1979machine # [ 28.793336] systemd[1]: proc-920-mounts.mount: Deactivated successfully.1980machine # [ 28.795314] systemd-homework[884]: /dev/mapper/home-test-homed-user successfully formatted as btrfs (label "test-homed-user", uuid ca12da34-6e79-46db-99ab-eb1fe87922ce)1981machine # [ 28.798812] systemd-homework[884]: Formatting file system completed.1982machine # [ 28.855094] systemd-homework[884]: Mounting file system completed.1983machine # [ 28.858921] systemd-homework[884]: Skeleton directory /etc/skel missing, ignoring.1984machine # [ 28.860826] systemd-homework[884]: Wrote embedded .identity file.1985machine # [ 28.862416] systemd-homework[884]: Replaced embedded blob dir with contents of system blob dir.1986machine # [ 28.864567] systemd-homework[884]: Recursive changing of ownership completed.1987machine # [ 28.867459] systemd-homework[884]: Changed top-level directory access mode to 0700.1988machine # [ 28.874118] systemd-homework[884]: Synchronized disk.1989machine # [ 28.876805] systemd-homework[884]: Discarded unused 652.8M.1990machine # [ 28.889926] systemd-homed[495]: block device /sys/devices/virtual/block/dm-0 has been removed.1991machine # [ 28.901415] systemd-homed[495]: block device /sys/devices/virtual/block/dm-0 has been removed.1992machine # [ 28.910976] systemd-homework[884]: Moved image file into place.1993machine # [ 28.912875] systemd-homework[884]: Creation completed.1994machine # [ 28.915201] systemd-homework[884]: Image size is 744M, file system size is 726M, file system payload size is 726M, file system free is 719.9M.1995machine # [ 28.929191] systemd-homed[495]: test-homed-user: changing state creating → inactive1996machine # [ 28.931481] systemd-homed[495]: block device /sys/devices/virtual/block/loop0 has been removed.1997machine # [ 28.939896] systemd[1]: Finished First Boot Home Area Wizard.1998machine # [ 28.944391] systemd[1]: systemd-mute-console@0-1-626_627-0.service: Deactivated successfully.1999machine # [ 28.950519] systemd[1]: Reached target First Boot Complete.2000machine # [ 28.954680] systemd[1]: Starting Save Transient machine-id to Disk...2001machine # [ 28.960619] systemd[1]: Starting Permit User Sessions...2002machine # [ 28.997125] systemd[1]: Finished Permit User Sessions.2003machine # [ 29.004406] systemd[1]: Started Getty on tty1.2004machine # [ 29.007289] systemd[1]: Reached target Login Prompts.2005machine # [ 29.009623] systemd[1]: Reached target Multi-User System.2006machine # [ 29.015521] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2007machine # [ 29.020260] systemd[1]: Finished Save Transient machine-id to Disk.2008machine # [ 29.022605] systemd[1]: Startup finished in 1.084s (kernel) + 5.142s (initrd) + 22.794s (userspace) = 29.022s.2009machine: (finished: waiting for unit systemd-homed-firstboot.service, in 14.95 seconds)2010(finished: subtest: create systemd-homed user on first boot prompt, in 30.49 seconds)2011machine: must succeed: homectl update test-homed-user --offline -G wheel2012machine # [ 29.520533] systemd-homed[495]: test-homed-user: changing state inactive → updating2013machine # [ 29.526830] systemd-homework[966]: Offline update requested. Not touching embedded records.2014machine # [ 29.529607] systemd-homed[495]: Home test-homed-user is signed exclusively by our key, accepting.2015machine # [ 29.535046] systemd-homed[495]: test-homed-user: changing state updating → inactive2016machine: (finished: must succeed: homectl update test-homed-user --offline -G wheel, in 0.05 seconds)2017subtest: login as homed user2018machine: waiting for login: to appear on tty 12019machine: (finished: waiting for login: to appear on tty 1, in 0.04 seconds)2020machine: sending keys 'test-homed-user\n'2021machine: (finished: sending keys 'test-homed-user\n', in 0.17 seconds)2022machine: waiting for Password: to appear on tty 12023machine # [ 29.954253] systemd-homed[495]: test-homed-user: changing state inactive → activating-for-acquire2024machine # [ 29.961739] systemd-homework[981]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2025machine # [ 29.969337] systemd-homed[495]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2026machine # [ 29.972580] systemd-homed[495]: test-homed-user: changing state activating-for-acquire → inactive2027machine # [ 29.975095] systemd-homed[495]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2028machine # [ 29.977799] systemd-homed[495]: Home test-homed-user already deactivated, no automatic deactivation needed.2029machine: (finished: waiting for Password: to appear on tty 1, in 1.11 seconds)2030machine: sending keys 'foobarfoo\n'2031machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2032machine: waiting for success: pgrep -u test-homed-user -t tty1 bash2033machine # [ 31.048702] systemd-homed[495]: test-homed-user: changing state inactive → activating-for-acquire2034machine # [ 31.082534] systemd-homework[993]: Provided password unlocks user record.2035machine # [ 31.093118] systemd-homework[993]: Successfully locked image file '/home/test-homed-user.home'.2036machine # [ 31.100103] systemd-homework[993]: Allocated additional 652.8M.2037machine # [ 31.363499] loop1: detected capacity change from 0 to 15196162038machine # [ 31.106497] systemd-homework[993]: Setting up loopback device /dev/loop1 completed.2039machine # [ 31.974069] systemd-homework[993]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2040machine # [ 32.003648] systemd-homework[993]: Provided password unlocks user record.2041machine # [ 32.010080] systemd-homework[993]: Probing file system completed (found btrfs).2042machine # [ 32.016424] systemd-homework[993]: No fsck for file system btrfs installed, ignoring.2043machine # [ 32.278946] BTRFS: device label test-homed-user devid 1 transid 9 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (993)2044machine # [ 32.282177] BTRFS info (device dm-0): first mount of filesystem ca12da34-6e79-46db-99ab-eb1fe87922ce2045machine # [ 32.284857] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2046machine # [ 32.289862] BTRFS info (device dm-0): enabling free space tree2047machine # [ 32.291134] BTRFS info (device dm-0): use zstd compression, level 12048machine # [ 32.033637] systemd-homework[993]: Mounting file system completed.2049machine # [ 32.036689] systemd-homework[993]: Discovered used loopback device /dev/loop1.2050machine # [ 32.038598] systemd-homework[993]: offset = 1048576, size = 778043392, image = 7801405442051machine # [ 32.051367] systemd-homework[993]: Ready to resize image size 744M → 897M, partition size 742M → 895M, file system size 726M → 879M.2052machine # [ 32.054564] systemd-homework[993]: Growing of image file from 744M to 897M completed.2053machine # [ 32.318146] loop1: detected capacity change from 1519616 to 18329602054machine # [ 32.063269] systemd-homework[993]: Refreshing loop device size completed.2055machine # [ 32.080823] systemd-homework[993]: Growing of partition completed.2056machine # [ 32.366310] async_tx: api initialized (async)2057machine # [ 32.158283] systemd-homework[993]: LUKS device growing completed.2058machine # [ 32.421480] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 761266176 to 9216983042059machine # [ 32.166249] systemd-homework[993]: File system resizing from 726M to 879M completed.2060machine # [ 32.169216] systemd-homework[993]: Synchronized disk.2061machine # [ 32.170608] systemd-homework[993]: Synchronized disk.2062machine # [ 32.171949] systemd-homework[993]: Resizing completed.2063machine # [ 32.173389] systemd-homework[993]: Image size is 897M, file system size is 879M, file system payload size is 879M, file system free is 872.9M.2064machine # [ 32.176329] systemd-homework[993]: Read embedded .identity file.2065machine # [ 32.198066] systemd-homework[993]: Provided password unlocks user record.2066machine # [ 32.200300] systemd-homework[993]: Reconciling header user identity completed (host version was newer).2067machine # [ 32.202561] systemd-homework[993]: Reconciling embedded user identity completed (host version was newer).2068machine # [ 32.219345] systemd-homework[993]: Wrote LUKS header user record.2069machine # [ 32.221058] systemd-homework[993]: Wrote embedded .identity file.2070machine # [ 32.222657] systemd-homework[993]: Replaced embedded blob dir with contents of system blob dir.2071machine # [ 32.225790] systemd-homework[993]: Recursive changing of ownership not necessary, skipped.2072machine # [ 32.231090] systemd-homework[993]: Synchronized disk.2073machine # [ 32.233759] systemd-homework[993]: Moving to final mount point /home/test-homed-user completed.2074machine # [ 32.253885] systemd-homework[993]: Activation completed.2075machine # [ 32.256250] systemd-homework[993]: Image size is 895M, file system size is 879M, file system payload size is 879M, file system free is 872.9M.2076machine # [ 32.268423] systemd-homed[495]: Home test-homed-user is signed exclusively by our key, accepting.2077machine # [ 32.277460] systemd-homed[495]: test-homed-user: changing state activating-for-acquire → active2078machine # [ 32.279827] login[957]: pam_systemd_home(login:auth): Home for user test-homed-user successfully acquired.2079machine # [ 32.289929] systemd-homed[495]: test-homed-user: changing state active → resizing-while-active2080machine # [ 32.304336] systemd-homework[1038]: Successfully acquired home volume key from kernel keyring.2081machine # [ 32.308349] systemd-homework[1038]: LUKS volume key from keyring unlocks user record.2082machine # [ 32.403593] login[957]: pam_unix(login:session): session opened for user test-homed-user(uid=60388) by LOGIN(uid=0)2083machine # [ 32.427203] systemd-homework[1038]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2084machine # [ 32.461749] systemd[1]: Created slice Slice /user/60388.2085machine # [ 32.468913] systemd[1]: Starting User Runtime Directory /run/user/60388...2086machine # [ 32.492285] systemd-logind[545]: New session '1' of user 'test-homed-user' with class 'user' and type 'tty'.2087machine # [ 32.543857] systemd[1]: Finished User Runtime Directory /run/user/60388.2088machine # [ 32.561560] systemd[1]: Starting User Manager for UID 60388...2089machine # [ 32.616658] (systemd)[1043]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2090machine # [ 32.718697] (systemd)[1043]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2091machine # [ 32.726973] systemd-logind[545]: New session '2' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2092machine # [ 32.755176] systemd-homework[1038]: Successfully re-activated LUKS device.2093machine # [ 32.759748] systemd-homework[1038]: LUKS volume key from keyring unlocks user record.2094machine # [ 32.762695] systemd-homework[1038]: Discovered used loopback device /dev/loop1.2095machine # [ 32.765225] systemd-homework[1038]: Read embedded .identity file.2096machine # [ 32.767503] systemd-homework[1038]: LUKS volume key from keyring unlocks user record.2097machine # [ 32.770045] systemd-homework[1038]: Reconciling header user identity completed (host version was newer).2098machine # [ 32.773544] systemd-homework[1038]: Reconciling embedded user identity completed (host version was newer).2099machine # [ 32.776202] systemd-homework[1038]: offset = 1048576, size = 938475520, image = 9405726722100machine # [ 32.785350] systemd[1043]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2101machine # [ 33.059908] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 921698304 to 7832862722102machine # [ 32.803117] systemd-homework[1038]: Ready to resize image size 897M → 765M, partition size 895M → 763M, file system size 879M → 747M.2103machine # [ 32.807086] systemd-homework[1038]: Wrote embedded .identity file.2104machine # [ 32.809136] systemd-homework[1038]: Replaced embedded blob dir with contents of system blob dir.2105machine # [ 32.811406] systemd-homework[1038]: Backing file is fully allocated already.2106machine # [ 32.813388] systemd-homework[1038]: File system resizing from 879M to 747M completed.2107machine # [ 32.816161] systemd-homework[1038]: Synchronized disk.2108machine # [ 32.874890] systemd-homework[1038]: LUKS device shrinking completed.2109machine # [ 33.137154] loop1: detected capacity change from 1832960 to 15626242110machine # [ 32.883533] systemd-homework[1038]: Refreshing loop device size completed.2111machine # [ 32.887437] systemd-homework[1038]: Shrinking of image file completed.2112machine # [ 32.909821] systemd-homework[1038]: Shrinking of partition completed.2113machine # [ 32.927854] systemd-homework[1038]: Wrote LUKS header user record.2114machine # [ 32.931783] systemd-homework[1038]: Synchronized disk.2115machine # [ 32.933962] systemd-homework[1038]: Resizing completed.2116machine # [ 32.937681] systemd-homework[1038]: Image size is 765M, file system size is 747M, file system payload size is 747M, file system free is 740.9M.2117machine # [ 32.948106] systemd-homed[495]: Home test-homed-user is signed exclusively by our key, accepting.2118machine # [ 32.957396] systemd-homed[495]: test-homed-user: changing state resizing-while-active → active2119machine # [ 32.960264] systemd-homed[495]: Rebalancing complete.2120machine # [ 33.071357] systemd[1043]: Queued start job for default target Main User Target.2121machine # [ 33.075407] systemd[1043]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2122machine # [ 33.097061] systemd[1043]: Created slice User Application Slice.2123machine # [ 33.099248] systemd[1043]: Started Daily Cleanup of User's Temporary Directories.2124machine # [ 33.101286] systemd[1043]: Reached target Paths.2125machine # [ 33.104084] systemd[1043]: Reached target Timers.2126machine # [ 33.108608] systemd[1043]: Starting D-Bus User Message Bus Socket...2127machine # [ 33.112633] systemd[1043]: Starting Create User Files and Directories...2128machine # [ 33.152772] systemd[1043]: Finished Create User Files and Directories.2129machine # [ 33.204100] systemd[1043]: Listening on D-Bus User Message Bus Socket.2130machine # [ 33.205909] systemd[1043]: Reached target Sockets.2131machine # [ 33.210845] systemd[1043]: Reached target Basic System.2132machine # [ 33.215333] systemd[1]: Started User Manager for UID 60388.2133machine # [ 33.217476] systemd[1]: Started Session 1 of User test-homed-user.2134machine # [ 33.225234] systemd[1043]: Starting Run user-specific NixOS activation...2135machine # [ 33.270130] systemd[1043]: Finished Run user-specific NixOS activation.2136machine # [ 33.272711] systemd[1043]: Reached target Main User Target.2137machine # [ 33.274918] systemd[1043]: Startup finished in 515ms.2138machine: (finished: waiting for success: pgrep -u test-homed-user -t tty1 bash, in 3.36 seconds)2139machine: sending keys 'whoami > /tmp/2\n'2140machine: (finished: sending keys 'whoami > /tmp/2\n', in 0.17 seconds)2141machine: waiting for file '/tmp/2'2142machine: (finished: waiting for file '/tmp/2', in 1.07 seconds)2143machine: must succeed: cat /tmp/22144machine: (finished: must succeed: cat /tmp/2, in 0.03 seconds)2145(finished: subtest: login as homed user, in 6.06 seconds)2146subtest: login as regular user2147sshClient: waiting for login: to appear on tty 12148sshClient: waiting for the VM to finish booting2149sshClient: Guest shell says: b'Spawning backdoor root shell...\n'2150sshClient: connected to guest root shell2151sshClient: (connecting took 0.00 seconds)2152sshClient: (finished: waiting for the VM to finish booting, in 0.00 seconds)2153sshClient: (finished: waiting for login: to appear on tty 1, in 0.10 seconds)2154sshClient: sending keys 'test-normal-user\n'2155sshClient: (finished: sending keys 'test-normal-user\n', in 0.18 seconds)2156sshClient: waiting for Password: to appear on tty 12157sshClient: (finished: waiting for Password: to appear on tty 1, in 1.14 seconds)2158sshClient: sending keys 'foobarfoo\n'2159sshClient: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2160sshClient: waiting for success: pgrep -u test-normal-user bash2161sshClient # [ 37.173534] login[683]: pam_unix(login:session): session opened for user test-normal-user(uid=1000) by LOGIN(uid=0)2162sshClient # [ 37.213896] systemd[1]: Created slice Slice /user/1000.2163sshClient # [ 37.218056] systemd[1]: Starting User Runtime Directory /run/user/1000...2164sshClient # [ 37.231965] systemd-logind[516]: New session '1' of user 'test-normal-user' with class 'user' and type 'tty'.2165sshClient # [ 37.271697] systemd[1]: Finished User Runtime Directory /run/user/1000.2166sshClient # [ 37.286214] systemd[1]: Starting User Manager for UID 1000...2167sshClient # [ 37.330593] (systemd)[815]: pam_unix(systemd-user:session): session opened for user test-normal-user(uid=1000) by (uid=0)2168sshClient # [ 37.339789] systemd-logind[516]: New session '2' of user 'test-normal-user' with class 'manager' and type 'unspecified'.2169sshClient # [ 37.371619] systemd[815]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2170sshClient # [ 37.547419] systemd[815]: Queued start job for default target Main User Target.2171sshClient # [ 37.551062] systemd[815]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2172sshClient # [ 37.555543] systemd[815]: Created slice User Application Slice.2173sshClient # [ 37.557417] systemd[815]: Started Daily Cleanup of User's Temporary Directories.2174sshClient # [ 37.560565] systemd[815]: Reached target Paths.2175sshClient # [ 37.562301] systemd[815]: Reached target Timers.2176sshClient # [ 37.566110] systemd[815]: Starting D-Bus User Message Bus Socket...2177sshClient # [ 37.570763] systemd[815]: Starting Create User Files and Directories...2178sshClient # [ 37.607455] systemd[815]: Finished Create User Files and Directories.2179sshClient # [ 37.640100] systemd[815]: Listening on D-Bus User Message Bus Socket.2180sshClient # [ 37.641830] systemd[815]: Reached target Sockets.2181sshClient # [ 37.643209] systemd[815]: Reached target Basic System.2182sshClient # [ 37.647477] systemd[1]: Started User Manager for UID 1000.2183sshClient # [ 37.651113] systemd[1]: Started Session 1 of User test-normal-user.2184sshClient # [ 37.653284] systemd[815]: Starting Run user-specific NixOS activation...2185sshClient # [ 37.700072] systemd[815]: Finished Run user-specific NixOS activation.2186sshClient # [ 37.701824] systemd[815]: Reached target Main User Target.2187sshClient # [ 37.704639] systemd[815]: Startup finished in 342ms.2188sshClient: (finished: waiting for success: pgrep -u test-normal-user bash, in 1.15 seconds)2189sshClient: sending keys 'whoami > /tmp/1\n'2190sshClient: (finished: sending keys 'whoami > /tmp/1\n', in 0.16 seconds)2191sshClient: waiting for file '/tmp/1'2192sshClient: (finished: waiting for file '/tmp/1', in 1.09 seconds)2193sshClient: must succeed: cat /tmp/12194sshClient: (finished: must succeed: cat /tmp/1, in 0.03 seconds)2195(finished: subtest: login as regular user, in 3.95 seconds)2196subtest: add homed ssh authorized key2197sshClient: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n'2198sshClient: (finished: sending keys 'ssh-keygen -t ed25519 -f /tmp/id_ed25519 -N ""\n', in 0.50 seconds)2199sshClient: waiting for file '/tmp/id_ed25519.pub'2200sshClient: (finished: waiting for file '/tmp/id_ed25519.pub', in 1.10 seconds)2201sshClient: must succeed: cat /tmp/id_ed25519.pub2202sshClient: (finished: must succeed: cat /tmp/id_ed25519.pub, in 0.03 seconds)2203machine: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIE4aIKtvLv4QtzsepQWAiuLIAKbQ/S70cTwmHF4SrIOM test-normal-user@sshClient'2204machine # [ 41.264869] systemd-homed[495]: test-homed-user: changing state active → updating-while-active2205machine # [ 41.279637] systemd-homework[1097]: Offline update requested. Not touching embedded records.2206machine # [ 41.328244] systemd-homed[495]: test-homed-user: changing state updating-while-active → active2207machine: (finished: must succeed: homectl update test-homed-user --offline --ssh-authorized-keys 'ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAIE4aIKtvLv4QtzsepQWAiuLIAKbQ/S70cTwmHF4SrIOM test-normal-user@sshClient', in 0.15 seconds)2208machine: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed255192209machine: (finished: must succeed: userdbctl ssh-authorized-keys test-homed-user | grep ed25519, in 0.02 seconds)2210(finished: subtest: add homed ssh authorized key, in 1.81 seconds)2211subtest: change homed user password2212machine: sending keys 'passwd; echo $? > /tmp/3\n'2213machine: (finished: sending keys 'passwd; echo $? > /tmp/3\n', in 0.26 seconds)2214machine: waiting for New password: to appear on tty 12215machine: (finished: waiting for New password: to appear on tty 1, in 1.15 seconds)2216machine: sending keys 'barfoobar\n'2217machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2218machine: waiting for Retype new password: to appear on tty 12219machine: (finished: waiting for Retype new password: to appear on tty 1, in 1.15 seconds)2220machine: sending keys 'barfoobar\n'2221machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2222??? Warning (UserWarning): sleep(): The 'secs' argument is deprecated. Use 'duration' instead.2223 File "/nix/store/3gycnalwgpix76jjky7ljgh88gwgdb0l-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 5732224machine: must succeed: sleep 4.02225machine # [ 44.256411] systemd-homed[495]: test-homed-user: changing state active → passwd-while-active2226machine # [ 44.941929] systemd-homework[1136]: No valid password for LUKS superblock.2227machine # [ 47.274951] systemd-homed[495]: Change operation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2228machine # [ 47.284353] systemd-homed[495]: test-homed-user: changing state passwd-while-active → active2229machine: (finished: must succeed: sleep 4.0, in 4.05 seconds)2230machine: sending keys 'foobarfoo\n'2231machine: (finished: sending keys 'foobarfoo\n', in 0.10 seconds)2232machine: waiting for file '/tmp/3'2233machine # [ 48.398652] systemd-homed[495]: test-homed-user: changing state active → passwd-while-active2234machine # [ 49.642395] systemd-homework[1141]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2235machine # [ 49.768095] systemd-homework[1141]: Successfully re-activated LUKS device.2236machine # [ 49.811539] systemd-homework[1141]: Provided password unlocks user record.2237machine # [ 49.813870] systemd-homework[1141]: Discovered used loopback device /dev/loop1.2238machine # [ 49.815843] systemd-homework[1141]: Read embedded .identity file.2239machine # [ 49.856972] systemd-homework[1141]: Provided password unlocks user record.2240machine # [ 49.859839] systemd-homework[1141]: Reconciling header user identity completed (host version was newer).2241machine # [ 49.862120] systemd-homework[1141]: Reconciling embedded user identity completed (host version was newer).2242machine # [ 53.272921] systemd-homework[1141]: Added LUKS key slot 1.2243machine # [ 53.300124] systemd-homework[1141]: Destroyed LUKS key slot 0.2244machine # [ 53.311927] systemd-homework[1141]: Wrote LUKS header user record.2245machine # [ 53.313953] systemd-homework[1141]: Wrote embedded .identity file.2246machine # [ 53.315915] systemd-homework[1141]: Replaced embedded blob dir with contents of system blob dir.2247machine # [ 53.323624] systemd-homework[1141]: Synchronized disk.2248machine # [ 53.329165] systemd-homework[1141]: Everything completed.2249machine # [ 53.340373] systemd-homed[495]: test-homed-user: changing state passwd-while-active → active2250machine # [ 53.343668] passwd[1110]: pam_systemd_home(passwd:chauthtok): Successfully changed password for user test-homed-user.2251machine: (finished: waiting for file '/tmp/3', in 5.22 seconds)2252machine: must succeed: cat /tmp/32253machine: (finished: must succeed: cat /tmp/3, in 0.03 seconds)2254(finished: subtest: change homed user password, in 12.18 seconds)2255subtest: escalate to root from homed user2256machine: sending keys 'sudo id | tee /tmp/4\n'2257machine: (finished: sending keys 'sudo id | tee /tmp/4\n', in 0.22 seconds)2258machine: waiting for password for test-homed-user to appear on tty 12259machine # [ 54.090413] systemd-homed[495]: test-homed-user: changing state active → authenticating-for-acquire2260machine # [ 54.097876] systemd-homework[1177]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2261machine # [ 54.109903] systemd-homed[495]: Authentication failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2262machine # [ 54.113904] systemd-homed[495]: test-homed-user: changing state authenticating-for-acquire → active2263machine: (finished: waiting for password for test-homed-user to appear on tty 1, in 1.09 seconds)2264machine: sending keys 'barfoobar\n'2265machine: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2266machine: waiting for file '/tmp/4'2267machine: (finished: waiting for file '/tmp/4', in 0.02 seconds)2268machine: waiting for success: grep uid=0 /tmp/42269machine # [ 55.033870] systemd-homed[495]: test-homed-user: changing state active → authenticating-for-acquire2270machine # [ 55.064225] systemd-homework[1193]: Provided password unlocks user record.2271machine # [ 55.738337] systemd-homework[1193]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2272machine # [ 55.861797] systemd-homework[1193]: Successfully re-activated LUKS device.2273machine # [ 55.886323] systemd-homework[1193]: Provided password unlocks user record.2274machine # [ 55.889245] systemd-homework[1193]: Discovered used loopback device /dev/loop1.2275machine # [ 55.891718] systemd-homework[1193]: Read embedded .identity file.2276machine # [ 55.913544] systemd-homework[1193]: Provided password unlocks user record.2277machine # [ 55.916157] systemd-homework[1193]: Reconciling user identities completed (host and header version were identical).2278machine # [ 55.918877] systemd-homework[1193]: Reconciling embedded user identity completed (host and embedded version were identical).2279machine # [ 55.929129] systemd-homework[1193]: Everything completed.2280machine # [ 55.934407] systemd-homed[495]: Home test-homed-user is signed exclusively by our key, accepting.2281machine # [ 55.942261] systemd-homed[495]: test-homed-user: changing state authenticating-for-acquire → active2282machine # [ 55.945278] sudo[1175]: pam_systemd_home(sudo:auth): Home for user test-homed-user successfully acquired.2283machine # [ 55.954647] sudo[1175]: test-homed-user : TTY=tty1 ; PWD=/home/test-homed-user ; USER=root ; COMMAND=/run/current-system/sw/bin/id2284machine # [ 55.978538] sudo[1175]: pam_unix(sudo:session): session opened for user root(uid=0) by test-homed-user(uid=60388)2285machine # [ 55.993542] sudo[1175]: pam_unix(sudo:session): session closed for user root2286machine: (finished: waiting for success: grep uid=0 /tmp/4, in 1.06 seconds)2287(finished: subtest: escalate to root from homed user, in 2.50 seconds)2288subtest: log out and deactivate homed user's home area2289machine: sending keys 'exit\n'2290machine: (finished: sending keys 'exit\n', in 0.05 seconds)2291machine: waiting for success: homectl inspect test-homed-user | grep 'State: inactive'2292machine # [ 56.117485] login[957]: pam_unix(login:session): session closed for user test-homed-user2293machine # [ 56.122616] login[957]: pam_systemd_home(login:session): Not deactivating home directory of test-homed-user, as it is still used.2294machine # [ 56.131842] systemd[1]: getty@tty1.service: Deactivated successfully.2295machine # [ 56.139749] systemd[1]: session-1.scope: Deactivated successfully.2296machine # [ 56.144908] systemd-logind[545]: Session 1 logged out. Waiting for processes to exit.2297machine # [ 56.147979] systemd[1]: getty@tty1.service: Scheduled restart job, restart counter is at 1.2298machine # [ 56.154608] systemd-logind[545]: Removed session 1.2299machine # [ 56.159290] systemd[1]: Started Getty on tty1.2300machine # [ 66.340887] systemd[1]: Stopping User Manager for UID 60388...2301machine # [ 66.354194] systemd[1043]: Activating special unit Exit the Session...2302machine # [ 66.356539] systemd[1043]: Stopped target Main User Target.2303machine # [ 66.359476] systemd[1043]: Stopped Run user-specific NixOS activation.2304machine # [ 66.361231] systemd[1043]: Stopped target Basic System.2305machine # [ 66.363416] systemd[1043]: Stopped target Paths.2306machine # [ 66.365625] systemd[1043]: Stopped target Sockets.2307machine # [ 66.368848] systemd[1043]: Stopped target Timers.2308machine # [ 66.371407] systemd[1043]: Stopped Daily Cleanup of User's Temporary Directories.2309machine # [ 66.374391] systemd[1043]: Closed D-Bus User Message Bus Socket.2310machine # [ 66.376516] systemd[1043]: Stopped Create User Files and Directories.2311machine # [ 66.379432] systemd[1043]: Removed slice User Application Slice.2312machine # [ 66.381684] systemd[1043]: Reached target Shutdown.2313machine # [ 66.383274] systemd[1043]: Finished Exit the Session.2314machine # [ 66.384884] systemd[1043]: Reached target Exit the Session.2315machine # [ 66.390766] systemd-homed[495]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2316machine # [ 66.396323] systemd-homed[495]: test-homed-user: changing state active → deactivating2317machine # [ 66.399960] systemd-logind[545]: Removed session 2.2318machine # [ 66.404181] systemd[1]: user@60388.service: Deactivated successfully.2319machine # [ 66.405946] systemd[1]: Stopped User Manager for UID 60388.2320machine # [ 66.409715] systemd-homework[1272]: Successfully acquired home volume key from kernel keyring.2321machine # [ 66.414517] systemd-homework[1272]: Discarded unused 674.3M.2322machine # [ 66.422413] systemd-homework[1272]: Syncing completed.2323machine # [ 66.428260] systemd[1]: home-test\x2dhomed\x2duser.mount: Deactivated successfully.2324machine # [ 66.438257] systemd[1]: Stopping User Runtime Directory /run/user/60388...2325machine # [ 66.487126] systemd[1]: run-user-60388.mount: Deactivated successfully.2326machine # [ 66.491207] systemd[1]: user-runtime-dir@60388.service: Deactivated successfully.2327machine # [ 66.497359] systemd[1]: Stopped User Runtime Directory /run/user/60388.2328machine # [ 66.507900] systemd-homework[1272]: Discovered used LUKS device /dev/mapper/home-test-homed-user, and validated password.2329machine # [ 66.633268] systemd-homework[1272]: Successfully re-activated LUKS device.2330machine # [ 66.635150] systemd-homework[1272]: Discovered used loopback device /dev/loop1.2331machine # [ 66.637431] systemd-homework[1272]: offset = 1048576, size = 800063488, image = 8021606402332machine # [ 66.649287] systemd-homework[1272]: Ready to resize image size 765M → 274M, partition size 763M → 272M, file system size 747M → 256M.2333machine # [ 66.652333] systemd-homework[1272]: Allocated additional 674.3M.2334machine # [ 66.917144] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 783286272 to 2684354562335machine # [ 66.660299] systemd-homework[1272]: File system resizing from 747M to 256M completed.2336machine # [ 66.663060] systemd-homework[1272]: Synchronized disk.2337machine # [ 66.854906] systemd-homework[1272]: LUKS device shrinking completed.2338machine # [ 67.118275] loop1: detected capacity change from 1562624 to 5570562339machine # [ 66.863373] systemd-homework[1272]: Refreshing loop device size completed.2340machine # [ 66.865152] systemd-homework[1272]: Shrinking of image file completed.2341machine # [ 66.881374] systemd-homework[1272]: Shrinking of partition completed.2342machine # [ 66.883127] systemd-homework[1272]: Synchronized disk.2343machine # [ 66.884584] systemd-homework[1272]: Resizing completed.2344machine # [ 67.144950] BTRFS info (device dm-0): last unmount of filesystem ca12da34-6e79-46db-99ab-eb1fe87922ce2345machine # [ 66.887881] systemd-homework[1272]: Image size is 274M, file system size is 256M, file system payload size is 256M, file system free is 249.9M.2346machine # [ 66.893305] systemd-homework[1272]: Unmounting completed.2347machine # [ 66.895984] systemd-homework[1272]: Discovered used LUKS device /dev/mapper/home-test-homed-user.2348machine # [ 66.898986] systemd-homework[1272]: Device home-test-homed-user is not active.2349machine # [ 66.909364] systemd-homed[495]: block device /sys/devices/virtual/block/dm-0 has been removed.2350machine # [ 66.914140] systemd-homework[1272]: Everything completed.2351machine # [ 66.921488] systemd-homed[495]: test-homed-user: changing state deactivating → inactive2352machine: (finished: waiting for success: homectl inspect test-homed-user | grep 'State: inactive', in 11.74 seconds)2353(finished: subtest: log out and deactivate homed user's home area, in 11.79 seconds)2354subtest: ssh as homed user2355sshClient: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n'2356sshClient: (finished: sending keys 'ssh -o StrictHostKeyChecking=no -i /tmp/id_ed25519 test-homed-user@machine\n', in 0.78 seconds)2357sshClient: waiting for Please enter password for user to appear on tty 12358machine # [ 69.708693] systemd-homed[495]: test-homed-user: changing state inactive → activating-for-acquire2359machine # [ 69.715135] systemd-homework[1307]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2360machine # [ 69.721956] systemd-homed[495]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2361machine # [ 69.725407] systemd-homed[495]: test-homed-user: changing state activating-for-acquire → inactive2362machine # [ 69.728222] systemd-homed[495]: Got notification that all sessions of user test-homed-user ended, deactivating automatically.2363machine # [ 69.731473] sshd-session[1303]: pam_systemd_home(sshd:account): Conversation function failed: Conversation error2364machine # [ 69.735262] systemd-homed[495]: Home test-homed-user already deactivated, no automatic deactivation needed.2365machine # [ 69.737606] sshd-session[1303]: pam_systemd_home(sshd:account): Home for user test-homed-user acquired in incomplete mode, requires later activation.2366machine # [ 69.741092] sshd-session[1303]: Accepted publickey for test-homed-user from 2001:db8:1::2 port 33940 ssh2: ED25519 SHA256:QdOP5m3MS7vTEgg5QGSH+SfhayhuMRwOmOKV8HjXeZ42367machine # [ 69.809123] sshd-session[1303]: pam_unix(sshd:session): session opened for user test-homed-user(uid=60388) by (uid=0)2368machine # [ 69.829465] systemd-logind[545]: New session '3' of user 'test-homed-user' with class 'user-incomplete' and type 'tty'.2369machine # [ 69.835850] systemd[1]: Starting User Runtime Directory /run/user/60388...2370machine # [ 69.875579] systemd[1]: Finished User Runtime Directory /run/user/60388.2371machine # [ 69.883864] systemd[1]: Started Session 3 of User test-homed-user.2372machine # [ 69.912359] sshd-session[1303]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2373machine # [ 69.917930] sshd-session[1303]: lastlog_openseek: Couldn't stat /var/log/lastlog: No such file or directory2374machine # [ 69.939427] systemd-homed[495]: test-homed-user: changing state inactive → activating2375machine # [ 69.945686] systemd-homework[1312]: None of the supplied plaintext passwords unlock the user record's hashed passwords.2376machine # [ 69.953412] systemd-homed[495]: Activation failed: Password for home test-homed-user is incorrect or not sufficient for authentication.2377machine # [ 69.956774] systemd-homed[495]: test-homed-user: changing state activating → inactive2378sshClient: (finished: waiting for Please enter password for user to appear on tty 1, in 2.20 seconds)2379sshClient: sending keys 'barfoobar\n'2380sshClient: (finished: sending keys 'barfoobar\n', in 0.10 seconds)2381machine: waiting for success: pgrep -u test-homed-user bash2382machine # [ 70.998422] systemd-homed[495]: test-homed-user: changing state inactive → activating2383machine # [ 71.031164] systemd-homework[1317]: Provided password unlocks user record.2384machine # [ 71.041882] systemd-homework[1317]: Successfully locked image file '/home/test-homed-user.home'.2385machine # [ 71.049748] systemd-homework[1317]: Backing file is fully allocated already.2386machine # [ 71.312189] loop1: detected capacity change from 0 to 5570562387machine # [ 71.054521] systemd-homework[1317]: Setting up loopback device /dev/loop1 completed.2388machine # [ 72.111538] systemd-homework[1317]: Setting up LUKS device /dev/mapper/home-test-homed-user completed.2389machine # [ 72.141812] systemd-homework[1317]: Provided password unlocks user record.2390machine # [ 72.148553] systemd-homework[1317]: Probing file system completed (found btrfs).2391machine # [ 72.150919] systemd-homework[1317]: No fsck for file system btrfs installed, ignoring.2392machine # [ 72.413991] BTRFS: device label test-homed-user devid 1 transid 17 /dev/mapper/home-test-homed-user (254:0) scanned by systemd-homewor (1317)2393machine # [ 72.417409] BTRFS info (device dm-0): first mount of filesystem ca12da34-6e79-46db-99ab-eb1fe87922ce2394machine # [ 72.420164] BTRFS info (device dm-0): using crc32c (crc32c-lib) checksum algorithm2395machine # [ 72.424977] BTRFS info (device dm-0): enabling free space tree2396machine # [ 72.426174] BTRFS info (device dm-0): use zstd compression, level 12397machine # [ 72.169158] systemd-homework[1317]: Mounting file system completed.2398machine # [ 72.171937] systemd-homework[1317]: Discovered used loopback device /dev/loop1.2399machine # [ 72.173838] systemd-homework[1317]: offset = 1048576, size = 285212672, image = 2873098242400machine # [ 72.186775] systemd-homework[1317]: Ready to resize image size 274M → 765M, partition size 272M → 763M, file system size 256M → 747M.2401machine # [ 72.190498] systemd-homework[1317]: Growing of image file from 274M to 765M completed.2402machine # [ 72.454082] loop1: detected capacity change from 557056 to 15626242403machine # [ 72.199631] systemd-homework[1317]: Refreshing loop device size completed.2404machine # [ 72.212991] systemd-homework[1317]: Growing of partition completed.2405machine # [ 72.257699] systemd-homework[1317]: LUKS device growing completed.2406machine # [ 72.522945] BTRFS info (device dm-0): resize device /dev/mapper/home-test-homed-user (devid 1) from 268435456 to 7832862722407machine # [ 72.266662] systemd-homework[1317]: File system resizing from 256M to 747M completed.2408machine # [ 72.270107] systemd-homework[1317]: Synchronized disk.2409machine # [ 72.271579] systemd-homework[1317]: Synchronized disk.2410machine # [ 72.272981] systemd-homework[1317]: Resizing completed.2411machine # [ 72.274719] systemd-homework[1317]: Image size is 765M, file system size is 747M, file system payload size is 747M, file system free is 740.9M.2412machine # [ 72.278225] systemd-homework[1317]: Read embedded .identity file.2413machine # [ 72.300560] systemd-homework[1317]: Provided password unlocks user record.2414machine # [ 72.303225] systemd-homework[1317]: Reconciling user identities completed (host and header version were identical).2415machine # [ 72.305810] systemd-homework[1317]: Reconciling embedded user identity completed (host and embedded version were identical).2416machine # [ 72.308838] systemd-homework[1317]: Recursive changing of ownership not necessary, skipped.2417machine # [ 72.312461] systemd-homework[1317]: Synchronized disk.2418machine # [ 72.314456] systemd-homework[1317]: Moving to final mount point /home/test-homed-user completed.2419machine # [ 72.341074] systemd-homework[1317]: Activation completed.2420machine # [ 72.342799] systemd-homework[1317]: Image size is 763M, file system size is 747M, file system payload size is 747M, file system free is 740.9M.2421machine # [ 72.353844] systemd-homed[495]: Home test-homed-user is signed exclusively by our key, accepting.2422machine # [ 72.362513] systemd-homed[495]: test-homed-user: changing state activating → active2423machine # [ 72.379522] systemd[1]: Starting User Manager for UID 60388...2424machine # [ 72.419455] (systemd)[1358]: pam_systemd_home(systemd-user:account): Home for user test-homed-user successfully acquired.2425machine # [ 72.495938] (systemd)[1358]: pam_unix(systemd-user:session): session opened for user test-homed-user(uid=60388) by (uid=0)2426machine # [ 72.506871] systemd-logind[545]: New session '4' of user 'test-homed-user' with class 'manager' and type 'unspecified'.2427machine # [ 72.541695] systemd[1358]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2428machine # [ 72.726326] systemd[1358]: Queued start job for default target Main User Target.2429machine # [ 72.730487] systemd[1358]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2430machine # [ 72.735424] systemd[1358]: Created slice User Application Slice.2431machine # [ 72.738858] systemd[1358]: Started Daily Cleanup of User's Temporary Directories.2432machine # [ 72.740754] systemd[1358]: Reached target Paths.2433machine # [ 72.742468] systemd[1358]: Reached target Timers.2434machine # [ 72.746161] systemd[1358]: Starting D-Bus User Message Bus Socket...2435machine # [ 72.751060] systemd[1358]: Starting Create User Files and Directories...2436machine # [ 72.796273] systemd[1358]: Finished Create User Files and Directories.2437machine # [ 72.799406] systemd[1358]: Listening on D-Bus User Message Bus Socket.2438machine # [ 72.802475] systemd[1358]: Reached target Sockets.2439machine # [ 72.804074] systemd[1358]: Reached target Basic System.2440machine # [ 72.807621] systemd[1]: Started User Manager for UID 60388.2441machine # [ 72.812493] systemd[1358]: Starting Run user-specific NixOS activation...2442machine # [ 72.867549] systemd[1358]: Finished Run user-specific NixOS activation.2443machine # [ 72.869962] systemd[1358]: Reached target Main User Target.2444machine # [ 72.872802] systemd[1358]: Startup finished in 342ms.2445machine: (finished: waiting for success: pgrep -u test-homed-user bash, in 2.25 seconds)2446sshClient: sending keys 'whoami > /tmp/5\n'2447sshClient: (finished: sending keys 'whoami > /tmp/5\n', in 0.17 seconds)2448machine: waiting for file '/tmp/5'2449machine: (finished: waiting for file '/tmp/5', in 1.10 seconds)2450machine: must succeed: cat /tmp/52451machine: (finished: must succeed: cat /tmp/5, in 0.05 seconds)2452sshClient: sending keys 'exit\n'2453sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2454sshClient: sending keys 'exit\n'2455sshClient: (finished: sending keys 'exit\n', in 0.05 seconds)2456(finished: subtest: ssh as homed user, in 6.75 seconds)2457(finished: run the VM test script, in 75.82 seconds)2458machine # [ 74.575984] sshd-session[1310]: Received disconnect from 2001:db8:1::2 port 33940:11: disconnected by user2459machine # [ 74.594963] sshd-session[1310]: Disconnected from user test-homed-user 2001:db8:1::2 port 339402460machine # [ 74.610557] sshd-session[1303]: pam_unix(sshd:session): session closed for user test-homed-user2461machine # [ 74.615526] sshd-session[1303]: pam_systemd_home(sshd:session): Not deactivating home directory of test-homed-user, as it is still used.2462machine # [ 74.625247] systemd[1]: session-3.scope: Deactivated successfully.2463machine # [ 74.632371] systemd-logind[545]: Session 3 logged out. Waiting for processes to exit.2464machine # [ 74.636109] systemd-logind[545]: Removed session 3.2465test script finished in 76.00s2466cleanup2467kill QemuMachine (pid 48)2468machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2469kill QemuMachine (pid 47)2470sshClient # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2471(finished: cleanup, in 0.35 seconds)2472additionally exposed symbols:2473 machine, sshClient,2474 vlan1,2475 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