vm-test-run-harmonia
checks.x86_64-linux.harmonia
· build #1
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.01 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 alice, bob,8 vlan1,9 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_ssh10start all VMs11alice: starting vm12bob: starting vm13alice # Disk image does not exist, creating the virtualisation disk image...14alice # Formatting '/build/vm-state-alice/tmp.VDiF4tBCWi', fmt=raw size=107374182415alice # mke2fs 1.47.4 (6-Mar-2025)16alice # Discarding device blocks: 0/262144 done17alice # Creating filesystem with 262144 4k blocks and 65536 inodes18alice # Filesystem UUID: ed25da61-ba25-43d7-aea6-89ad3e92824c19alice # Superblock backups stored on blocks:20alice # 32768, 98304, 163840, 22937621alice # 22alice # Allocating group tables: 0/8 done23alice # Writing inode tables: 0/8 done24alice # Creating journal (8192 blocks): done25alice # Writing superblocks and filesystem accounting information: 0/8 done26alice # 27alice # Virtualisation disk image created.28alice # qemu-system-x86_64: Could not access KVM kernel module: No such file or directory29alice # qemu-system-x86_64: failed to initialize kvm: No such file or directory30alice # qemu-system-x86_64: falling back to tcg31alice: QEMU running (pid 46)32bob # Disk image does not exist, creating the virtualisation disk image...33bob # Formatting '/build/vm-state-bob/tmp.aHNqbWO8Xr', fmt=raw size=107374182434bob # mke2fs 1.47.4 (6-Mar-2025)35bob # Discarding device blocks: 0/262144 done36bob # Creating filesystem with 262144 4k blocks and 65536 inodes37bob # Filesystem UUID: 021fd8e5-add2-4c91-8acf-dff17a382e3f38bob # Superblock backups stored on blocks:39bob # 32768, 98304, 163840, 22937640bob # 41bob # Allocating group tables: 0/8 done42bob # Writing inode tables: 0/8 done43bob # Creating journal (8192 blocks): done44bob # Writing superblocks and filesystem accounting information: 0/8 done45bob # 46bob # Virtualisation disk image created.47bob # qemu-system-x86_64: Could not access KVM kernel module: No such file or directory48bob # qemu-system-x86_64: failed to initialize kvm: No such file or directory49bob # qemu-system-x86_64: falling back to tcg50bob: QEMU running (pid 48)51(finished: start all VMs, in 0.88 seconds)52bob: waiting for success: curl bob:5000/nix-cache-info53bob: waiting for the VM to finish booting54bob # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)55alice # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)56bob # 57bob # 58alice # 59bob # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC750+3EF2C750 CA0060alice # 61alice # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFD15F0+3EF315F0 CA0062bob # Press Ctrl-B to configure iPXE (PCI 00:02.0)...63bob # 64bob # 65bob # 66bob # 67alice # Press Ctrl-B to configure iPXE (PCI 00:02.0)...68alice # 69alice # 70alice # 71alice # 72bob # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC750 3EF2C750 CB0073alice # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFD15F0 3EF315F0 CB0074alice # Press Ctrl-B to configure iPXE (PCI 00:08.0)...75alice # 76alice # 77bob # Press Ctrl-B to configure iPXE (PCI 00:08.0)...78bob # 79bob # 80alice # Booting from ROM...81bob # Booting from ROM...82alice # Probing EDD (edd=off to disable)... ok83alice # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 202684alice # [ 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/s07la4r24v006hj7wxyzffb5ksqhavky-nixos-system-alice-test/init regInfo=/nix/store/qi8bh9i4y0a9i5k8p0323mqszbn9yvj5-closure-info/registration console=ttyS0,115200n8 console=tty085alice # [ 0.000000] BIOS-provided physical RAM map:86alice # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable87alice # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved88alice # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved89alice # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable90alice # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved91alice # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved92alice # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved93alice # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved94alice # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved95alice # [ 0.000000] NX (Execute Disable) protection: active96alice # [ 0.000000] APIC: Static calls initialized97alice # [ 0.000000] SMBIOS 2.8 present.98alice # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201499alice # [ 0.000000] DMI: Memory slots populated: 1/1100alice # [ 0.000000] tsc: Fast TSC calibration using PIT101alice # [ 0.000000] tsc: Detected 3593.248 MHz processor102alice # [ 0.018140] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000103alice # [ 0.018971] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs104alice # [ 0.019180] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT105alice # [ 0.047753] found SMP MP-table at [mem 0x000f5450-0x000f545f]106alice # [ 0.050365] Using GB pages for direct mapping107alice # [ 0.055356] RAMDISK: [mem 0x3e36a000-0x3ffcffff]108alice # [ 0.055964] ACPI: Early table checksum verification disabled109alice # [ 0.056526] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )110alice # [ 0.056918] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)111alice # [ 0.057834] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)112alice # [ 0.058634] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)113alice # [ 0.058731] ACPI: FACS 0x000000003FFE0000 000040114alice # [ 0.058801] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)115alice # [ 0.058835] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)116alice # [ 0.058865] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)117alice # [ 0.058895] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)118alice # [ 0.059019] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]119alice # [ 0.059058] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]120alice # [ 0.059069] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]121alice # [ 0.059078] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]122alice # [ 0.059086] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]123alice # [ 0.059094] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]124alice # [ 0.059109] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]125alice # [ 0.065532] No NUMA configuration found126alice # [ 0.065603] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]127alice # [ 0.066418] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]128alice # [ 0.071657] Zone ranges:129alice # [ 0.071724] DMA [mem 0x0000000000001000-0x0000000000ffffff]130alice # [ 0.071826] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]131alice # [ 0.071840] Normal empty132alice # [ 0.071859] Device empty133alice # [ 0.071874] Movable zone start for each node134alice # [ 0.071909] Early memory node ranges135alice # [ 0.071977] node 0: [mem 0x0000000000001000-0x000000000009efff]136alice # [ 0.072194] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]137alice # [ 0.072356] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]138alice # [ 0.073728] On node 0, zone DMA: 1 pages in unavailable ranges139alice # [ 0.074221] On node 0, zone DMA: 97 pages in unavailable ranges140alice # [ 0.091346] On node 0, zone DMA32: 40 pages in unavailable ranges141alice # [ 0.092266] ACPI: PM-Timer IO Port: 0x608142alice # [ 0.092927] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])143alice # [ 0.093536] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23144alice # [ 0.093706] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)145alice # [ 0.094033] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)146alice # [ 0.094114] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)147alice # [ 0.094242] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)148alice # [ 0.094256] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)149alice # [ 0.094484] ACPI: Using ACPI (MADT) for SMP configuration information150alice # [ 0.094542] ACPI: HPET id: 0x8086a201 base: 0xfed00000151alice # [ 0.095064] CPU topo: Max. logical packages: 1152alice # [ 0.095081] CPU topo: Max. logical dies: 1153alice # [ 0.095093] CPU topo: Max. dies per package: 1154alice # [ 0.095169] CPU topo: Max. threads per core: 1155alice # [ 0.095360] CPU topo: Num. cores per package: 1156alice # [ 0.095381] CPU topo: Num. threads per package: 1157alice # [ 0.095393] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs158alice # [ 0.096454] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]159alice # [ 0.096491] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]160alice # [ 0.096620] [mem 0x40000000-0xafffffff] available for PCI devices161alice # [ 0.096687] Booting paravirtualized kernel on bare hardware162alice # [ 0.097314] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns163alice # [ 0.113287] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1164alice # [ 0.116842] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152165alice # [ 0.118536] 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/s07la4r24v006hj7wxyzffb5ksqhavky-nixos-system-alice-test/init regInfo=/nix/store/qi8bh9i4y0a9i5k8p0323mqszbn9yvj5-closure-info/registration console=ttyS0,115200n8 console=tty0166alice # [ 0.120903] Unknown kernel command line parameters "regInfo=/nix/store/qi8bh9i4y0a9i5k8p0323mqszbn9yvj5-closure-info/registration", will be passed to user space.167alice # [ 0.121738] random: crng init done168alice # [ 0.121841] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes169alice # [ 0.122930] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)170alice # [ 0.123167] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)171alice # [ 0.127554] Fallback order for Node 0: 0172alice # [ 0.128005] Built 1 zonelists, mobility grouping on. Total pages: 262006173alice # [ 0.128052] Policy zone: DMA32174alice # [ 0.131264] mem auto-init: stack:all(zero), heap alloc:on, heap free:off175alice # [ 0.172534] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1176alice # [ 0.177201] allocated 2097152 bytes of page_ext177alice # [ 0.234081] ftrace: allocating 48733 entries in 192 pages178alice # [ 0.234380] ftrace: allocated 192 pages with 2 groups179alice # [ 0.246855] Dynamic Preempt: lazy180alice # [ 0.251821] rcu: Preemptible hierarchical RCU implementation.181alice # [ 0.251856] rcu: RCU event tracing is enabled.182alice # [ 0.251884] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.183alice # [ 0.252046] Trampoline variant of Tasks RCU enabled.184alice # [ 0.252057] Rude variant of Tasks RCU enabled.185alice # [ 0.252065] Tracing variant of Tasks RCU enabled.186alice # [ 0.252212] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.187alice # [ 0.252249] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1188alice # [ 0.254166] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.189alice # [ 0.254226] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.190alice # [ 0.254239] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.191alice # [ 0.312260] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16192alice # [ 0.326996] rcu: srcu_init: Setting srcu_struct sizes based on contention.193alice # [ 0.327865] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns194alice # [ 0.332558] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)195alice # [ 0.339173] Console: colour VGA+ 80x25196alice # [ 0.339734] printk: legacy console [tty0] enabled197alice # [ 0.350770] printk: legacy console [ttyS0] enabled198alice # [ 0.372735] ACPI: Core revision 20250807199alice # [ 0.386233] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns200alice # [ 0.392627] APIC: Switch to symmetric I/O mode setup201alice # [ 0.394240] x2apic: IRQ remapping doesn't support X2APIC mode202alice # [ 0.400549] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1203alice # [ 0.406345] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x33cb68e6ea4, max_idle_ns: 440795288133 ns204alice # [ 0.407571] Calibrating delay loop (skipped), value calculated using timer frequency.. 7186.49 BogoMIPS (lpj=3593248)205alice # [ 0.414341] x86/cpu: User Mode Instruction Prevention (UMIP) activated206alice # [ 0.429981] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0207alice # [ 0.430417] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0208alice # [ 0.433092] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto209alice # [ 0.434453] Speculative Store Bypass: Vulnerable210alice # [ 0.435291] Spectre V2 : Mitigation: Retpolines211alice # [ 0.435752] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization212alice # [ 0.436323] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT213bob # Probing EDD (edd=off to disable)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 2026214bob # [ 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/3l8qw1fkj6k2snnfdwq4s94r5qyl6amz-nixos-system-bob-test/init regInfo=/nix/store/y12p41z2d4s3pjggxm1c427hmz80ijxy-closure-info/registration console=ttyS0,115200n8 console=tty0215bob # [ 0.000000] BIOS-provided physical RAM map:216bob # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable217bob # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved218bob # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved219bob # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable220bob # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved221bob # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved222bob # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved223bob # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved224bob # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved225bob # [ 0.000000] NX (Execute Disable) protection: active226bob # [ 0.000000] APIC: Static calls initialized227bob # [ 0.000000] SMBIOS 2.8 present.228bob # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014229bob # [ 0.000000] DMI: Memory slots populated: 1/1230bob # [ 0.000000] tsc: Fast TSC calibration using PIT231bob # [ 0.000000] tsc: Detected 3593.300 MHz processor232bob # [ 0.018088] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000233bob # [ 0.018960] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs234bob # [ 0.019166] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT235bob # [ 0.050645] found SMP MP-table at [mem 0x000f5450-0x000f545f]236bob # [ 0.053303] Using GB pages for direct mapping237bob # [ 0.058016] RAMDISK: [mem 0x3e369000-0x3ffcffff]238bob # [ 0.058639] ACPI: Early table checksum verification disabled239bob # [ 0.059188] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )240bob # [ 0.059576] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)241bob # [ 0.060462] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)242bob # [ 0.061242] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)243bob # [ 0.061340] ACPI: FACS 0x000000003FFE0000 000040244bob # [ 0.061409] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)245bob # [ 0.061442] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)246bob # [ 0.061472] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)247bob # [ 0.061509] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)248bob # [ 0.061629] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]249bob # [ 0.061668] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]250bob # [ 0.061678] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]251bob # [ 0.061686] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]252bob # [ 0.061694] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]253bob # [ 0.061702] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]254bob # [ 0.061710] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]255bob # [ 0.068204] No NUMA configuration found256bob # [ 0.068255] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]257bob # [ 0.069021] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]258bob # [ 0.073976] Zone ranges:259bob # [ 0.074029] DMA [mem 0x0000000000001000-0x0000000000ffffff]260bob # [ 0.074132] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]261bob # [ 0.074146] Normal empty262bob # [ 0.074165] Device empty263bob # [ 0.074179] Movable zone start for each node264bob # [ 0.074214] Early memory node ranges265bob # [ 0.074265] node 0: [mem 0x0000000000001000-0x000000000009efff]266bob # [ 0.074461] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]267bob # [ 0.074634] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]268bob # [ 0.075920] On node 0, zone DMA: 1 pages in unavailable ranges269bob # [ 0.076330] On node 0, zone DMA: 97 pages in unavailable ranges270bob # [ 0.091845] On node 0, zone DMA32: 40 pages in unavailable ranges271bob # [ 0.092679] ACPI: PM-Timer IO Port: 0x608272bob # [ 0.093288] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])273bob # [ 0.093806] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23274bob # [ 0.093960] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)275bob # [ 0.094280] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)276bob # [ 0.094348] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)277bob # [ 0.094464] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)278bob # [ 0.094481] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)279bob # [ 0.094707] ACPI: Using ACPI (MADT) for SMP configuration information280bob # [ 0.094764] ACPI: HPET id: 0x8086a201 base: 0xfed00000281bob # [ 0.095252] CPU topo: Max. logical packages: 1282bob # [ 0.095268] CPU topo: Max. logical dies: 1283bob # [ 0.095280] CPU topo: Max. dies per package: 1284bob # [ 0.095347] CPU topo: Max. threads per core: 1285bob # [ 0.095539] CPU topo: Num. cores per package: 1286bob # [ 0.095560] CPU topo: Num. threads per package: 1287bob # [ 0.095571] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs288alice # [ 0.444526] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'289bob # [ 0.096601] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]290bob # [ 0.096638] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]291bob # [ 0.096766] [mem 0x40000000-0xafffffff] available for PCI devices292bob # [ 0.096834] Booting paravirtualized kernel on bare hardware293bob # [ 0.097445] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns294alice # [ 0.448337] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'295bob # [ 0.113294] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1296alice # [ 0.448622] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'297bob # [ 0.116908] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152298alice # [ 0.449106] x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'299alice # [ 0.449343] x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR'300bob # [ 0.118605] 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/3l8qw1fkj6k2snnfdwq4s94r5qyl6amz-nixos-system-bob-test/init regInfo=/nix/store/y12p41z2d4s3pjggxm1c427hmz80ijxy-closure-info/registration console=ttyS0,115200n8 console=tty0301alice # [ 0.449633] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'302bob # [ 0.120956] Unknown kernel command line parameters "regInfo=/nix/store/y12p41z2d4s3pjggxm1c427hmz80ijxy-closure-info/registration", will be passed to user space.303bob # [ 0.121776] random: crng init done304alice # [ 0.450122] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256305bob # [ 0.121877] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes306bob # [ 0.123079] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)307alice # [ 0.450469] x86/fpu: xstate_offset[3]: 960, xstate_sizes[3]: 64308bob # [ 0.123302] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)309bob # [ 0.127229] Fallback order for Node 0: 0310bob # [ 0.127603] Built 1 zonelists, mobility grouping on. Total pages: 262006311bob # [ 0.127627] Policy zone: DMA32312bob # [ 0.130598] mem auto-init: stack:all(zero), heap alloc:on, heap free:off313bob # [ 0.162802] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1314alice # [ 0.450680] x86/fpu: xstate_offset[4]: 1024, xstate_sizes[4]: 64315bob # [ 0.167339] allocated 2097152 bytes of page_ext316bob # [ 0.223566] ftrace: allocating 48733 entries in 192 pages317alice # [ 0.451100] x86/fpu: xstate_offset[9]: 2688, xstate_sizes[9]: 8318bob # [ 0.223844] ftrace: allocated 192 pages with 2 groups319bob # [ 0.235844] Dynamic Preempt: lazy320bob # [ 0.241095] rcu: Preemptible hierarchical RCU implementation.321bob # [ 0.241123] rcu: RCU event tracing is enabled.322alice # [ 0.451376] x86/fpu: Enabled xstate features 0x21f, context size is 2696 bytes, using 'standard' format.323bob # [ 0.241150] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.324bob # [ 0.241306] Trampoline variant of Tasks RCU enabled.325bob # [ 0.241316] Rude variant of Tasks RCU enabled.326bob # [ 0.241324] Tracing variant of Tasks RCU enabled.327bob # [ 0.241452] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.328bob # [ 0.241495] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1329bob # [ 0.243120] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.330bob # [ 0.243148] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.331bob # [ 0.243160] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.332bob # [ 0.302934] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16333bob # [ 0.317014] rcu: srcu_init: Setting srcu_struct sizes based on contention.334bob # [ 0.318031] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns335bob # [ 0.322924] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)336bob # [ 0.330520] Console: colour VGA+ 80x25337bob # [ 0.331173] printk: legacy console [tty0] enabled338bob # [ 0.342099] printk: legacy console [ttyS0] enabled339bob # [ 0.362792] ACPI: Core revision 20250807340bob # [ 0.371460] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns341bob # [ 0.378064] APIC: Switch to symmetric I/O mode setup342bob # [ 0.379663] x2apic: IRQ remapping doesn't support X2APIC mode343bob # [ 0.385860] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1344bob # [ 0.392635] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x33cb9aadd1e, max_idle_ns: 440795387521 ns345bob # [ 0.393824] Calibrating delay loop (skipped), value calculated using timer frequency.. 7186.60 BogoMIPS (lpj=3593300)346bob # [ 0.399711] x86/cpu: User Mode Instruction Prevention (UMIP) activated347bob # [ 0.414538] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0348bob # [ 0.414964] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0349bob # [ 0.417342] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto350bob # [ 0.418812] Speculative Store Bypass: Vulnerable351bob # [ 0.419582] Spectre V2 : Mitigation: Retpolines352bob # [ 0.420033] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization353bob # [ 0.420615] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT354bob # [ 0.425599] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'355bob # [ 0.429909] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'356bob # [ 0.430192] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'357bob # [ 0.430682] x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'358bob # [ 0.430940] x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR'359bob # [ 0.431251] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'360bob # [ 0.431732] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256361bob # [ 0.432079] x86/fpu: xstate_offset[3]: 960, xstate_sizes[3]: 64362bob # [ 0.432535] x86/fpu: xstate_offset[4]: 1024, xstate_sizes[4]: 64363bob # [ 0.433305] x86/fpu: xstate_offset[9]: 2688, xstate_sizes[9]: 8364bob # [ 0.433702] x86/fpu: Enabled xstate features 0x21f, context size is 2696 bytes, using 'standard' format.365alice # [ 0.982038] Freeing SMP alternatives memory: 44K366alice # [ 0.983552] pid_max: default: 32768 minimum: 301367alice # [ 0.995795] LSM: initializing lsm=capability,landlock,yama,bpf,ima368alice # [ 0.999228] landlock: Up and running.369alice # [ 0.999430] Yama: becoming mindful.370alice # [ 1.001076] LSM support for eBPF active371alice # [ 1.006294] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)372alice # [ 1.006701] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)373bob # [ 0.938763] Freeing SMP alternatives memory: 44K374bob # [ 0.941692] pid_max: default: 32768 minimum: 301375bob # [ 0.958273] LSM: initializing lsm=capability,landlock,yama,bpf,ima376bob # [ 0.962879] landlock: Up and running.377bob # [ 0.963174] Yama: becoming mindful.378bob # [ 0.965311] LSM support for eBPF active379bob # [ 0.972797] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)380bob # [ 0.973383] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)381alice # [ 1.170928] smpboot: CPU0: AMD QEMU TCG CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)382alice # [ 1.193598] Performance Events: PMU not available due to virtualization, using software events only.383alice # [ 1.197621] signal: max sigframe size: 3632384alice # [ 1.203743] rcu: Hierarchical SRCU implementation.385alice # [ 1.204130] rcu: Max phase no-delay instances is 400.386alice # [ 1.221663] NMI watchdog: Perf NMI watchdog permanently disabled387alice # [ 1.227293] smp: Bringing up secondary CPUs ...388bob # [ 1.136499] smpboot: CPU0: AMD QEMU TCG CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)389alice # [ 1.230439] smp: Brought up 1 node, 1 CPU390alice # [ 1.231202] smpboot: Total of 1 processors activated (7186.49 BogoMIPS)391alice # [ 1.245423] Memory: 941048K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 99604K reserved, 0K cma-reserved)392bob # [ 1.161549] Performance Events: PMU not available due to virtualization, using software events only.393bob # [ 1.164807] signal: max sigframe size: 3632394alice # [ 1.260310] devtmpfs: initialized395bob # [ 1.170303] rcu: Hierarchical SRCU implementation.396bob # [ 1.170708] rcu: Max phase no-delay instances is 400.397alice # [ 1.270090] x86/mm: Memory block size: 128MB398bob # [ 1.185955] NMI watchdog: Perf NMI watchdog permanently disabled399bob # [ 1.192790] smp: Bringing up secondary CPUs ...400bob # [ 1.195629] smp: Brought up 1 node, 1 CPU401bob # [ 1.196029] smpboot: Total of 1 processors activated (7186.60 BogoMIPS)402alice # [ 1.294279] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)403alice # [ 1.295311] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).404alice # [ 1.302141] pinctrl core: initialized pinctrl subsystem405bob # [ 1.210015] Memory: 941068K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 99608K reserved, 0K cma-reserved)406alice # [ 1.316146] PM: RTC time: 13:16:21, date: 2026-09-04407bob # [ 1.223250] devtmpfs: initialized408bob # [ 1.231715] x86/mm: Memory block size: 128MB409bob # [ 1.250933] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)410alice # [ 1.346571] NET: Registered PF_NETLINK/PF_ROUTE protocol family411bob # [ 1.252355] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).412bob # [ 1.258135] pinctrl core: initialized pinctrl subsystem413alice # [ 1.354638] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations414alice # [ 1.356404] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations415alice # [ 1.358158] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations416alice # [ 1.359134] audit: initializing netlink subsys (disabled)417alice # [ 1.363547] audit: type=2000 audit(1788527780.970:1): state=initialized audit_enabled=0 res=1418alice # [ 1.375571] thermal_sys: Registered thermal governor 'fair_share'419alice # [ 1.375717] thermal_sys: Registered thermal governor 'bang_bang'420alice # [ 1.376208] thermal_sys: Registered thermal governor 'step_wise'421alice # [ 1.376431] thermal_sys: Registered thermal governor 'user_space'422alice # [ 1.376675] thermal_sys: Registered thermal governor 'power_allocator'423alice # [ 1.378235] cpuidle: using governor menu424alice # [ 1.381863] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5425bob # [ 1.271660] PM: RTC time: 13:16:21, date: 2026-09-04426alice # [ 1.388301] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]427alice # [ 1.389497] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry428alice # [ 1.392103] PCI: Using configuration type 1 for base access429alice # [ 1.397490] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.430bob # [ 1.297090] NET: Registered PF_NETLINK/PF_ROUTE protocol family431bob # [ 1.303553] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations432bob # [ 1.304869] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations433bob # [ 1.305916] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations434bob # [ 1.306610] audit: initializing netlink subsys (disabled)435bob # [ 1.309945] audit: type=2000 audit(1788527780.931:1): state=initialized audit_enabled=0 res=1436bob # [ 1.318279] thermal_sys: Registered thermal governor 'fair_share'437bob # [ 1.318353] thermal_sys: Registered thermal governor 'bang_bang'438bob # [ 1.318670] thermal_sys: Registered thermal governor 'step_wise'439bob # [ 1.318838] thermal_sys: Registered thermal governor 'user_space'440bob # [ 1.319015] thermal_sys: Registered thermal governor 'power_allocator'441bob # [ 1.320104] cpuidle: using governor menu442alice # [ 1.430178] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages443alice # [ 1.430517] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page444alice # [ 1.430768] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages445alice # [ 1.430981] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page446bob # [ 1.323229] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5447bob # [ 1.328279] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]448bob # [ 1.329628] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry449bob # [ 1.331920] PCI: Using configuration type 1 for base access450bob # [ 1.337811] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.451bob # [ 1.357120] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages452bob # [ 1.357459] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page453bob # [ 1.360145] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages454bob # [ 1.360371] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page455alice # [ 1.505302] ACPI: Added _OSI(Module Device)456alice # [ 1.505565] ACPI: Added _OSI(Processor Device)457alice # [ 1.505718] ACPI: Added _OSI(Processor Aggregator Device)458bob # [ 1.434920] ACPI: Added _OSI(Module Device)459bob # [ 1.435202] ACPI: Added _OSI(Processor Device)460bob # [ 1.435351] ACPI: Added _OSI(Processor Aggregator Device)461alice # [ 1.624305] ACPI: 1 ACPI AML tables successfully acquired and loaded462bob # [ 1.568712] ACPI: 1 ACPI AML tables successfully acquired and loaded463alice # [ 1.690213] ACPI: Interpreter enabled464alice # [ 1.694377] ACPI: PM: (supports S0 S3 S4 S5)465alice # [ 1.694685] ACPI: Using IOAPIC for interrupt routing466alice # [ 1.712260] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug467alice # [ 1.713281] PCI: Using E820 reservations for host bridge windows468alice # [ 1.723554] ACPI: Enabled 2 GPEs in block 00 to 3F469bob # [ 1.657786] ACPI: Interpreter enabled470bob # [ 1.663499] ACPI: PM: (supports S0 S3 S4 S5)471bob # [ 1.669856] ACPI: Using IOAPIC for interrupt routing472bob # [ 1.691951] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug473bob # [ 1.693004] PCI: Using E820 reservations for host bridge windows474bob # [ 1.715897] ACPI: Enabled 2 GPEs in block 00 to 3F475alice # [ 2.177166] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])476alice # [ 2.185454] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]477alice # [ 2.188928] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]478alice # [ 2.201249] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]479bob # [ 2.086474] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])480bob # [ 2.088652] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]481bob # [ 2.101078] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]482bob # [ 2.117954] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]483alice # [ 2.245271] PCI host bridge to bus 0000:00484alice # [ 2.251121] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]485alice # [ 2.254284] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]486alice # [ 2.255595] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]487alice # [ 2.257851] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]488alice # [ 2.259382] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]489alice # [ 2.261461] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]490alice # [ 2.264608] pci_bus 0000:00: root bus resource [bus 00-ff]491bob # [ 2.160559] PCI host bridge to bus 0000:00492bob # [ 2.162982] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]493alice # [ 2.277928] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint494bob # [ 2.165037] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]495bob # [ 2.165950] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]496bob # [ 2.166436] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]497bob # [ 2.166499] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]498bob # [ 2.166499] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]499bob # [ 2.167499] pci_bus 0000:00: root bus resource [bus 00-ff]500bob # [ 2.174852] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint501alice # [ 2.309282] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint502bob # [ 2.190499] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint503alice # [ 2.311928] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]504alice # [ 2.311928] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]505alice # [ 2.314128] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]506bob # [ 2.191726] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]507bob # [ 2.193181] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]508bob # [ 2.193499] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]509bob # [ 2.196342] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]510alice # [ 2.320297] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]511bob # [ 2.205744] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint512bob # [ 2.210499] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]513bob # [ 2.210499] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]514bob # [ 2.210499] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]515bob # [ 2.210499] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]516alice # [ 2.339762] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint517bob # [ 2.220499] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint518alice # [ 2.347626] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]519bob # [ 2.224499] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]520bob # [ 2.224499] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]521bob # [ 2.224499] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]522alice # [ 2.347928] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]523alice # [ 2.351511] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]524bob # [ 2.226499] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint525alice # [ 2.355742] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]526bob # [ 2.226499] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]527bob # [ 2.226499] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]528bob # [ 2.226499] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]529bob # [ 2.228499] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint530bob # [ 2.229499] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]531bob # [ 2.229499] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]532bob # [ 2.229499] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]533bob # [ 2.236313] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint534alice # [ 2.373928] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint535alice # [ 2.375928] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]536alice # [ 2.376359] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]537alice # [ 2.378231] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]538alice # [ 2.387749] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint539bob # [ 2.239151] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]540bob # [ 2.241850] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]541alice # [ 2.389928] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]542bob # [ 2.245120] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]543alice # [ 2.392288] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]544alice # [ 2.394296] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]545alice # [ 2.406619] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint546bob # [ 2.266142] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint547alice # [ 2.406928] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]548alice # [ 2.407928] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]549alice # [ 2.407928] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]550bob # [ 2.273852] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]551bob # [ 2.279085] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]552alice # [ 2.417507] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint553bob # [ 2.281817] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]554alice # [ 2.421219] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]555alice # [ 2.421928] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]556alice # [ 2.421928] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]557bob # [ 2.292499] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint558alice # [ 2.423928] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint559bob # [ 2.295699] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]560bob # [ 2.297298] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]561bob # [ 2.298028] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]562bob # [ 2.299013] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]563alice # [ 2.425413] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]564alice # [ 2.425928] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]565alice # [ 2.425928] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]566bob # [ 2.313133] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint567bob # [ 2.315499] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]568bob # [ 2.316889] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]569alice # [ 2.431649] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint570alice # [ 2.437260] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]571bob # [ 2.326739] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint572alice # [ 2.440741] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]573alice # [ 2.443321] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]574alice # [ 2.445437] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]575bob # [ 2.328980] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]576bob # [ 2.329499] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]577bob # [ 2.329499] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]578alice # [ 2.456138] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint579bob # [ 2.339953] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint580alice # [ 2.462374] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]581bob # [ 2.343673] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]582bob # [ 2.344499] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]583alice # [ 2.466387] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]584bob # [ 2.345778] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]585bob # [ 2.353017] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint586bob # [ 2.353499] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]587alice # [ 2.474928] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint588alice # [ 2.475928] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]589bob # [ 2.362293] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint590alice # [ 2.478264] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]591bob # [ 2.366499] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]592alice # [ 2.480420] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]593alice # [ 2.490245] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint594bob # [ 2.377068] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint595alice # [ 2.490928] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]596alice # [ 2.490928] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]597alice # [ 2.490928] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]598bob # [ 2.382989] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]599alice # [ 2.492928] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint600alice # [ 2.492928] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]601alice # [ 2.494928] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint602alice # [ 2.494928] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]603bob # [ 2.396679] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint604bob # [ 2.397499] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]605bob # [ 2.399499] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint606alice # [ 2.505522] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint607bob # [ 2.404715] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO608alice # [ 2.506928] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]609bob # [ 2.415999] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint610alice # [ 2.512171] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint611alice # [ 2.515928] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]612bob # [ 2.418499] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]613bob # [ 2.420187] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]614alice # [ 2.527106] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint615alice # [ 2.530592] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO616bob # [ 2.430288] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint617bob # [ 2.430499] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]618alice # [ 2.536928] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint619alice # [ 2.537928] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]620alice # [ 2.537928] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]621alice # [ 2.551107] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint622alice # [ 2.552928] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]623bob # [ 2.496202] ACPI: PCI: Interrupt link LNKA configured for IRQ 10624alice # [ 2.610928] ACPI: PCI: Interrupt link LNKA configured for IRQ 10625bob # [ 2.522499] ACPI: PCI: Interrupt link LNKB configured for IRQ 10626alice # [ 2.623768] ACPI: PCI: Interrupt link LNKB configured for IRQ 10627bob # [ 2.539904] ACPI: PCI: Interrupt link LNKC configured for IRQ 11628alice # [ 2.640421] ACPI: PCI: Interrupt link LNKC configured for IRQ 11629bob # [ 2.551499] ACPI: PCI: Interrupt link LNKD configured for IRQ 11630bob # [ 2.558499] ACPI: PCI: Interrupt link LNKE configured for IRQ 10631alice # [ 2.655404] ACPI: PCI: Interrupt link LNKD configured for IRQ 11632bob # [ 2.564499] ACPI: PCI: Interrupt link LNKF configured for IRQ 10633alice # [ 2.659928] ACPI: PCI: Interrupt link LNKE configured for IRQ 10634bob # [ 2.566499] ACPI: PCI: Interrupt link LNKG configured for IRQ 11635alice # [ 2.661928] ACPI: PCI: Interrupt link LNKF configured for IRQ 10636bob # [ 2.569499] ACPI: PCI: Interrupt link LNKH configured for IRQ 11637bob # [ 2.571499] ACPI: PCI: Interrupt link GSIA configured for IRQ 16638alice # [ 2.672863] ACPI: PCI: Interrupt link LNKG configured for IRQ 11639bob # [ 2.572499] ACPI: PCI: Interrupt link GSIB configured for IRQ 17640bob # [ 2.572499] ACPI: PCI: Interrupt link GSIC configured for IRQ 18641bob # [ 2.573499] ACPI: PCI: Interrupt link GSID configured for IRQ 19642alice # [ 2.688928] ACPI: PCI: Interrupt link LNKH configured for IRQ 11643alice # [ 2.690928] ACPI: PCI: Interrupt link GSIA configured for IRQ 16644alice # [ 2.691928] ACPI: PCI: Interrupt link GSIB configured for IRQ 17645alice # [ 2.693928] ACPI: PCI: Interrupt link GSIC configured for IRQ 18646alice # [ 2.694928] ACPI: PCI: Interrupt link GSID configured for IRQ 19647alice # [ 2.695928] ACPI: PCI: Interrupt link GSIE configured for IRQ 20648alice # [ 2.697663] ACPI: PCI: Interrupt link GSIF configured for IRQ 21649alice # [ 2.701458] ACPI: PCI: Interrupt link GSIG configured for IRQ 22650alice # [ 2.704460] ACPI: PCI: Interrupt link GSIH configured for IRQ 23651bob # [ 2.581060] ACPI: PCI: Interrupt link GSIE configured for IRQ 20652bob # [ 2.587326] ACPI: PCI: Interrupt link GSIF configured for IRQ 21653bob # [ 2.597199] ACPI: PCI: Interrupt link GSIG configured for IRQ 22654bob # [ 2.604286] ACPI: PCI: Interrupt link GSIH configured for IRQ 23655alice # [ 2.773462] iommu: Default domain type: Translated656alice # [ 2.776048] iommu: DMA domain TLB invalidation policy: lazy mode657alice # [ 2.792284] ACPI: bus type USB registered658bob # [ 2.667892] iommu: Default domain type: Translated659bob # [ 2.670698] iommu: DMA domain TLB invalidation policy: lazy mode660alice # [ 2.800928] usbcore: registered new interface driver usbfs661alice # [ 2.803928] usbcore: registered new interface driver hub662alice # [ 2.804928] usbcore: registered new device driver usb663bob # [ 2.693673] ACPI: bus type USB registered664bob # [ 2.700628] usbcore: registered new interface driver usbfs665bob # [ 2.705544] usbcore: registered new interface driver hub666bob # [ 2.708671] usbcore: registered new device driver usb667alice # [ 2.913227] NetLabel: Initializing668alice # [ 2.914163] NetLabel: domain hash size = 128669bob # [ 2.803049] NetLabel: Initializing670bob # [ 2.804676] NetLabel: domain hash size = 128671alice # [ 2.916164] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO672bob # [ 2.805857] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO673alice # [ 2.923461] NetLabel: unlabeled traffic allowed by default674bob # [ 2.812866] NetLabel: unlabeled traffic allowed by default675alice # [ 2.925169] PCI: Using ACPI for IRQ routing676bob # [ 2.814968] PCI: Using ACPI for IRQ routing677alice # [ 2.951928] pci 0000:00:01.0: vgaarb: setting as boot VGA device678alice # [ 2.951928] pci 0000:00:01.0: vgaarb: bridge control possible679alice # [ 2.951928] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none680alice # [ 2.953170] vgaarb: loaded681alice # [ 2.957070] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0682alice # [ 2.957908] hpet0: 3 comparators, 64-bit 100.000000 MHz counter683bob # [ 2.846499] pci 0000:00:01.0: vgaarb: setting as boot VGA device684bob # [ 2.846499] pci 0000:00:01.0: vgaarb: bridge control possible685bob # [ 2.846499] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none686bob # [ 2.847926] vgaarb: loaded687bob # [ 2.853047] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0688bob # [ 2.855107] hpet0: 3 comparators, 64-bit 100.000000 MHz counter689alice # [ 2.974398] clocksource: Switched to clocksource tsc-early690bob # [ 2.877668] clocksource: Switched to clocksource tsc-early691bob # [ 2.977973] VFS: Disk quotas dquot_6.6.0692bob # [ 2.987145] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)693bob # [ 3.018282] pnp: PnP ACPI init694alice # [ 3.140034] VFS: Disk quotas dquot_6.6.0695alice # [ 3.150143] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)696alice # [ 3.178431] pnp: PnP ACPI init697bob # [ 3.079545] ACPI: IRQ 4 override to edge(!), high(!)698alice # [ 3.206925] ACPI: IRQ 4 override to edge(!), high(!)699alice # [ 3.224486] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved700bob # [ 3.110178] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved701alice # [ 3.255375] pnp: PnP ACPI: found 6 devices702bob # [ 3.194120] pnp: PnP ACPI: found 6 devices703alice # [ 3.625984] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns704alice # [ 3.630669] clocksource: Switched to clocksource acpi_pm705alice # [ 3.642275] NET: Registered PF_INET protocol family706alice # [ 3.661575] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)707bob # [ 3.606443] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns708bob # [ 3.611029] clocksource: Switched to clocksource acpi_pm709bob # [ 3.622367] NET: Registered PF_INET protocol family710bob # [ 3.636617] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)711alice # [ 3.934732] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)712alice # [ 3.935309] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)713alice # [ 3.935309] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)714alice # [ 3.942219] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)715alice # [ 3.942383] TCP: Hash tables configured (established 8192 bind 8192)716alice # [ 3.954380] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)717alice # [ 3.958324] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)718alice # [ 3.962698] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)719alice # [ 3.981310] NET: Registered PF_UNIX/PF_LOCAL protocol family720alice # [ 3.991815] NET: Registered PF_XDP protocol family721alice # [ 3.996858] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]722alice # [ 3.998252] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]723alice # [ 3.999333] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]724alice # [ 4.000480] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]725alice # [ 4.001123] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]726alice # [ 4.002138] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]727alice # [ 4.038857] ACPI: \_SB_.GSIA: Enabled at IRQ 16728bob # [ 3.932704] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)729bob # [ 3.935944] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)730bob # [ 3.939636] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)731bob # [ 3.945038] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)732bob # [ 3.948670] TCP: Hash tables configured (established 8192 bind 8192)733bob # [ 3.964724] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)734bob # [ 3.966816] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)735alice # [ 4.077523] pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x7c0 took 70315 usecs736bob # [ 3.973293] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)737bob # [ 3.990916] NET: Registered PF_UNIX/PF_LOCAL protocol family738alice # [ 4.103380] ACPI: \_SB_.GSIB: Enabled at IRQ 17739bob # [ 4.000058] NET: Registered PF_XDP protocol family740bob # [ 4.008726] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]741bob # [ 4.009757] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]742bob # [ 4.012536] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]743bob # [ 4.013958] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]744bob # [ 4.014281] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]745bob # [ 4.014281] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]746alice # [ 4.129489] pci 0000:00:1d.1: quirk_usb_early_handoff+0x0/0x7c0 took 42833 usecs747alice # [ 4.148146] ACPI: \_SB_.GSIC: Enabled at IRQ 18748bob # [ 4.050781] ACPI: \_SB_.GSIA: Enabled at IRQ 16749alice # [ 4.166208] pci 0000:00:1d.2: quirk_usb_early_handoff+0x0/0x7c0 took 33166 usecs750alice # [ 4.180789] ACPI: \_SB_.GSID: Enabled at IRQ 19751bob # [ 4.083605] pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x7c0 took 58889 usecs752alice # [ 4.201080] pci 0000:00:1d.7: quirk_usb_early_handoff+0x0/0x7c0 took 31108 usecs753alice # [ 4.205132] PCI: CLS 0 bytes, default 64754bob # [ 4.098570] ACPI: \_SB_.GSIB: Enabled at IRQ 17755bob # [ 4.110351] pci 0000:00:1d.1: quirk_usb_early_handoff+0x0/0x7c0 took 22489 usecs756bob # [ 4.119281] ACPI: \_SB_.GSIC: Enabled at IRQ 18757bob # [ 4.128297] pci 0000:00:1d.2: quirk_usb_early_handoff+0x0/0x7c0 took 16190 usecs758alice # [ 4.242695] Trying to unpack rootfs image as initramfs...759bob # [ 4.135973] ACPI: \_SB_.GSID: Enabled at IRQ 19760bob # [ 4.143948] pci 0000:00:1d.7: quirk_usb_early_handoff+0x0/0x7c0 took 14015 usecs761bob # [ 4.144588] PCI: CLS 0 bytes, default 64762bob # [ 4.156337] Trying to unpack rootfs image as initramfs...763alice # [ 4.526938] Initialise system trusted keyrings764alice # [ 4.531629] workingset: timestamp_bits=40 max_order=18 bucket_order=0765bob # [ 4.436088] Initialise system trusted keyrings766bob # [ 4.446024] workingset: timestamp_bits=40 max_order=18 bucket_order=0767alice # [ 4.726015] Key type asymmetric registered768alice # [ 4.726497] Asymmetric key parser 'x509' registered769alice # [ 4.727214] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)770alice # [ 4.732061] io scheduler mq-deadline registered771alice # [ 4.732477] io scheduler kyber registered772bob # [ 4.641458] Key type asymmetric registered773alice # [ 4.754501] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled774bob # [ 4.643994] Asymmetric key parser 'x509' registered775bob # [ 4.645131] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)776bob # [ 4.650288] io scheduler mq-deadline registered777bob # [ 4.652823] io scheduler kyber registered778alice # [ 4.770064] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A779bob # [ 4.674409] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled780bob # [ 4.690534] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A781alice # [ 4.804756] Linux agpgart interface v0.103782alice # [ 4.808165] ACPI: bus type drm_connector registered783alice # [ 4.827208] usbcore: registered new interface driver usbserial_generic784alice # [ 4.828286] usbserial: USB Serial support registered for generic785alice # [ 4.831035] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled786alice # [ 4.838773] drop_monitor: Initializing network drop monitor service787bob # [ 4.731020] Linux agpgart interface v0.103788alice # [ 4.843123] NET: Registered PF_INET6 protocol family789bob # [ 4.734795] ACPI: bus type drm_connector registered790bob # [ 4.757248] usbcore: registered new interface driver usbserial_generic791bob # [ 4.758561] usbserial: USB Serial support registered for generic792bob # [ 4.762198] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled793bob # [ 4.769123] drop_monitor: Initializing network drop monitor service794alice # [ 4.882524] Segment Routing with IPv6795alice # [ 4.883381] In-situ OAM (IOAM) with IPv6796bob # [ 4.773626] NET: Registered PF_INET6 protocol family797alice # [ 4.896645] IPI shorthand broadcast: enabled798bob # [ 4.805334] Segment Routing with IPv6799bob # [ 4.806122] In-situ OAM (IOAM) with IPv6800bob # [ 4.817200] IPI shorthand broadcast: enabled801alice # [ 4.972982] sched_clock: Marking stable (4908050964, 64225522)->(5482735241, -510458755)802alice # [ 4.983110] registered taskstats version 1803alice # [ 4.992016] Loading compiled-in X.509 certificates804bob # [ 4.900318] sched_clock: Marking stable (4840098495, 59639773)->(5419735254, -519996986)805bob # [ 4.929268] registered taskstats version 1806bob # [ 4.937644] Loading compiled-in X.509 certificates807alice # [ 5.142036] Demotion targets for Node 0: null808alice # [ 5.148551] Key type .fscrypt registered809alice # [ 5.148815] Key type fscrypt-provisioning registered810alice # [ 5.155633] ima: No TPM chip found, activating TPM-bypass!811alice # [ 5.155997] ima: Allocated hash algorithm: sha1812alice # [ 5.167362] ima: No architecture policies found813alice # [ 5.178531] PM: Magic number: 10:416:280814alice # [ 5.179013] tty tty17: hash matches815alice # [ 5.194680] RAS: Correctable Errors collector initialized.816bob # [ 5.083491] Demotion targets for Node 0: null817bob # [ 5.088564] Key type .fscrypt registered818bob # [ 5.088953] Key type fscrypt-provisioning registered819bob # [ 5.100431] ima: No TPM chip found, activating TPM-bypass!820bob # [ 5.100969] ima: Allocated hash algorithm: sha1821bob # [ 5.108514] ima: No architecture policies found822bob # [ 5.120064] PM: Magic number: 10:416:280823bob # [ 5.120554] tty tty17: hash matches824bob # [ 5.136541] RAS: Correctable Errors collector initialized.825alice # [ 5.274414] clk: Disabling unused clocks826alice # [ 5.275183] PM: genpd: Disabling unused power domains827alice # [ 5.289569] tsc: Refined TSC clocksource calibration: 3593.233 MHz828alice # [ 5.290496] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x33cb5b25ea5, max_idle_ns: 440795305334 ns829bob # [ 5.211088] tsc: Refined TSC clocksource calibration: 3593.232 MHz830bob # [ 5.211972] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x33cb59d6956, max_idle_ns: 440795347381 ns831bob # [ 5.221003] clk: Disabling unused clocks832bob # [ 5.221631] PM: genpd: Disabling unused power domains833alice # [ 7.424524] Freeing initrd memory: 29080K834bob # [ 7.374881] Freeing initrd memory: 29084K835alice # [ 7.540540] Freeing unused decrypted memory: 2028K836bob # [ 7.498436] Freeing unused decrypted memory: 2028K837alice # [ 7.614819] Freeing unused kernel image (initmem) memory: 3644K838alice # [ 7.615807] Write protecting the kernel read-only data: 32768k839alice # [ 7.620086] Freeing unused kernel image (text/rodata gap) memory: 1216K840alice # [ 7.621772] Freeing unused kernel image (rodata/data gap) memory: 756K841bob # [ 7.573153] Freeing unused kernel image (initmem) memory: 3644K842bob # [ 7.574004] Write protecting the kernel read-only data: 32768k843bob # [ 7.577962] Freeing unused kernel image (text/rodata gap) memory: 1216K844bob # [ 7.579435] Freeing unused kernel image (rodata/data gap) memory: 756K845alice # [ 7.809260] x86/mm: Checked W+X mappings: passed, no W+X pages found.846alice # [ 7.809824] Run /init as init process847bob # [ 7.772598] x86/mm: Checked W+X mappings: passed, no W+X pages found.848bob # [ 7.773662] Run /init as init process849alice # [ 8.236267] systemd[1]: Inserted module 'autofs4'850bob # [ 8.309629] systemd[1]: Inserted module 'autofs4'851alice # [ 8.590298] fuse: init (API version 7.45)852alice # [ 8.752231] ACPI: \_SB_.GSIG: Enabled at IRQ 22853alice # [ 8.774302] ACPI: \_SB_.GSIH: Enabled at IRQ 23854alice # [ 8.818187] ACPI: \_SB_.GSIE: Enabled at IRQ 20855alice # [ 8.836671] ACPI: \_SB_.GSIF: Enabled at IRQ 21856bob # [ 8.889801] fuse: init (API version 7.45)857bob # [ 9.045649] ACPI: \_SB_.GSIG: Enabled at IRQ 22858bob # [ 9.082529] ACPI: \_SB_.GSIH: Enabled at IRQ 23859bob # [ 9.145656] ACPI: \_SB_.GSIE: Enabled at IRQ 20860bob # [ 9.162064] ACPI: \_SB_.GSIF: Enabled at IRQ 21861alice # [ 9.357774] systemd[1]: Successfully made /usr/ read-only.862alice # [ 9.788748] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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)863alice # [ 9.791804] systemd[1]: Detected virtualization qemu.864alice # [ 9.795998] systemd[1]: Detected architecture x86-64.865alice # [ 9.798182] systemd[1]: Running in initrd.866bob # [ 9.720985] systemd[1]: Successfully made /usr/ read-only.867alice # [ 9.834720] systemd[1]: Initializing machine ID from random generator.868alice # [ 9.845792] systemd[1]: Hostname set to <alice>.869bob # [ 10.101329] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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)870bob # [ 10.115465] systemd[1]: Detected virtualization qemu.871bob # [ 10.117238] systemd[1]: Detected architecture x86-64.872bob # [ 10.126293] systemd[1]: Running in initrd.873bob # [ 10.217020] systemd[1]: Initializing machine ID from random generator.874bob # [ 10.253210] systemd[1]: Hostname set to <bob>.875alice # [ 13.640870] systemd[1]: bpf-restrict-fs: LSM BPF program attached876bob # [ 13.706109] systemd[1]: bpf-restrict-fs: LSM BPF program attached877alice # [ 14.864214] systemd[1]: Queued start job for default target Initrd Default Target.878alice # [ 14.934113] systemd[1]: Created slice Slice /system/modprobe.879alice # [ 14.941443] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.880alice # [ 14.943386] systemd[1]: Expecting device /dev/disk/by-label/nixos...881alice # [ 14.944595] systemd[1]: Reached target Path Units.882alice # [ 14.945243] systemd[1]: Reached target Slice Units.883alice # [ 14.946070] systemd[1]: Reached target Swaps.884alice # [ 14.947034] systemd[1]: Reached target Timer Units.885alice # [ 14.954961] systemd[1]: Listening on D-Bus System Message Bus Socket.886alice # [ 14.959442] systemd[1]: Listening on Journal Socket (/dev/log).887alice # [ 14.962148] systemd[1]: Listening on Journal Sockets.888alice # [ 14.965726] systemd[1]: Listening on udev Control Socket.889alice # [ 14.967794] systemd[1]: Listening on udev Kernel Socket.890alice # [ 14.968788] systemd[1]: Reached target Socket Units.891alice # [ 15.016977] systemd[1]: Starting Create List of Static Device Nodes...892alice # [ 15.104126] systemd[1]: Starting Load Kernel Module 9pnet_virtio...893bob # [ 15.022010] systemd[1]: Queued start job for default target Initrd Default Target.894alice # [ 15.174849] systemd[1]: Starting Load Kernel Module configfs...895bob # [ 15.098193] systemd[1]: Created slice Slice /system/modprobe.896bob # [ 15.106029] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.897bob # [ 15.108185] systemd[1]: Expecting device /dev/disk/by-label/nixos...898bob # [ 15.109579] systemd[1]: Reached target Path Units.899bob # [ 15.110537] systemd[1]: Reached target Slice Units.900bob # [ 15.111352] systemd[1]: Reached target Swaps.901bob # [ 15.112270] systemd[1]: Reached target Timer Units.902bob # [ 15.119267] systemd[1]: Listening on D-Bus System Message Bus Socket.903bob # [ 15.124462] systemd[1]: Listening on Journal Socket (/dev/log).904bob # [ 15.127182] systemd[1]: Listening on Journal Sockets.905bob # [ 15.130245] systemd[1]: Listening on udev Control Socket.906bob # [ 15.132594] systemd[1]: Listening on udev Kernel Socket.907bob # [ 15.133577] systemd[1]: Reached target Socket Units.908bob # [ 15.175280] systemd[1]: Starting Create List of Static Device Nodes...909bob # [ 15.235958] systemd[1]: Starting Load Kernel Module 9pnet_virtio...910bob # [ 15.317392] systemd[1]: Starting Load Kernel Module configfs...911alice # [ 15.498211] systemd[1]: Starting Journal Service...912bob # [ 15.726099] systemd[1]: Starting Journal Service...913alice # [ 15.839957] systemd[1]: Starting Load Kernel Modules...914alice # [ 15.880888] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os915bob # [ 16.013382] systemd[1]: Starting Load Kernel Modules...916alice # [ 16.129825] systemd[1]: Starting Coldplug All udev Devices...917bob # [ 16.047346] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os918bob # [ 16.245426] systemd[1]: Starting Coldplug All udev Devices...919alice # [ 16.544513] netfs: FS-Cache loaded920alice # [ 16.601073] systemd[1]: Finished Create List of Static Device Nodes.921bob # [ 16.639474] netfs: FS-Cache loaded922alice # [ 16.791039] 9pnet: Installing 9P2000 support923bob # [ 16.794542] systemd[1]: Finished Create List of Static Device Nodes.924alice # [ 16.941191] systemd[1]: modprobe@configfs.service: Deactivated successfully.925alice # [ 17.011209] systemd[1]: Finished Load Kernel Module configfs.926bob # [ 16.902161] 9pnet: Installing 9P2000 support927alice # [ 17.107508] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.928alice # [ 17.157518] systemd[1]: Finished Load Kernel Module 9pnet_virtio.929bob # [ 17.119222] systemd[1]: modprobe@configfs.service: Deactivated successfully.930alice # [ 17.277053] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config931bob # [ 17.197236] systemd[1]: Finished Load Kernel Module configfs.932alice # [ 17.431600] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...933bob # [ 17.327359] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.934bob # [ 17.396192] systemd[1]: Finished Load Kernel Module 9pnet_virtio.935bob # [ 17.506896] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config936alice # [ 17.725213] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.937alice # [ 17.754861] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev938bob # [ 17.650433] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...939bob # [ 17.842510] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.940bob # [ 17.856330] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev941alice # [ 18.204632] systemd[1]: Finished Load Kernel Modules.942alice # [ 18.308136] systemd[1]: Starting Apply Kernel Variables...943bob # [ 18.263880] systemd[1]: Finished Load Kernel Modules.944bob # [ 18.362044] systemd[1]: Starting Apply Kernel Variables...945alice # [ 18.533225] systemd-journald[68]: Collecting audit messages is disabled.946alice # [ 18.581960] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.947alice # [ 18.730935] systemd[1]: Starting Create Static Device Nodes in /dev...948bob # [ 18.635508] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.949bob # [ 18.641318] systemd-journald[68]: Collecting audit messages is disabled.950bob # [ 18.748084] systemd[1]: Starting Create Static Device Nodes in /dev...951alice # [ 19.320878] systemd[1]: Finished Apply Kernel Variables.952bob # [ 19.216348] systemd[1]: Finished Apply Kernel Variables.953alice # [ 19.553660] systemd[1]: Finished Create Static Device Nodes in /dev.954alice # [ 19.572580] systemd[1]: Reached target Preparation for Local File Systems.955alice # [ 19.575782] systemd[1]: Reached target Local File Systems.956bob # [ 19.505542] systemd[1]: Finished Create Static Device Nodes in /dev.957bob # [ 19.536929] systemd[1]: Reached target Preparation for Local File Systems.958alice # [ 19.651870] systemd[1]: Starting Rule-based Manager for Device Events and Files...959bob # [ 19.543255] systemd[1]: Reached target Local File Systems.960bob # [ 19.637849] systemd[1]: Starting Rule-based Manager for Device Events and Files...961alice # [ 20.939675] systemd[1]: Started Journal Service.962alice # [ 20.900733] systemd-modules-load[69]: Inserted module 'dm_mod'963alice # [ 20.983797] systemd-modules-load[69]: Inserted module 'virtio_balloon'964alice # [ 21.015517] systemd-modules-load[69]: Inserted module 'virtio_gpu'965alice # [ 21.053353] systemd-udevd[75]: Using default interface naming scheme 'v261'.966alice # [ 21.100417] systemd[1]: Starting Create System Files and Directories...967bob # [ 21.263243] systemd[1]: Started Journal Service.968bob # [ 21.232501] systemd-modules-load[69]: Inserted module 'dm_mod'969bob # [ 21.338004] systemd-modules-load[69]: Inserted module 'virtio_balloon'970bob # [ 21.381933] systemd-modules-load[69]: Inserted module 'virtio_gpu'971bob # [ 21.433627] systemd-udevd[75]: Using default interface naming scheme 'v261'.972bob # [ 21.481637] systemd[1]: Starting Create System Files and Directories...973alice # [ 21.775541] systemd[1]: Finished Create System Files and Directories.974alice # [ 22.181732] systemd[1]: Started Rule-based Manager for Device Events and Files.975bob # [ 22.172554] systemd[1]: Finished Create System Files and Directories.976bob # [ 22.833492] systemd[1]: Started Rule-based Manager for Device Events and Files.977bob: Guest root shell did not produce any data yet...978bob: To debug, enter the VM and run 'systemctl status backdoor.service'.979alice # [ 30.370902] systemd[1]: Finished Coldplug All udev Devices.980alice # [ 30.425607] systemd[1]: Reached target System Initialization.981alice # [ 30.484044] systemd[1]: Reached target Basic System.982bob # [ 36.105836] systemd[1]: Finished Coldplug All udev Devices.983bob # [ 36.127077] systemd[1]: Reached target System Initialization.984bob # [ 36.156672] systemd[1]: Reached target Basic System.985alice # [ 49.195994] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12986alice # [ 49.260181] serio: i8042 KBD port at 0x60,0x64 irq 1987alice # [ 49.261107] serio: i8042 AUX port at 0x60,0x64 irq 12988bob # [ 49.282636] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12989bob # [ 49.296940] serio: i8042 KBD port at 0x60,0x64 irq 1990bob # [ 49.297554] serio: i8042 AUX port at 0x60,0x64 irq 12991alice # [ 49.842652] virtio_blk virtio5: 1/0/0 default/read/poll queues992alice # [ 49.998872] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)993alice # [ 50.367070] ehci-pci 0000:00:1d.7: EHCI Host Controller994alice # [ 50.368102] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1995alice # [ 50.387158] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000996alice # [ 50.394740] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00997alice # [ 50.418138] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18998alice # [ 50.418924] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1999alice # [ 50.419233] usb usb1: Product: EHCI Host Controller1000alice # [ 50.419578] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd1001alice # [ 50.419757] usb usb1: SerialNumber: 0000:00:1d.71002alice # [ 50.439218] hub 1-0:1.0: USB hub found1003alice # [ 50.447702] hub 1-0:1.0: 6 ports detected1004alice # [ 50.468467] uhci_hcd 0000:00:1d.0: UHCI Host Controller1005alice # [ 50.480832] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 21006alice # [ 50.491643] uhci_hcd 0000:00:1d.0: detected 2 ports1007alice # [ 50.493176] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001008alice # [ 50.536980] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181009alice # [ 50.537695] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11010alice # [ 50.537952] usb usb2: Product: UHCI Host Controller1011alice # [ 50.538080] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd1012alice # [ 50.548693] usb usb2: SerialNumber: 0000:00:1d.01013alice # [ 50.562483] hub 2-0:1.0: USB hub found1014alice # [ 50.571496] hub 2-0:1.0: 2 ports detected1015alice # [ 50.682686] uhci_hcd 0000:00:1d.1: UHCI Host Controller1016alice # [ 50.683114] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31017alice # [ 50.683828] uhci_hcd 0000:00:1d.1: detected 2 ports1018alice # [ 50.692936] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201019alice # [ 50.719076] usb 1-1: new high-speed USB device number 2 using ehci-pci1020alice # [ 50.729866] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181021alice # [ 50.730798] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11022alice # [ 50.731053] usb usb3: Product: UHCI Host Controller1023alice # [ 50.731197] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1024alice # [ 50.744889] usb usb3: SerialNumber: 0000:00:1d.11025alice # [ 50.766147] hub 3-0:1.0: USB hub found1026alice # [ 50.775755] hub 3-0:1.0: 2 ports detected1027alice # [ 50.859144] uhci_hcd 0000:00:1d.2: UHCI Host Controller1028alice # [ 50.870013] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41029alice # [ 50.870764] uhci_hcd 0000:00:1d.2: detected 2 ports1030alice # [ 50.879858] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401031alice # [ 50.891189] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001032alice # [ 50.891826] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101033alice # [ 50.892135] usb 1-1: Product: QEMU USB Tablet1034alice # [ 50.892658] usb 1-1: Manufacturer: QEMU1035alice # [ 50.892859] usb 1-1: SerialNumber: 28754-0000:00:1d.7-11036alice # [ 50.917612] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181037alice # [ 50.918047] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11038alice # [ 50.925557] usb usb4: Product: UHCI Host Controller1039alice # [ 50.925861] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1040alice # [ 50.926018] usb usb4: SerialNumber: 0000:00:1d.21041alice # [ 50.958568] hub 4-0:1.0: USB hub found1042alice # [ 50.962622] hub 4-0:1.0: 2 ports detected1043bob # [ 51.073934] virtio_blk virtio5: 1/0/0 default/read/poll queues1044alice # [ 51.297553] SCSI subsystem initialized1045bob # [ 51.503941] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1046bob # [ 52.087196] uhci_hcd 0000:00:1d.0: UHCI Host Controller1047bob # [ 52.106877] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11048bob # [ 52.143498] uhci_hcd 0000:00:1d.0: detected 2 ports1049bob # [ 52.168903] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c2001050bob # [ 52.244671] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181051bob # [ 52.253642] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11052bob # [ 52.254554] usb usb1: Product: UHCI Host Controller1053bob # [ 52.268538] usb usb1: Manufacturer: Linux 6.18.48 uhci_hcd1054bob # [ 52.269471] usb usb1: SerialNumber: 0000:00:1d.01055bob # [ 52.321270] hub 1-0:1.0: USB hub found1056bob # [ 52.336210] hub 1-0:1.0: 2 ports detected1057bob # [ 52.443834] ehci-pci 0000:00:1d.7: EHCI Host Controller1058bob # [ 52.444257] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 21059bob # [ 52.460285] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001060bob # [ 52.469130] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001061alice # [ 52.587719] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1062bob # [ 52.485196] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181063alice # [ 52.599570] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1064alice # [ 52.600069] ahci 0000:00:1f.2: flags: 64bit ncq only1065bob # [ 52.489101] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11066bob # [ 52.489635] usb usb2: Product: EHCI Host Controller1067bob # [ 52.490285] usb usb2: Manufacturer: Linux 6.18.48 ehci_hcd1068bob # [ 52.490597] usb usb2: SerialNumber: 0000:00:1d.71069bob # [ 52.507395] hub 2-0:1.0: USB hub found1070bob # [ 52.516300] hub 2-0:1.0: 6 ports detected1071bob # [ 52.587318] hub 1-0:1.0: USB hub found1072bob # [ 52.593458] hub 1-0:1.0: 2 ports detected1073bob # [ 52.609510] uhci_hcd 0000:00:1d.1: UHCI Host Controller1074bob # [ 52.610077] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 31075bob # [ 52.610467] uhci_hcd 0000:00:1d.1: detected 2 ports1076bob # [ 52.611461] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c2201077alice # [ 52.726111] scsi host0: ahci1078alice # [ 52.753788] scsi host1: ahci1079alice # [ 52.773676] scsi host2: ahci1080alice # [ 52.797010] scsi host3: ahci1081bob # [ 52.694323] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181082bob # [ 52.695575] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11083alice # [ 52.814574] scsi host4: ahci1084bob # [ 52.712033] usb usb3: Product: UHCI Host Controller1085bob # [ 52.712386] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd1086bob # [ 52.712614] usb usb3: SerialNumber: 0000:00:1d.11087alice # [ 52.832887] scsi host5: ahci1088alice # [ 52.844770] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11089alice # [ 52.850874] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11090bob # [ 52.738569] hub 3-0:1.0: USB hub found1091alice # [ 52.851583] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11092alice # [ 52.851935] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11093alice # [ 52.852220] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11094alice # [ 52.859775] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11095bob # [ 52.755927] hub 3-0:1.0: 2 ports detected1096bob # [ 52.827246] usb 2-1: new high-speed USB device number 2 using ehci-pci1097bob # [ 52.854308] uhci_hcd 0000:00:1d.2: UHCI Host Controller1098bob # [ 52.855169] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 41099bob # [ 52.868068] uhci_hcd 0000:00:1d.2: detected 2 ports1100bob # [ 52.877091] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c2401101bob # [ 52.905919] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181102bob # [ 52.906269] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11103bob # [ 52.906526] usb usb4: Product: UHCI Host Controller1104bob # [ 52.906979] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd1105bob # [ 52.907169] usb usb4: SerialNumber: 0000:00:1d.21106bob # [ 52.922972] hub 4-0:1.0: USB hub found1107bob # [ 52.931947] hub 4-0:1.0: 2 ports detected1108bob # [ 52.988046] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001109bob # [ 52.988450] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101110bob # [ 52.988645] usb 2-1: Product: QEMU USB Tablet1111bob # [ 52.989068] usb 2-1: Manufacturer: QEMU1112bob # [ 52.989217] usb 2-1: SerialNumber: 28754-0000:00:1d.7-11113alice # [ 53.193138] ata6: SATA link down (SStatus 0 SControl 300)1114alice # [ 53.199155] ata1: SATA link down (SStatus 0 SControl 300)1115alice # [ 53.200230] ata4: SATA link down (SStatus 0 SControl 300)1116alice # [ 53.200953] ata5: SATA link down (SStatus 0 SControl 300)1117alice # [ 53.201491] ata2: SATA link down (SStatus 0 SControl 300)1118alice # [ 53.202649] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1119alice # [ 53.215024] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001120alice # [ 53.219788] ata3.00: applying bridge limits1121alice # [ 53.223921] ata3.00: configured for UDMA/1001122alice # [ 53.257143] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51123bob # [ 53.184342] SCSI subsystem initialized1124bob # [ 54.424231] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1125bob # [ 54.428236] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1126bob # [ 54.429456] ahci 0000:00:1f.2: flags: 64bit ncq only1127bob # [ 54.617099] scsi host0: ahci1128bob # [ 54.694895] scsi host1: ahci1129bob # [ 54.774038] scsi host2: ahci1130bob # [ 54.868748] scsi host3: ahci1131bob # [ 54.922155] scsi host4: ahci1132bob # [ 54.962863] scsi host5: ahci1133bob # [ 54.992190] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 11134bob # [ 55.013186] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 11135bob # [ 55.014020] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 11136bob # [ 55.014343] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 11137bob # [ 55.014650] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 11138bob # [ 55.014969] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 11139bob # [ 55.389844] ata6: SATA link down (SStatus 0 SControl 300)1140bob # [ 55.416968] ata4: SATA link down (SStatus 0 SControl 300)1141bob # [ 55.420789] ata1: SATA link down (SStatus 0 SControl 300)1142bob # [ 55.426169] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1143bob # [ 55.490802] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001144bob # [ 55.492005] ata3.00: applying bridge limits1145bob # [ 55.510227] ata5: SATA link down (SStatus 0 SControl 300)1146bob # [ 55.511530] ata2: SATA link down (SStatus 0 SControl 300)1147bob # [ 55.522291] ata3.00: configured for UDMA/1001148bob # [ 55.660148] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51149bob: Guest root shell did not produce any data yet...1150bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1151alice # [ 71.616542] systemd[1]: Starting Virtual Console Setup...1152alice # [ 75.149241] systemd-vconsole-setup[208]: Configuration of first virtual console was skipped, ignoring remaining ones.1153alice # [ 75.367136] systemd[1]: Finished Virtual Console Setup.1154alice # [ 78.814757] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01155bob # [ 78.762702] systemd[1]: Starting Virtual Console Setup...1156alice # [ 78.904961] (udev-worker)[216]: Network interface NamePolicy= disabled on kernel command line.1157alice # [ 78.942916] (udev-worker)[211]: Network interface NamePolicy= disabled on kernel command line.1158bob # [ 80.548770] systemd-vconsole-setup[226]: Configuration of first virtual console was skipped, ignoring remaining ones.1159alice # [ 80.758359] systemd[1]: Found device /dev/disk/by-label/nixos.1160alice # [ 80.779723] systemd[1]: Reached target Initrd Root Device.1161bob # [ 80.690453] systemd[1]: Finished Virtual Console Setup.1162alice # [ 80.843759] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1163alice # [ 83.291731] systemd-fsck[234]: nixos: clean, 12/65536 files, 13019/262144 blocks1164alice # [ 83.481770] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1165alice # [ 83.624040] systemd[1]: Mounting /sysroot...1166bob # [ 84.067776] systemd[1]: Found device /dev/disk/by-label/nixos.1167bob # [ 84.080906] systemd[1]: Reached target Initrd Root Device.1168bob # [ 84.137590] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1169bob # [ 84.945928] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01170bob # [ 85.026727] systemd-fsck[250]: nixos: clean, 12/65536 files, 13019/262144 blocks1171bob # [ 85.177072] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1172bob # [ 85.241987] systemd[1]: Mounting /sysroot...1173bob # [ 85.453854] (udev-worker)[241]: Network interface NamePolicy= disabled on kernel command line.1174bob # [ 85.499897] (udev-worker)[244]: Network interface NamePolicy= disabled on kernel command line.1175alice # [ 86.471948] EXT4-fs (vda): mounted filesystem ed25da61-ba25-43d7-aea6-89ad3e92824c r/w with ordered data mode. Quota mode: none.1176alice # [ 86.572838] systemd[1]: Mounted /sysroot.1177alice # [ 86.592660] systemd[1]: Reached target Initrd Root File System.1178alice # [ 86.743971] systemd[1]: Mounting /sysroot/nix/.ro-store...1179alice # [ 86.870783] systemd[1]: Mounting /sysroot/nix/.rw-store...1180alice # [ 87.041579] systemd[1]: Mounting /sysroot/run...1181bob: Guest root shell did not produce any data yet...1182bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1183alice # [ 87.285020] systemd[1]: Mounting /sysroot/tmp/shared...1184alice # [ 87.461769] systemd[1]: Mounting /sysroot/tmp/xchg...1185alice # [ 87.761233] systemd[1]: Starting Mountpoints Configured in the Real Root...1186bob # [ 88.218006] EXT4-fs (vda): mounted filesystem 021fd8e5-add2-4c91-8acf-dff17a382e3f r/w with ordered data mode. Quota mode: none.1187bob # [ 88.336521] systemd[1]: Mounted /sysroot.1188bob # [ 88.366533] systemd[1]: Reached target Initrd Root File System.1189alice # [ 88.763994] 9p: Installing v9fs 9p2000 file system support1190bob # [ 88.885202] systemd[1]: Mounting /sysroot/nix/.ro-store...1191bob # [ 89.543478] systemd[1]: Mounting /sysroot/nix/.rw-store...1192alice # [ 90.241004] systemd-sysroot-fstab-check[258]: /sysroot should be mounted in the initrd, will request daemon-reload.1193bob # [ 90.132918] systemd[1]: Mounting /sysroot/run...1194bob # [ 90.956492] systemd[1]: Mounting /sysroot/tmp/shared...1195alice # [ 91.271576] systemd[1]: Mounted /sysroot/nix/.ro-store.1196alice # [ 91.335763] systemd[1]: Mounted /sysroot/nix/.rw-store.1197alice # [ 91.342128] systemd[1]: Mounted /sysroot/run.1198alice # [ 91.368082] systemd[1]: Mounted /sysroot/tmp/shared.1199alice # [ 91.412837] systemd[1]: Mounted /sysroot/tmp/xchg.1200alice # [ 92.049104] systemd[1]: Reload requested from client PID 258 ('systemd-sysroot') (unit initrd-parse-etc.service)...1201alice # [ 92.089949] systemd[1]: Reloading...1202bob # [ 92.519537] systemd[1]: Mounting /sysroot/tmp/xchg...1203bob # [ 94.344029] hrtimer: interrupt took 3972572 ns1204bob # [ 94.340592] systemd[1]: Starting Mountpoints Configured in the Real Root...1205bob # [ 96.442259] 9p: Installing v9fs 9p2000 file system support1206bob # [ 99.052734] systemd-sysroot-fstab-check[277]: /sysroot should be mounted in the initrd, will request daemon-reload.1207bob # [ 99.160785] systemd[1]: Mounted /sysroot/nix/.ro-store.1208bob # [ 99.689429] systemd[1]: Mounted /sysroot/nix/.rw-store.1209bob # [ 99.923800] systemd[1]: Mounted /sysroot/run.1210bob # [ 99.967636] systemd[1]: Mounted /sysroot/tmp/shared.1211bob # [ 100.087210] systemd[1]: Mounted /sysroot/tmp/xchg.1212bob # [ 100.293642] systemd[1]: Reload requested from client PID 277 ('systemd-sysroot') (unit initrd-parse-etc.service)...1213bob # [ 100.301909] systemd[1]: Reloading...1214alice # [ 100.435888] systemd[1]: Reloading finished in 8281 ms.1215alice # [ 100.980894] systemd-sysroot-fstab-check[258]: Requesting initrd-fs.target/start/replace...1216alice # [ 101.133845] systemd-sysroot-fstab-check[258]: Requesting swap.target/start/replace...1217alice # [ 101.227717] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1218alice # [ 101.248726] systemd[1]: Finished Mountpoints Configured in the Real Root.1219alice # [ 101.265886] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1220alice # [ 101.483206] systemd[1]: Starting rw-sysroot-nix-store.service...1221alice # [ 103.999337] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1222alice # [ 104.062232] systemd[1]: Finished rw-sysroot-nix-store.service.1223alice # [ 104.395978] systemd[1]: Mounting /sysroot/nix/store...1224bob # [ 106.369420] systemd[1]: Reloading finished in 6012 ms.1225alice # [ 106.571719] systemd[1]: Mounted /sysroot/nix/store.1226alice # [ 106.631841] systemd[1]: Reached target Initrd File Systems.1227alice # [ 107.017706] systemd[1]: Starting Find NixOS closure...1228bob # [ 107.002992] systemd-sysroot-fstab-check[277]: Requesting initrd-fs.target/start/replace...1229bob # [ 107.178767] systemd-sysroot-fstab-check[277]: Requesting swap.target/start/replace...1230alice # [ 107.429569] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1231bob # [ 107.441008] systemd[1]: Starting rw-sysroot-nix-store.service...1232bob # [ 107.490120] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1233bob # [ 107.528898] systemd[1]: Finished Mountpoints Configured in the Real Root.1234bob # [ 107.539809] systemd[1]: initrd-parse-etc.service: Consumed 1.228s CPU time over 13.331s wall clock time, 2.1M memory peak.1235bob # [ 107.548901] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1236bob # [ 108.222556] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1237bob # [ 108.246995] systemd[1]: Finished rw-sysroot-nix-store.service.1238bob # [ 108.350657] systemd[1]: Mounting /sysroot/nix/store...1239alice # [ 108.747857] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1240alice # [ 108.796525] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1241alice # [ 109.232972] systemd[1]: Finished Find NixOS closure.1242alice # [ 109.269731] systemd[1]: Reached target Initrd Default Target.1243alice # [ 109.335909] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1244bob # [ 109.341702] systemd[1]: Mounted /sysroot/nix/store.1245bob # [ 109.370543] systemd[1]: Reached target Initrd File Systems.1246bob # [ 109.407874] systemd[1]: Starting Find NixOS closure...1247bob # [ 109.466677] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1248alice # [ 110.124901] systemd[1]: initrd-cleanup.service: Deactivated successfully.1249alice # [ 110.132982] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1250alice # [ 110.163609] systemd[1]: Stopped target Initrd Default Target.1251alice # [ 110.175655] systemd[1]: Stopped target Basic System.1252alice # [ 110.185909] systemd[1]: Stopped target Initrd Root Device.1253alice # [ 110.192774] systemd[1]: Stopped target Path Units.1254alice # [ 110.198836] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1255alice # [ 110.213974] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1256alice # [ 110.224647] systemd[1]: Stopped target Slice Units.1257alice # [ 110.229632] systemd[1]: Stopped target Socket Units.1258alice # [ 110.236910] systemd[1]: Stopped target System Initialization.1259alice # [ 110.243787] systemd[1]: Stopped target Swaps.1260alice # [ 110.249819] systemd[1]: Stopped target Timer Units.1261alice # [ 110.259611] systemd[1]: dbus.socket: Deactivated successfully.1262alice # [ 110.266847] systemd[1]: Closed D-Bus System Message Bus Socket.1263alice # [ 110.274896] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1264alice # [ 110.283150] systemd[1]: Stopped Find NixOS closure.1265alice # [ 110.294428] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1266alice # [ 110.328641] systemd[1]: Starting rw-sysroot-nix-store.service...1267alice # [ 110.338231] systemd[1]: systemd-sysctl.service: Deactivated successfully.1268alice # [ 110.347644] systemd[1]: Stopped Apply Kernel Variables.1269alice # [ 110.373501] systemd[1]: systemd-modules-load.service: Deactivated successfully.1270alice # [ 110.384460] systemd[1]: Stopped Load Kernel Modules.1271alice # [ 110.395717] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1272alice # [ 110.404967] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1273alice # [ 110.412844] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1274alice # [ 110.424868] systemd[1]: Stopped Create System Files and Directories.1275alice # [ 110.436623] systemd[1]: Stopped target Local File Systems.1276alice # [ 110.443497] systemd[1]: Stopped target Preparation for Local File Systems.1277alice # [ 110.451696] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1278alice # [ 110.460731] systemd[1]: Stopped Coldplug All udev Devices.1279alice # [ 110.469911] systemd[1]: systemd-udev-trigger.service: Consumed 4.559s CPU time over 1min 34.399s wall clock time, 3M memory peak.1280alice # [ 110.481665] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1281alice # [ 110.491027] systemd[1]: Stopped Virtual Console Setup.1282alice # [ 110.512976] systemd[1]: systemd-vconsole-setup.service: Consumed 1.073s CPU time over 39.043s wall clock time, 1.9M memory peak.1283bob # [ 110.484671] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1284bob # [ 110.563822] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1285alice # [ 110.985902] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1286alice # [ 111.014603] systemd[1]: Finished rw-sysroot-nix-store.service.1287bob # [ 111.152791] systemd[1]: Finished Find NixOS closure.1288alice # [ 111.261980] systemd[1]: systemd-udevd.service: Deactivated successfully.1289alice # [ 111.278536] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1290alice # [ 111.287493] systemd[1]: systemd-udevd.service: Consumed 42.747s CPU time over 1min 31.669s wall clock time, 22.9M memory peak.1291bob # [ 111.183946] systemd[1]: Reached target Initrd Default Target.1292alice # [ 111.307983] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1293alice # [ 111.321513] systemd[1]: Closed udev Control Socket.1294alice # [ 111.354358] systemd[1]: Starting Cleanup udev Database...1295alice # [ 111.362666] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1296bob # [ 111.254852] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1297alice # [ 111.370872] systemd[1]: Stopped Create Static Device Nodes in /dev.1298alice # [ 111.379827] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1299alice # [ 111.395834] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1300alice # [ 111.412869] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1301alice # [ 111.420916] systemd[1]: Stopped Create List of Static Device Nodes.1302alice # [ 111.756935] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1303alice # [ 111.801924] systemd[1]: Finished Cleanup udev Database.1304alice # [ 111.834656] systemd[1]: Reached target Switch Root.1305alice # [ 111.918296] systemd[1]: Starting NixOS Activation...1306bob # [ 113.144892] systemd[1]: Stopped target Initrd Default Target.1307bob # [ 113.154931] systemd[1]: Stopped target Basic System.1308bob # [ 113.166990] systemd[1]: Stopped target Initrd Root Device.1309bob # [ 113.178617] systemd[1]: Stopped target Path Units.1310bob # [ 113.190508] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1311bob # [ 113.200481] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1312bob # [ 113.211869] systemd[1]: Stopped target Slice Units.1313bob # [ 113.226585] systemd[1]: Stopped target Socket Units.1314bob # [ 113.238963] systemd[1]: Stopped target System Initialization.1315bob # [ 113.250939] systemd[1]: Stopped target Swaps.1316bob # [ 113.259649] systemd[1]: Stopped target Timer Units.1317bob # [ 113.271437] systemd[1]: dbus.socket: Deactivated successfully.1318bob # [ 113.284575] systemd[1]: Closed D-Bus System Message Bus Socket.1319bob # [ 113.297875] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1320bob # [ 113.306929] systemd[1]: Stopped Find NixOS closure.1321bob # [ 113.320404] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1322bob # [ 113.348910] systemd[1]: Starting rw-sysroot-nix-store.service...1323bob # [ 113.363533] systemd[1]: systemd-sysctl.service: Deactivated successfully.1324bob # [ 113.382526] systemd[1]: Stopped Apply Kernel Variables.1325bob # [ 113.392691] systemd[1]: systemd-modules-load.service: Deactivated successfully.1326bob # [ 113.401643] systemd[1]: Stopped Load Kernel Modules.1327bob # [ 113.423733] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1328bob # [ 113.437586] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1329bob # [ 113.452811] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1330bob # [ 113.461945] systemd[1]: Stopped Create System Files and Directories.1331bob # [ 113.477607] systemd[1]: Stopped target Local File Systems.1332bob # [ 113.486687] systemd[1]: Stopped target Preparation for Local File Systems.1333bob # [ 113.496903] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1334bob # [ 113.504783] systemd[1]: Stopped Coldplug All udev Devices.1335bob # [ 113.512520] systemd[1]: systemd-udev-trigger.service: Consumed 6.666s CPU time over 1min 37.310s wall clock time, 3M memory peak.1336bob # [ 113.523671] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1337bob # [ 113.532447] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1338bob # [ 113.542617] systemd[1]: Stopped Virtual Console Setup.1339bob # [ 113.582517] systemd[1]: initrd-cleanup.service: Deactivated successfully.1340bob # [ 113.601934] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1341bob # [ 114.042753] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1342bob # [ 114.057430] systemd[1]: Finished rw-sysroot-nix-store.service.1343bob # [ 114.582892] systemd[1]: systemd-udevd.service: Deactivated successfully.1344bob # [ 114.599788] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1345bob # [ 114.606784] systemd[1]: systemd-udevd.service: Consumed 45.012s CPU time over 1min 35.000s wall clock time, 20.9M memory peak.1346bob # [ 114.640616] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1347bob # [ 114.654973] systemd[1]: Closed udev Control Socket.1348bob # [ 114.703395] systemd[1]: Starting Cleanup udev Database...1349bob # [ 114.716876] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1350bob # [ 114.735149] systemd[1]: Stopped Create Static Device Nodes in /dev.1351bob # [ 114.758973] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1352bob # [ 114.785901] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1353bob # [ 114.807800] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1354bob # [ 114.827842] systemd[1]: Stopped Create List of Static Device Nodes.1355alice # [ 115.266519] initrd-nixos-activation-start[312]: booting system configuration /nix/store/s07la4r24v006hj7wxyzffb5ksqhavky-nixos-system-alice-test1356bob # [ 115.163659] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1357bob # [ 115.179548] systemd[1]: Finished Cleanup udev Database.1358bob # [ 115.205002] systemd[1]: Reached target Switch Root.1359bob # [ 115.233014] systemd[1]: Starting NixOS Activation...1360alice # [ 115.960689] initrd-nixos-activation-start[312]: running activation script...1361bob: Guest root shell did not produce any data yet...1362bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1363bob # [ 117.195998] initrd-nixos-activation-start[331]: booting system configuration /nix/store/3l8qw1fkj6k2snnfdwq4s94r5qyl6amz-nixos-system-bob-test1364bob # [ 117.821539] initrd-nixos-activation-start[331]: running activation script...1365alice # [ 121.029768] initrd-nixos-activation-start[335]: setting up /etc...1366bob # [ 122.396885] initrd-nixos-activation-start[354]: setting up /etc...1367alice # [ 122.726889] initrd-nixos-activation-start[335]: setting up age secrets...1368alice # [ 123.769685] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1369alice # [ 123.777684] systemd[1]: Finished NixOS Activation.1370alice # [ 123.783758] systemd[1]: initrd-nixos-activation.service: Consumed 7.729s CPU time over 11.845s wall clock time, 20M memory peak.1371alice # [ 123.803683] systemd[1]: Starting Switch Root...1372alice # [ 123.975629] systemd[1]: Switching root.1373alice # [ 124.301123] systemd-journald[68]: Received SIGTERM from PID 1 (systemd).1374bob # [ 124.703954] initrd-nixos-activation-start[354]: setting up age secrets...1375alice # [ 125.351665] NET: Registered PF_VSOCK protocol family1376alice # [ 126.058460] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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)1377alice # [ 126.059869] systemd[1]: Detected virtualization qemu.1378alice # [ 126.060904] systemd[1]: Detected architecture x86-64.1379alice # [ 126.062652] systemd[1]: Detected first boot.1380alice # [ 126.096448] systemd[1]: Initializing machine ID from random generator.1381bob # [ 126.442865] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1382bob # [ 126.449703] systemd[1]: Finished NixOS Activation.1383bob # [ 126.455780] systemd[1]: initrd-nixos-activation.service: Consumed 7.754s CPU time over 11.205s wall clock time, 20M memory peak.1384bob # [ 126.478446] systemd[1]: Starting Switch Root...1385bob # [ 126.671525] systemd[1]: Switching root.1386bob # [ 127.042410] systemd-journald[68]: Received SIGTERM from PID 1 (systemd).1387alice # [ 127.777137] systemd[1]: bpf-restrict-fs: LSM BPF program attached1388bob # [ 128.092277] NET: Registered PF_VSOCK protocol family1389bob # [ 128.774586] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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)1390bob # [ 128.776236] systemd[1]: Detected virtualization qemu.1391bob # [ 128.777277] systemd[1]: Detected architecture x86-64.1392bob # [ 128.778838] systemd[1]: Detected first boot.1393bob # [ 128.814211] systemd[1]: Initializing machine ID from random generator.1394alice # [ 129.673922] systemd[1]: Applying preset policy.1395bob # [ 130.657198] systemd[1]: bpf-restrict-fs: LSM BPF program attached1396alice # [ 132.563732] systemd[1]: Populated /etc with preset unit settings.1397bob # [ 132.848561] systemd[1]: Applying preset policy.1398bob # [ 136.174000] systemd[1]: Populated /etc with preset unit settings.1399alice # [ 137.216810] systemd[1]: initrd-switch-root.service: Deactivated successfully.1400alice # [ 137.222147] systemd[1]: Stopped initrd-switch-root.service.1401alice # [ 137.262064] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1402alice # [ 137.277055] systemd[1]: Created slice Slice /system/getty.1403alice # [ 137.289103] systemd[1]: Created slice User and Session Slice.1404alice # [ 137.293943] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1405alice # [ 137.295887] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1406alice # [ 137.297594] systemd[1]: Expecting device /dev/hvc0...1407alice # [ 137.298103] systemd[1]: Expecting device /dev/ttyS0...1408alice # [ 137.298927] systemd[1]: Reached target Local Encrypted Volumes.1409alice # [ 137.300068] systemd[1]: Stopped target initrd-fs.target.1410alice # [ 137.301044] systemd[1]: Stopped target initrd-root-fs.target.1411alice # [ 137.301845] systemd[1]: Stopped target initrd-switch-root.target.1412alice # [ 137.302812] systemd[1]: Reached target Virtual Machines and Containers.1413alice # [ 137.303846] systemd[1]: Reached target Path Units.1414alice # [ 137.304737] systemd[1]: Reached target Remote File Systems.1415alice # [ 137.305757] systemd[1]: Reached target Slice Units.1416alice # [ 137.306889] systemd[1]: Reached target Swaps.1417alice # [ 137.338757] systemd[1]: Listening on Query the User Interactively for a Password.1418alice # [ 137.367777] systemd[1]: Listening on Process Core Dump Socket.1419alice # [ 137.389750] systemd[1]: Listening on Credential Encryption/Decryption.1420alice # [ 137.416630] systemd[1]: Listening on Factory Reset Management.1421alice # [ 137.418843] systemd[1]: Listening on Hostname Service Socket.1422alice # [ 137.457982] systemd[1]: Starting Journal Log Access Socket...1423alice # [ 137.481180] systemd[1]: Listening on Journal Audit Socket.1424alice # [ 137.524452] systemd[1]: Listening on Console Output Muting Service Socket.1425alice # [ 137.528808] systemd[1]: Listening on Network Management Metrics Varlink Socket.1426alice # [ 137.533043] systemd[1]: Listening on Network Management Varlink Socket.1427alice # [ 137.536881] systemd[1]: Listening on Network Management Netlink Socket.1428alice # [ 137.540673] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1429alice # [ 137.545969] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1430alice # [ 137.547819] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1431alice # [ 137.602667] systemd[1]: Listening on Disk Repartitioning Service Socket.1432alice # [ 137.605693] systemd[1]: Listening on Resolve Monitor Varlink Socket.1433alice # [ 137.608845] systemd[1]: Listening on Resolve Service Varlink Socket.1434alice # [ 137.611067] systemd[1]: Listening on udev Control Socket.1435alice # [ 137.614100] systemd[1]: Listening on udev Varlink Socket.1436alice # [ 137.659093] systemd[1]: Mounting Huge Pages File System...1437alice # [ 137.723709] systemd[1]: Mounting POSIX Message Queue File System...1438alice # [ 137.821159] systemd[1]: Mounting Kernel Debug File System...1439alice # [ 137.942808] systemd[1]: Mounting Kernel Trace File System...1440alice # [ 138.097605] systemd[1]: Starting Create List of Static Device Nodes...1441alice # [ 138.116050] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1442alice # [ 138.312641] systemd[1]: Starting Load Kernel Module configfs...1443alice # [ 138.321019] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1444alice # [ 138.341703] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1445alice # [ 138.348133] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1446alice # [ 138.597004] systemd[1]: Mounting FUSE Control File System...1447alice # [ 138.630099] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671448alice # [ 139.488773] systemd[1]: Starting Journal Service...1449alice # [ 139.762160] systemd[1]: Starting Load Kernel Modules...1450alice # [ 140.815853] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1451alice # [ 141.070810] systemd[1]: Starting Remount Root and Kernel File Systems...1452alice # [ 141.088088] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1453bob # [ 141.237519] systemd[1]: initrd-switch-root.service: Deactivated successfully.1454bob # [ 141.247289] systemd[1]: Stopped initrd-switch-root.service.1455bob # [ 141.288141] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1456alice # [ 141.411053] systemd[1]: Starting Coldplug All udev Devices...1457bob # [ 141.307978] systemd[1]: Created slice Slice /system/getty.1458bob # [ 141.319395] systemd[1]: Created slice User and Session Slice.1459bob # [ 141.323900] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1460bob # [ 141.326032] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1461bob # [ 141.327560] systemd[1]: Expecting device /dev/hvc0...1462bob # [ 141.328406] systemd[1]: Expecting device /dev/ttyS0...1463bob # [ 141.329264] systemd[1]: Reached target Local Encrypted Volumes.1464bob # [ 141.330817] systemd[1]: Stopped target initrd-fs.target.1465bob # [ 141.331815] systemd[1]: Stopped target initrd-root-fs.target.1466bob # [ 141.332501] systemd[1]: Stopped target initrd-switch-root.target.1467bob # [ 141.333526] systemd[1]: Reached target Virtual Machines and Containers.1468bob # [ 141.334863] systemd[1]: Reached target Path Units.1469bob # [ 141.335775] systemd[1]: Reached target Remote File Systems.1470bob # [ 141.336425] systemd[1]: Reached target Slice Units.1471bob # [ 141.337251] systemd[1]: Reached target Swaps.1472alice # [ 141.460967] loop: module loaded1473bob # [ 141.376209] systemd[1]: Listening on Query the User Interactively for a Password.1474bob # [ 141.409848] systemd[1]: Listening on Process Core Dump Socket.1475bob # [ 141.433973] systemd[1]: Listening on Credential Encryption/Decryption.1476bob # [ 141.464567] systemd[1]: Listening on Factory Reset Management.1477bob # [ 141.466869] systemd[1]: Listening on Hostname Service Socket.1478bob # [ 141.512374] systemd[1]: Starting Journal Log Access Socket...1479alice # [ 141.646171] systemd-journald[421]: Collecting audit messages is enabled.1480bob # [ 141.541786] systemd[1]: Listening on Journal Audit Socket.1481bob # [ 141.580490] systemd[1]: Listening on Console Output Muting Service Socket.1482bob # [ 141.584772] systemd[1]: Listening on Network Management Metrics Varlink Socket.1483bob # [ 141.589279] systemd[1]: Listening on Network Management Varlink Socket.1484bob # [ 141.593274] systemd[1]: Listening on Network Management Netlink Socket.1485bob # [ 141.598194] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1486bob # [ 141.603436] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1487bob # [ 141.605286] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1488bob # [ 141.675034] systemd[1]: Listening on Disk Repartitioning Service Socket.1489bob # [ 141.678024] systemd[1]: Listening on Resolve Monitor Varlink Socket.1490bob # [ 141.680907] systemd[1]: Listening on Resolve Service Varlink Socket.1491bob # [ 141.683391] systemd[1]: Listening on udev Control Socket.1492bob # [ 141.687010] systemd[1]: Listening on udev Varlink Socket.1493bob # [ 141.737481] systemd[1]: Mounting Huge Pages File System...1494bob # [ 141.820452] systemd[1]: Mounting POSIX Message Queue File System...1495alice # [ 142.037983] systemd[1]: Listening on Journal Log Access Socket.1496bob # [ 141.944519] systemd[1]: Mounting Kernel Debug File System...1497alice # [ 142.099165] systemd[1]: Mounted Huge Pages File System.1498alice # [ 142.135151] systemd[1]: Mounted POSIX Message Queue File System.1499alice # [ 142.163109] systemd[1]: Mounted Kernel Debug File System.1500bob # [ 142.077507] systemd[1]: Mounting Kernel Trace File System...1501alice # [ 142.201415] systemd[1]: Mounted Kernel Trace File System.1502alice # [ 142.281999] systemd[1]: Finished Create List of Static Device Nodes.1503alice # [ 142.311821] systemd[1]: Started Journal Service.1504alice # [ 142.249792] systemd[1]: Queued start job for default target Multi-User System.1505alice # [ 142.312386] systemd[1]: systemd-journald.service: Deactivated successfully.1506bob # [ 142.283557] systemd[1]: Starting Create List of Static Device Nodes...1507bob # [ 142.315899] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio1508alice # [ 142.362821] systemd[1]: systemd-journald.service: Consumed 3.035s CPU time over 2min 1.664s wall clock time, 3.6M memory peak.1509alice # [ 142.446923] systemd-modules-load[422]: Inserted module 'loop'1510alice # [ 142.486618] systemd[1]: modprobe@configfs.service: Deactivated successfully.1511alice # [ 142.606029] EXT4-fs (vda): re-mounted ed25da61-ba25-43d7-aea6-89ad3e92824c.1512alice # [ 142.543483] systemd[1]: Finished Load Kernel Module configfs.1513bob # [ 142.539231] systemd[1]: Starting Load Kernel Module configfs...1514alice # [ 142.589523] systemd[1]: Mounted FUSE Control File System.1515bob # [ 142.548813] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1516bob # [ 142.564150] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1517bob # [ 142.582300] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1518alice # [ 142.625545] systemd[1]: Finished Load Kernel Modules.1519alice # [ 142.868477] systemd[1]: Finished Remount Root and Kernel File Systems.1520bob # [ 142.925109] systemd[1]: Mounting FUSE Control File System...1521bob # [ 142.975877] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671522alice # [ 143.198835] systemd[1]: Listening on Disk Image Download Service Socket.1523alice # [ 143.330801] systemd[1]: Mounting Kernel Configuration File System...1524alice # [ 143.498910] systemd[1]: Starting Firewall...1525bob # [ 143.621333] systemd[1]: Starting Journal Service...1526alice # [ 143.727627] systemd[1]: Starting Flush Journal to Persistent Storage...1527alice # [ 143.739744] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1528bob # [ 144.630273] systemd[1]: Starting Load Kernel Modules...1529alice # [ 144.790783] systemd[1]: Starting Load/Save OS Random Seed...1530alice # [ 145.611645] hrtimer: interrupt took 12440966 ns1531alice # [ 145.951785] systemd[1]: Starting Apply Kernel Variables...1532bob # [ 146.614280] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1533alice # [ 146.804685] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1534alice # [ 146.850853] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1535bob # [ 146.950610] systemd[1]: Starting Remount Root and Kernel File Systems...1536bob # [ 146.966525] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1537bob: Guest root shell did not produce any data yet...1538bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1539alice # [ 147.487625] systemd-journald[421]: Received client request to flush runtime journal.1540bob # [ 147.581124] systemd[1]: Starting Coldplug All udev Devices...1541bob # [ 147.785560] loop: module loaded1542bob # [ 147.969248] systemd-journald[448]: Collecting audit messages is enabled.1543bob # [ 148.635501] systemd[1]: Listening on Journal Log Access Socket.1544bob # [ 148.679562] systemd[1]: Mounted Huge Pages File System.1545bob # [ 148.732431] systemd[1]: Mounted POSIX Message Queue File System.1546bob # [ 148.770472] systemd[1]: Mounted Kernel Debug File System.1547bob # [ 148.819969] systemd[1]: Mounted Kernel Trace File System.1548bob # [ 148.927542] systemd[1]: Finished Create List of Static Device Nodes.1549bob # [ 149.014213] systemd[1]: modprobe@configfs.service: Deactivated successfully.1550bob # [ 149.035789] EXT4-fs (vda): re-mounted 021fd8e5-add2-4c91-8acf-dff17a382e3f.1551bob # [ 149.079578] systemd[1]: Finished Load Kernel Module configfs.1552bob # [ 149.238531] systemd[1]: Started Journal Service.1553bob # [ 149.177691] systemd[1]: Queued start job for default target Multi-User System.1554bob # [ 149.254836] systemd[1]: systemd-journald.service: Deactivated successfully.1555bob # [ 149.324973] systemd[1]: systemd-journald.service: Consumed 3.244s CPU time over 2min 5.444s wall clock time, 3.6M memory peak.1556bob # [ 149.402654] systemd-modules-load[449]: Inserted module 'loop'1557bob # [ 149.445686] systemd[1]: Mounted FUSE Control File System.1558bob # [ 149.491854] systemd[1]: Finished Load Kernel Modules.1559bob # [ 149.535706] systemd[1]: Finished Remount Root and Kernel File Systems.1560bob # [ 150.166711] systemd[1]: Listening on Disk Image Download Service Socket.1561bob # [ 150.277835] systemd[1]: Mounting Kernel Configuration File System...1562bob # [ 150.551938] systemd[1]: Starting Firewall...1563alice # [ 150.999464] systemd-oomd[424]: No swap; memory pressure usage will be degraded1564alice # [ 151.123778] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1565alice # [ 151.207847] systemd[1]: Mounted Kernel Configuration File System.1566alice # [ 151.258881] systemd[1]: Finished Load/Save OS Random Seed.1567alice # [ 151.277973] systemd[1]: Reached target First Boot Complete.1568alice # [ 151.302829] systemd[1]: Finished Apply Kernel Variables.1569alice # [ 151.329627] systemd[1]: Finished Flush Journal to Persistent Storage.1570bob # [ 151.519363] systemd[1]: Starting Flush Journal to Persistent Storage...1571bob # [ 151.602997] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1572alice # [ 151.739518] systemd[1]: Starting Network Name Resolution...1573alice # [ 152.691322] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1574bob # [ 152.911653] systemd[1]: Starting Load/Save OS Random Seed...1575alice # [ 153.050878] systemd[1]: Starting Create Static Device Nodes in /dev...1576bob # [ 153.486469] systemd-oomd[451]: No swap; memory pressure usage will be degraded1577bob # [ 153.663985] systemd[1]: Starting Apply Kernel Variables...1578bob # [ 154.792352] systemd-journald[448]: Received client request to flush runtime journal.1579alice # [ 156.320029] systemd[1]: Finished Create Static Device Nodes in /dev.1580alice # [ 156.441995] systemd[1]: Reached target Preparation for Local File Systems.1581alice # [ 156.653606] systemd[1]: Mounting /run/wrappers...1582alice # [ 157.134832] systemd[1]: Starting Rule-based Manager for Device Events and Files...1583bob # [ 158.724905] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1584bob # [ 158.775995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1585bob # [ 158.836606] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1586bob # [ 158.908861] systemd[1]: Mounted Kernel Configuration File System.1587bob # [ 158.955969] systemd[1]: Finished Load/Save OS Random Seed.1588bob # [ 158.983707] systemd[1]: Reached target First Boot Complete.1589bob # [ 159.013776] systemd[1]: Finished Flush Journal to Persistent Storage.1590alice # [ 159.394856] systemd[1]: Mounted /run/wrappers.1591alice # [ 159.448766] systemd[1]: Reached target Local File Systems.1592bob # [ 159.358479] systemd[1]: Finished Apply Kernel Variables.1593alice # [ 159.684722] systemd[1]: Listening on Boot Loader Control Service Socket.1594alice # [ 159.820622] systemd-resolved[456]: Positive Trust Anchors:1595alice # [ 159.852815] systemd-resolved[456]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1596alice # [ 159.886517] systemd-resolved[456]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161597bob # [ 159.798710] systemd[1]: Starting Network Name Resolution...1598alice # [ 159.916472] systemd-resolved[456]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1599alice # [ 160.541265] systemd[1]: Starting register-nix-paths.service...1600alice # [ 160.553757] systemd[1]: Starting Create SUID/SGID Wrappers...1601alice # [ 160.582576] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1602bob # [ 160.594622] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1603alice # [ 161.056821] systemd[1]: Starting Save Transient machine-id to Disk...1604bob # [ 160.986615] systemd[1]: Starting Create Static Device Nodes in /dev...1605alice # [ 161.769741] systemd[1]: Starting Create System Files and Directories...1606bob # [ 163.062823] systemd[1]: Finished Create Static Device Nodes in /dev.1607bob # [ 163.147637] systemd[1]: Reached target Preparation for Local File Systems.1608bob # [ 163.322521] systemd[1]: Mounting /run/wrappers...1609bob # [ 163.646522] systemd[1]: Starting Rule-based Manager for Device Events and Files...1610alice # [ 164.545846] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1611alice # [ 164.695359] systemd[1]: Finished Save Transient machine-id to Disk.1612bob # [ 165.308868] systemd-resolved[482]: Positive Trust Anchors:1613bob # [ 165.348782] systemd-resolved[482]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1614alice # [ 165.468776] systemd-udevd[477]: Using default interface naming scheme 'v261'.1615bob # [ 165.367655] systemd-resolved[482]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161616bob # [ 165.387452] systemd-resolved[482]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1617bob # [ 166.255623] systemd[1]: Mounted /run/wrappers.1618bob # [ 166.280024] systemd[1]: Reached target Local File Systems.1619bob # [ 166.319810] systemd[1]: Listening on Boot Loader Control Service Socket.1620bob # [ 166.349998] systemd[1]: Starting register-nix-paths.service...1621bob # [ 166.669002] systemd[1]: Starting Create SUID/SGID Wrappers...1622bob # [ 166.702700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1623bob # [ 167.317699] systemd[1]: Starting Save Transient machine-id to Disk...1624bob # [ 167.885577] systemd[1]: Starting Create System Files and Directories...1625alice # [ 169.686851] systemd[1]: Finished Create System Files and Directories.1626alice # [ 170.203942] systemd[1]: Starting Rebuild Journal Catalog...1627alice # [ 170.699892] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1628bob # [ 171.003542] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1629bob # [ 171.113790] systemd[1]: Finished Save Transient machine-id to Disk.1630bob # [ 171.893545] systemd-udevd[504]: Using default interface naming scheme 'v261'.1631bob # [ 173.994943] systemd[1]: Finished Create System Files and Directories.1632alice # [ 174.284794] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1633bob # [ 174.426000] systemd[1]: Starting Rebuild Journal Catalog...1634alice # [ 174.528942] systemd[1]: Started Rule-based Manager for Device Events and Files.1635alice # [ 175.020479] systemd-resolved[456]: Using system hostname 'alice'.1636bob # [ 174.927006] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1637alice # [ 175.710813] systemd[1]: Started Network Name Resolution.1638alice # [ 176.727760] systemd[1]: Finished Rebuild Journal Catalog.1639alice # [ 176.953826] systemd[1]: Starting Update is Completed...1640bob: Guest root shell did not produce any data yet...1641bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1642bob # [ 177.979532] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1643bob # [ 178.282589] systemd-resolved[482]: Using system hostname 'bob'.1644bob # [ 178.307780] systemd[1]: Started Rule-based Manager for Device Events and Files.1645alice # [ 178.726897] systemd[1]: Finished Update is Completed.1646bob # [ 178.873585] systemd[1]: Started Network Name Resolution.1647bob # [ 180.056578] systemd[1]: Finished Rebuild Journal Catalog.1648bob # [ 180.302646] systemd[1]: Starting Update is Completed...1649bob # [ 182.505983] systemd[1]: Finished Update is Completed.1650alice # [ 183.315997] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1651alice # [ 183.359610] systemd[1]: Finished Create SUID/SGID Wrappers.1652alice # [ 183.389389] systemd[1]: suid-sgid-wrappers.service: Consumed 2.537s CPU time over 22.841s wall clock time, 2.9M memory peak.1653alice # [ 183.559851] systemd[1]: Finished Coldplug All udev Devices.1654bob # [ 185.888945] systemd[1]: Finished Coldplug All udev Devices.1655bob # [ 187.925783] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1656bob # [ 187.950727] systemd[1]: Finished Create SUID/SGID Wrappers.1657bob # [ 187.969420] systemd[1]: suid-sgid-wrappers.service: Consumed 2.488s CPU time over 21.316s wall clock time, 2.9M memory peak.1658alice # [ 189.486561] systemd[1]: Finished Firewall.1659alice # [ 189.505553] systemd[1]: Reached target Preparation for Network.1660alice # [ 189.517842] systemd[1]: Listening on Network Management Resolve Hook Socket.1661alice # [ 189.674579] systemd[1]: Starting Network Management...1662alice # [ 192.119933] systemd[1]: Finished register-nix-paths.service.1663alice # [ 192.135701] systemd[1]: Reached target System Initialization.1664alice # [ 192.186625] systemd[1]: Started Discard unused filesystem blocks once a week.1665alice # [ 192.197463] systemd[1]: Started Daily Cleanup of Temporary Directories.1666alice # [ 192.213551] systemd[1]: Reached target Timer Units.1667alice # [ 192.234548] systemd[1]: Listening on D-Bus System Message Bus Socket.1668alice # [ 192.246854] systemd[1]: Listening on Nix Daemon Socket.1669alice # [ 192.264508] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1670alice # [ 192.276236] systemd[1]: Reached target Socket Units.1671alice # [ 192.287779] systemd[1]: Reached target Basic System.1672alice # [ 192.369843] systemd[1]: Starting Import lastlog data into lastlog2 database...1673alice # [ 192.564634] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1674bob # [ 192.623786] systemd[1]: Finished Firewall.1675bob # [ 192.641634] systemd[1]: Reached target Preparation for Network.1676bob # [ 192.652523] systemd[1]: Listening on Network Management Resolve Hook Socket.1677alice # [ 192.790605] systemd[1]: Starting Post-Boot Actions...1678bob # [ 192.771504] systemd[1]: Starting Network Management...1679alice # [ 193.123696] systemd[1]: Started Reset console on configuration changes.1680alice # [ 194.211536] systemd[1]: Starting D-Bus System Message Bus...1681bob # [ 194.183860] systemd[1]: Finished register-nix-paths.service.1682bob # [ 194.202643] systemd[1]: Reached target System Initialization.1683bob # [ 194.233665] systemd[1]: Started Discard unused filesystem blocks once a week.1684bob # [ 194.240564] systemd[1]: Started Daily Cleanup of Temporary Directories.1685bob # [ 194.251353] systemd[1]: Reached target Timer Units.1686bob # [ 194.263638] systemd[1]: Listening on D-Bus System Message Bus Socket.1687bob # [ 194.326576] systemd[1]: Listening on harmonia binary cache socket.1688bob # [ 194.338469] systemd[1]: Listening on Nix Daemon Socket.1689bob # [ 194.348719] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1690bob # [ 194.354804] systemd[1]: Reached target Socket Units.1691bob # [ 194.364815] systemd[1]: Reached target Basic System.1692bob # [ 194.403492] systemd[1]: Starting Import lastlog data into lastlog2 database...1693bob # [ 194.527823] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1694alice # [ 194.678242] systemd[1]: Finished Post-Boot Actions.1695bob # [ 194.746665] systemd[1]: Starting Post-Boot Actions...1696bob # [ 195.010494] systemd[1]: Started Reset console on configuration changes.1697alice # [ 195.160556] systemd[1]: Finished Import lastlog data into lastlog2 database.1698alice # [ 195.291297] nsncd[644]: Sep 04 13:19:34.883 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1699alice # [ 195.347979] systemd[1]: Started Name Service Cache Daemon (nsncd).1700alice # [ 195.366589] systemd[1]: Reached target Host and Network Name Lookups.1701alice # [ 195.400457] systemd[1]: Reached target User and Group Name Lookups.1702alice # [ 195.587463] systemd[1]: Starting User Login Management...1703alice # [ 196.114751] cfg80211: Loading compiled-in X.509 certificates for regulatory database1704bob # [ 195.973659] systemd[1]: Starting D-Bus System Message Bus...1705bob # [ 196.370350] systemd[1]: Finished Post-Boot Actions.1706alice # [ 196.590731] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1707alice # [ 196.598483] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1708alice # [ 196.631878] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21709alice # [ 196.632843] cfg80211: failed to load regulatory.db1710alice # [ 197.139001] dbus-broker-launch[660]: Looking up NSS user entry for 'systemd-timesync'...1711bob # [ 197.277788] systemd[1]: Finished Import lastlog data into lastlog2 database.1712alice # [ 197.614693] dbus-broker-launch[660]: NSS returned no entry for 'systemd-timesync'1713alice # [ 197.624842] dbus-broker-launch[660]: Invalid user-name in /nix/store/kmk5g4n47739mq4lgm6vwlh2zk60655c-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1714bob # [ 197.770003] nsncd[673]: Sep 04 13:19:37.335 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1715alice # [ 197.892754] systemd-networkd[639]: lo: Link UP1716bob # [ 197.795622] systemd[1]: Started Name Service Cache Daemon (nsncd).1717bob # [ 197.802958] systemd[1]: Reached target Host and Network Name Lookups.1718alice # [ 197.918495] systemd-networkd[639]: lo: Gained carrier1719bob # [ 197.822705] systemd[1]: Reached target User and Group Name Lookups.1720alice # [ 198.067509] systemd[1]: Started D-Bus System Message Bus.1721bob # [ 198.039786] systemd[1]: Starting User Login Management...1722alice # [ 198.231922] systemd[1]: Started Network Management.1723alice # [ 198.271675] systemd[1]: Reached target Network.1724alice # [ 198.379614] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1725alice # [ 198.530623] systemd[1]: Starting Permit User Sessions...1726bob # [ 198.834002] dbus-broker-launch[680]: Looking up NSS user entry for 'systemd-timesync'...1727bob # [ 199.272673] dbus-broker-launch[680]: NSS returned no entry for 'systemd-timesync'1728bob # [ 199.280837] dbus-broker-launch[680]: Invalid user-name in /nix/store/ca81in7r9m2d4x1k833hda3wxd6svxyk-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1729alice # [ 199.593016] dbus-broker-launch[660]: Ready1730bob # [ 199.616853] systemd[1]: Started D-Bus System Message Bus.1731bob # [ 199.774385] cfg80211: Loading compiled-in X.509 certificates for regulatory database1732alice # [ 199.970444] systemd-logind[675]: New seat seat0.1733alice # [ 200.034544] systemd[1]: Finished Permit User Sessions.1734alice # [ 200.073586] systemd[1]: Started User Login Management.1735alice # [ 200.101607] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1736bob # [ 200.206309] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1737bob # [ 200.216513] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1738bob # [ 200.250057] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21739alice # [ 200.297919] systemd[1]: Started Getty on tty1.1740bob # [ 200.255007] cfg80211: failed to load regulatory.db1741alice # [ 200.338567] systemd[1]: Reached target Login Prompts.1742alice # [ 200.479475] systemd[1]: Starting linger-users.service...1743alice # [ 201.127966] systemd[1]: linger-users.service: Deactivated successfully.1744alice # [ 201.144580] systemd[1]: Finished linger-users.service.1745bob # [ 201.156512] dbus-broker-launch[680]: Ready1746bob # [ 201.596869] systemd-networkd[668]: lo: Link UP1747bob # [ 201.612579] systemd-networkd[668]: lo: Gained carrier1748bob # [ 201.863790] systemd[1]: Started Network Management.1749bob # [ 201.929426] systemd[1]: Reached target Network.1750bob # [ 201.963468] systemd-logind[694]: New seat seat0.1751bob # [ 202.056533] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1752bob # [ 202.167657] systemd[1]: Starting Permit User Sessions...1753bob # [ 202.258769] systemd[1]: Started User Login Management.1754bob # [ 202.489204] systemd[1]: Starting linger-users.service...1755alice # [ 202.807900] hid: raw HID events driver (C) Jiri Kosina1756bob # [ 203.024562] systemd[1]: Finished Permit User Sessions.1757bob # [ 203.184807] systemd[1]: Started Getty on tty1.1758alice # [ 203.389574] usbcore: registered new interface driver usbhid1759alice # [ 203.389819] usbhid: USB HID core driver1760bob # [ 203.230643] systemd[1]: Reached target Login Prompts.1761bob # [ 203.321981] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1762alice # [ 203.531028] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1763alice # [ 203.569744] cdrom: Uniform CD-ROM driver Revision: 3.201764bob # [ 203.414598] systemd[1]: linger-users.service: Deactivated successfully.1765bob # [ 203.424980] systemd[1]: Finished linger-users.service.1766alice # [ 205.103600] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1767bob # [ 205.214742] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1768bob # [ 205.233166] cdrom: Uniform CD-ROM driver Revision: 3.201769bob # [ 206.730877] hid: raw HID events driver (C) Jiri Kosina1770alice # [ 206.957569] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1771bob # [ 207.099873] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1772bob: Guest root shell did not produce any data yet...1773bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1774bob # [ 207.274523] usbcore: registered new interface driver usbhid1775bob # [ 207.281884] usbhid: USB HID core driver1776alice # [ 207.332703] (udev-worker)[720]: Network interface NamePolicy= disabled on kernel command line.1777alice # [ 207.646316] systemd-networkd[639]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.1778alice # [ 207.797549] systemd-networkd[639]: eth0: Link UP1779alice # [ 207.838587] systemd-networkd[639]: eth0: Gained carrier1780alice # [ 208.133821] NET: Registered PF_PACKET protocol family1781alice # [ 208.284597] systemd-networkd[639]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.21782alice # [ 209.221971] systemd-networkd[639]: eth0: Gained IPv6LL1783alice # [ 209.497645] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1784alice # [ 209.571618] systemd[1]: Started backdoor.service.1785alice # [ 209.623520] systemd[1]: Reached target Multi-User System.1786alice # [ 209.645779] systemd[1]: Startup finished in 7.907s (kernel) + 1min 56.978s (initrd) + 1min 24.759s (userspace) = 3min 29.644s.1787bob # [ 209.564482] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1788alice # [ 209.912786] (udev-worker)[728]: Network interface NamePolicy= disabled on kernel command line.1789bob # [ 210.227664] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.1790bob # [ 210.312324] systemd[1]: Started backdoor.service.1791bob # [ 210.349598] systemd[1]: Reached target Multi-User System.1792bob # [ 210.368501] systemd[1]: Startup finished in 7.887s (kernel) + 1min 59.725s (initrd) + 1min 22.753s (userspace) = 3min 30.366s.1793alice # [ 210.527491] systemd-networkd[639]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1794alice # [ 210.529833] systemd-networkd[639]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1795alice # connecting to host...1796alice # [ 210.847449] systemd-networkd[639]: eth1: Link UP1797alice # [ 210.868886] systemd-networkd[639]: eth1: Gained carrier1798alice # [ 210.874746] systemd-networkd[639]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1799bob # [ 211.121345] (udev-worker)[748]: Network interface NamePolicy= disabled on kernel command line.1800bob # [ 211.184476] (udev-worker)[752]: Network interface NamePolicy= disabled on kernel command line.1801bob # connecting to host...1802bob: Guest shell says: b'Spawning backdoor root shell...\n'1803bob: connected to guest root shell1804bob: (connecting took 214.61 seconds)1805bob: (finished: waiting for the VM to finish booting, in 214.61 seconds)1806bob # [ 211.922417] systemd-networkd[668]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.1807bob # [ 212.177217] systemd-networkd[668]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1808bob # [ 212.188516] systemd-networkd[668]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1809bob # [ 212.277347] systemd-networkd[668]: eth0: Link UP1810bob # [ 212.321792] systemd-networkd[668]: eth0: Gained carrier1811alice # [ 212.543911] systemd-networkd[639]: eth1: Gained IPv6LL1812bob # [ 212.682249] NET: Registered PF_PACKET protocol family1813bob # [ 212.696916] systemd-networkd[668]: eth1: Link UP1814bob # [ 212.738563] systemd-networkd[668]: eth1: Gained carrier1815bob # [ 212.744929] systemd-networkd[668]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1816bob # [ 213.076976] systemd-networkd[668]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.21817bob # [ 213.605451] systemd-networkd[668]: eth1: Gained IPv6LL1818bob # [ 213.793547] systemd-networkd[668]: eth0: Gained IPv6LL1819bob # % Total % Received % Xferd Average Speed Time Time Time Current1820bob # Dload Upload Total Spent Left Speed1821bob # 0 0 0 0 0 0 0 0 0[ 214.299187] systemd[1]: Starting harmonia binary cache service...1822alice # [ 215.640065] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input21823alice # [ 215.677061] ACPI: button: Power Button [PWRF]1824alice # [ 215.806672] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1825alice # [ 215.822570] Console: switching to colour dummy device 80x251826alice # [ 215.837990] [drm] Found bochs VGA, ID 0xb0c5.1827alice # [ 215.840413] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1828alice # [ 215.860670] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1829alice # [ 215.860929] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01830alice # [ 216.266483] Console: switching to colour frame buffer device 160x501831alice # [ 216.289963] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1832bob # 0 0 0 0 0 0 0 0 00:01 0 0 0 0 0 0 0 0 0 00:02 0[ 217.120685] harmonia-cache[779]: 2026-09-04T13:19:56.764068Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))1833bob # [ 217.134583] harmonia-cache[779]: 2026-09-04T13:19:56.790146Z INFO actix_server::builder: starting 4 workers1834bob # [ 217.143496] harmonia-cache[779]: 2026-09-04T13:19:56.809837Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s1835bob # [ 217.173663] systemd[1]: Started harmonia binary cache service.1836bob # [ 217.187468] harmonia-cache[779]: 2026-09-04T13:19:56.842008Z INFO actix_server::server: Actix runtime found; starting in Actix runtime1837bob # [ 217.190012] harmonia-cache[779]: 2026-09-04T13:19:56.853460Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50001838bob # 0 0 0 0 0 0 0 0 00:03 0100 51 100 51 0 0 12 0 00:04 00:04 14100 51 100 51 0 0 12 0 00:04 00:04 14100 51 100 51 0 0 12 0 00:04 00:04 141839bob: (finished: waiting for success: curl bob:5000/nix-cache-info, in 220.93 seconds)1840bob: waiting for unit harmonia1841alice # [ 218.108665] rtc_cmos 00:04: RTC can wake from S41842alice # [ 218.191450] rtc_cmos 00:04: registered as rtc01843alice # [ 218.212822] rtc_cmos 00:04: setting system clock to 2026-09-04T13:19:59 UTC (1788527999)1844alice # [ 218.164575] systemd-resolved[456]: Clock change detected. Flushing caches.1845alice # [ 218.261122] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1846alice # [ 218.305919] parport_pc 00:02: reported by Plug and Play ACPI1847alice # [ 218.312525] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1848alice # [ 218.861891] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1849alice # [ 218.932827] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input31850bob: (finished: waiting for unit harmonia, in 0.99 seconds)1851bob: must succeed: systemctl status harmonia1852alice # [ 219.069019] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1853alice # [ 219.081973] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1854bob: (finished: must succeed: systemctl status harmonia, in 0.73 seconds)1855alice: waiting for success: curl bob:5000/nix-cache-info1856alice: waiting for the VM to finish booting1857alice: Guest shell says: b'Spawning backdoor root shell...\n'1858alice: connected to guest root shell1859alice: (connecting took 0.00 seconds)1860alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)1861alice # % Total % Received % Xferd Average Speed Time Time Time Current1862alice # Dload Upload Total Spent Left Speed1863alice # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 97 0 0100 51 100 51 0 0 96 0 0100 51 100 51 0 0 95 0 01864alice: (finished: waiting for success: curl bob:5000/nix-cache-info, in 1.70 seconds)1865bob: must succeed: nix-build --expr '1866 builtins.derivation {1867 name = "hi";1868 builder = "/bin/sh";1869 args = [ "-c" "echo hi > $out" ];1870 system = "x86_64-linux";1871 }1872' 2>&118731874alice # [ 222.827346] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input41875bob # [ 223.721535] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input21876bob # [ 223.791459] ACPI: button: Power Button [PWRF]1877bob # [ 223.879418] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1878bob # [ 223.909117] Console: switching to colour dummy device 80x251879bob # [ 223.887633] systemd-resolved[482]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.1880bob # [ 223.964902] [drm] Found bochs VGA, ID 0xb0c5.1881bob # [ 223.965133] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1882bob # [ 223.931558] systemd-resolved[482]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.1883bob # [ 223.955844] systemd-resolved[482]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.1884bob # [ 224.047585] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1885bob # [ 224.048060] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01886bob # [ 224.304304] Console: switching to colour frame buffer device 160x501887bob # [ 224.332936] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1888alice # [ 225.255250] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1889alice # [ 225.598414] systemd[1]: Starting Virtual Console Setup...1890bob # [ 226.158420] rtc_cmos 00:04: RTC can wake from S41891bob # [ 226.214439] rtc_cmos 00:04: registered as rtc01892bob # [ 226.209635] systemd-resolved[482]: Clock change detected. Flushing caches.1893bob # [ 226.271098] rtc_cmos 00:04: setting system clock to 2026-09-04T13:20:07 UTC (1788528007)1894bob # [ 226.298276] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1895bob # [ 226.352148] parport_pc 00:02: reported by Plug and Play ACPI1896bob # [ 226.359769] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1897bob # [ 226.793858] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input31898alice # [ 226.980483] kvm_amd: Nested Virtualization enabled1899alice # [ 226.981055] kvm_amd: Nested Paging enabled1900alice # [ 226.988333] kvm_amd: Virtual GIF supported1901alice # [ 226.988643] kvm_amd: PMU virtualization is disabled1902bob # [ 227.898182] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1903bob # [ 228.698983] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1904bob # [ 228.715913] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1905alice # [ 230.293522] systemd-vconsole-setup[801]: Configuration of first virtual console was skipped, ignoring remaining ones.1906alice # [ 230.481531] systemd[1]: Finished Virtual Console Setup.1907bob # [ 230.764431] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input41908bob: (finished: must succeed: nix-build --expr '1909 builtins.derivation {1910 name = "hi";1911 builder = "/bin/sh";1912 args = [ "-c" "echo hi > $out" ];1913 system = "x86_64-linux";1914 }1915' 2>&11916, in 9.58 seconds)1917alice: must succeed: nix-build --expr '1918 builtins.derivation {1919 name = "hi";1920 builder = "/bin/sh";1921 args = [ "-c" "echo hi > $out" ];1922 system = "x86_64-linux";1923 }1924' 2>&119251926bob # [ 232.956404] systemd[1]: Starting Virtual Console Setup...1927alice # [ 235.265119] 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/input51928alice # [ 235.304715] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01929alice # [ 235.617550] systemd-logind[675]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1930alice # [ 235.695616] systemd-resolved[456]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.1931alice # [ 235.734341] systemd-resolved[456]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.1932alice # [ 235.768647] systemd-resolved[456]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.1933bob # [ 236.215784] systemd-vconsole-setup[873]: Configuration of first virtual console was skipped, ignoring remaining ones.1934bob # [ 236.276872] systemd[1]: Finished Virtual Console Setup.1935bob # [ 237.139128] kvm_amd: Nested Virtualization enabled1936bob # [ 237.144909] kvm_amd: Nested Paging enabled1937bob # [ 237.151446] kvm_amd: Virtual GIF supported1938bob # [ 237.154184] kvm_amd: PMU virtualization is disabled1939alice # [ 237.633830] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1940alice # [ 237.651547] systemd[1]: Stopped Virtual Console Setup.1941alice # [ 237.666737] systemd[1]: systemd-vconsole-setup.service: Consumed 1.382s CPU time over 12.050s wall clock time, 2.2M memory peak.1942alice # [ 237.677535] systemd[1]: Stopping Virtual Console Setup...1943alice # [ 237.729785] systemd-logind[675]: Watching system buttons on /dev/input/event1 (Power Button)1944alice # [ 237.966877] systemd[1]: Starting Virtual Console Setup...1945alice # [ 238.269918] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1946alice # [ 238.285973] systemd[1]: Stopped Virtual Console Setup.1947alice # [ 238.467546] systemd[1]: Starting Virtual Console Setup...1948bob # [ 238.637486] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1949bob # [ 239.582982] systemd-logind[694]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1950bob # [ 239.719150] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input51951bob # [ 239.754956] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input01952alice # [ 241.382558] systemd-vconsole-setup[849]: Configuration of first virtual console was skipped, ignoring remaining ones.1953alice # [ 241.491521] ppdev: user-space parallel port driver1954alice # [ 241.460598] systemd[1]: Finished Virtual Console Setup.1955alice: (finished: must succeed: nix-build --expr '1956 builtins.derivation {1957 name = "hi";1958 builder = "/bin/sh";1959 args = [ "-c" "echo hi > $out" ];1960 system = "x86_64-linux";1961 }1962' 2>&11963, in 11.29 seconds)1964(finished: run the VM test script, in 246.11 seconds)1965bob # [ 242.327593] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1966bob # [ 242.351540] systemd[1]: Stopped Virtual Console Setup.1967bob # [ 242.380460] systemd[1]: Stopping Virtual Console Setup...1968bob # [ 242.409591] systemd-logind[694]: Watching system buttons on /dev/input/event1 (Power Button)1969bob # [ 242.644849] systemd[1]: Starting Virtual Console Setup...1970bob # [ 243.116001] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1971bob # [ 243.171659] systemd[1]: Stopped Virtual Console Setup.1972bob # [ 243.428876] systemd[1]: Starting Virtual Console Setup...1973alice # [ 243.899291] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1974alice # [ 243.941369] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1975alice # [ 244.265564] mousedev: PS/2 mouse device common for all mice1976test script finished in 248.12s1977cleanup1978kill QemuMachine (pid 46)1979alice # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1980kill QemuMachine (pid 48)1981bob # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1982(finished: cleanup, in 0.24 seconds)