vm-test-run-harmonia
checks.x86_64-linux.harmonia
· build #3
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 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 vm13bob # Disk image does not exist, creating the virtualisation disk image...14bob: QEMU running (pid 48)15bob # Formatting '/build/vm-state-bob/tmp.z5s3d6JSKI', fmt=raw size=107374182416bob # mke2fs 1.47.4 (6-Mar-2025)17bob # Discarding device blocks: 0/262144 done18bob # Creating filesystem with 262144 4k blocks and 65536 inodes19bob # Filesystem UUID: bf4151ed-ddcc-484b-a344-da467ef50d4f20bob # Superblock backups stored on blocks:21bob # 32768, 98304, 163840, 22937622bob # 23bob # Allocating group tables: 0/8 done24bob # Writing inode tables: 0/8 done25bob # Creating journal (8192 blocks): done26bob # Writing superblocks and filesystem accounting information: 0/8 done27bob # 28bob # Virtualisation disk image created.29bob # Starting virtiofs daemons...30bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32bob # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...33bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35bob # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...36bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)37bob # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether38bob # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...39bob # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests40bob # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests41bob # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests42bob # qemu-system-x86_64: Could not access KVM kernel module: No such file or directory43bob # qemu-system-x86_64: failed to initialize kvm: No such file or directory44bob # qemu-system-x86_64: falling back to tcg45alice # Disk image does not exist, creating the virtualisation disk image...46alice: QEMU running (pid 47)47alice # Formatting '/build/vm-state-alice/tmp.yDxuKJqje0', fmt=raw size=107374182448alice # mke2fs 1.47.4 (6-Mar-2025)49alice # Discarding device blocks: 0/262144 done50alice # Creating filesystem with 262144 4k blocks and 65536 inodes51(finished: start all VMs, in 0.22 seconds)52alice # Filesystem UUID: 97b8a4f6-291d-4747-878d-587587bb26a753bob: waiting for success: curl bob:5000/nix-cache-info54alice # Superblock backups stored on blocks:55bob: waiting for the VM to finish booting56alice # 32768, 98304, 163840, 22937657alice # 58alice # Allocating group tables: 0/8 done59alice # Writing inode tables: 0/8 done60alice # Creating journal (8192 blocks): done61alice # Writing superblocks and filesystem accounting information: 0/8 done62alice # 63alice # Virtualisation disk image created.64alice # Starting virtiofs daemons...65alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)66alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether67alice # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...68alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)69alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether70alice # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...71alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)72alice # [2026-09-22T17:55:34Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether73alice # [2026-09-22T17:55:34Z INFO virtiofsd] Waiting for vhost-user socket connection...74alice # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests75alice # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests76alice # [2026-09-22T17:55:34Z INFO virtiofsd] Client connected, servicing requests77alice # qemu-system-x86_64: Could not access KVM kernel module: No such file or directory78alice # qemu-system-x86_64: failed to initialize kvm: No such file or directory79alice # qemu-system-x86_64: falling back to tcg80bob # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)81alice # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)82bob # 83bob # 84bob # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC750+3EF2C750 CA0085alice # 86alice # 87bob # Press Ctrl-B to configure iPXE (PCI 00:02.0)...88bob # 89bob # 90bob # 91bob # 92alice # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC750+3EF2C750 CA0093bob # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC750 3EF2C750 CB0094alice # Press Ctrl-B to configure iPXE (PCI 00:02.0)...95alice # 96alice # 97alice # 98alice # 99alice # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC750 3EF2C750 CB00100bob # Press Ctrl-B to configure iPXE (PCI 00:05.0)...101bob # 102bob # 103alice # Press Ctrl-B to configure iPXE (PCI 00:05.0)...104alice # 105alice # 106bob # Booting from ROM...107alice # Booting from ROM...108bob # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 14 11:36:19 UTC 2026109bob # [ 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/p8hwydl4ilpb66vfs3pdc12192v1qv90-nixos-system-bob-test/init regInfo=/nix/.ro-store/j7hg3r4lmk2jfr15d55rq2jc2sjizg7d-closure-info/registration console=ttyS0,115200n8 console=tty0110bob # [ 0.000000] BIOS-provided physical RAM map:111bob # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable112bob # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved113bob # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved114bob # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable115bob # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved116bob # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved117bob # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved118bob # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved119bob # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved120bob # [ 0.000000] NX (Execute Disable) protection: active121bob # [ 0.000000] APIC: Static calls initialized122bob # [ 0.000000] SMBIOS 2.8 present.123bob # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014124bob # [ 0.000000] DMI: Memory slots populated: 1/1125bob # [ 0.000000] tsc: Fast TSC calibration using PIT126bob # [ 0.000000] tsc: Detected 3593.156 MHz processor127bob # [ 0.017492] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000128bob # [ 0.018316] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs129bob # [ 0.018522] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT130bob # [ 0.044165] found SMP MP-table at [mem 0x000f5450-0x000f545f]131bob # [ 0.046627] Using GB pages for direct mapping132bob # [ 0.051210] RAMDISK: [mem 0x3e36d000-0x3ffcffff]133bob # [ 0.051787] ACPI: Early table checksum verification disabled134bob # [ 0.052344] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )135bob # [ 0.052726] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)136bob # [ 0.053580] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)137bob # [ 0.054364] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)138bob # [ 0.054488] ACPI: FACS 0x000000003FFE0000 000040139bob # [ 0.054558] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)140bob # [ 0.054589] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)141bob # [ 0.054618] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)142bob # [ 0.054646] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)143bob # [ 0.054764] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]144bob # [ 0.054802] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]145bob # [ 0.054812] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]146bob # [ 0.054819] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]147bob # [ 0.054826] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]148bob # [ 0.054833] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]149bob # [ 0.054840] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]150bob # [ 0.060733] No NUMA configuration found151bob # [ 0.060783] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]152bob # [ 0.061571] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]153bob # [ 0.066359] Zone ranges:154bob # [ 0.066408] DMA [mem 0x0000000000001000-0x0000000000ffffff]155bob # [ 0.066507] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]156bob # [ 0.066520] Normal empty157bob # [ 0.066538] Device empty158bob # [ 0.066551] Movable zone start for each node159bob # [ 0.066586] Early memory node ranges160bob # [ 0.066619] node 0: [mem 0x0000000000001000-0x000000000009efff]161bob # [ 0.066834] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]162bob # [ 0.066991] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]163bob # [ 0.068302] On node 0, zone DMA: 1 pages in unavailable ranges164bob # [ 0.068726] On node 0, zone DMA: 97 pages in unavailable ranges165bob # [ 0.084595] On node 0, zone DMA32: 40 pages in unavailable ranges166bob # [ 0.085397] ACPI: PM-Timer IO Port: 0x608167bob # [ 0.086029] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])168bob # [ 0.086576] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23169bob # [ 0.086740] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)170bob # [ 0.087062] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)171bob # [ 0.087123] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)172bob # [ 0.087239] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)173bob # [ 0.087251] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)174bob # [ 0.087483] ACPI: Using ACPI (MADT) for SMP configuration information175bob # [ 0.087541] ACPI: HPET id: 0x8086a201 base: 0xfed00000176bob # [ 0.088027] CPU topo: Max. logical packages: 1177bob # [ 0.088048] CPU topo: Max. logical dies: 1178bob # [ 0.088059] CPU topo: Max. dies per package: 1179bob # [ 0.088125] CPU topo: Max. threads per core: 1180bob # [ 0.088322] CPU topo: Num. cores per package: 1181bob # [ 0.088385] CPU topo: Num. threads per package: 1182bob # [ 0.088406] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs183bob # [ 0.089479] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]184bob # [ 0.089523] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]185bob # [ 0.089649] [mem 0x40000000-0xafffffff] available for PCI devices186bob # [ 0.089724] Booting paravirtualized kernel on bare hardware187bob # [ 0.090380] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns188bob # [ 0.106052] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1189bob # [ 0.109815] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152190bob # [ 0.111534] 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/p8hwydl4ilpb66vfs3pdc12192v1qv90-nixos-system-bob-test/init regInfo=/nix/.ro-store/j7hg3r4lmk2jfr15d55rq2jc2sjizg7d-closure-info/registration console=ttyS0,115200n8 console=tty0191bob # [ 0.113959] Unknown kernel command line parameters "regInfo=/nix/.ro-store/j7hg3r4lmk2jfr15d55rq2jc2sjizg7d-closure-info/registration", will be passed to user space.192bob # [ 0.114817] random: crng init done193bob # [ 0.114932] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes194bob # [ 0.116104] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)195bob # [ 0.116372] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)196bob # [ 0.120423] Fallback order for Node 0: 0197bob # [ 0.120810] Built 1 zonelists, mobility grouping on. Total pages: 262006198bob # [ 0.120836] Policy zone: DMA32199bob # [ 0.123666] mem auto-init: stack:all(zero), heap alloc:on, heap free:off200bob # [ 0.153005] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1201bob # [ 0.157605] allocated 2097152 bytes of page_ext202bob # [ 0.214410] ftrace: allocating 48787 entries in 192 pages203bob # [ 0.214684] ftrace: allocated 192 pages with 2 groups204bob # [ 0.227127] Dynamic Preempt: lazy205bob # [ 0.232119] rcu: Preemptible hierarchical RCU implementation.206bob # [ 0.232150] rcu: RCU event tracing is enabled.207bob # [ 0.232177] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.208bob # [ 0.232345] Trampoline variant of Tasks RCU enabled.209bob # [ 0.232356] Rude variant of Tasks RCU enabled.210bob # [ 0.232364] Tracing variant of Tasks RCU enabled.211bob # [ 0.232492] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.212bob # [ 0.232527] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1213bob # [ 0.234231] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.214bob # [ 0.234271] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.215bob # [ 0.234291] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.216bob # [ 0.292288] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16217bob # [ 0.305460] rcu: srcu_init: Setting srcu_struct sizes based on contention.218bob # [ 0.306338] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns219bob # [ 0.311166] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)220bob # [ 0.318171] Console: colour VGA+ 80x25221bob # [ 0.318730] printk: legacy console [tty0] enabled222bob # [ 0.329740] printk: legacy console [ttyS0] enabled223bob # [ 0.349712] ACPI: Core revision 20250807224alice # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Mon Sep 14 11:36:19 UTC 2026225alice # [ 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/dm25ifzai99pkp763r7wv9b38z3i6w0n-nixos-system-alice-test/init regInfo=/nix/.ro-store/f14fnyp3hll108i4nmqldhzm1qlpc32a-closure-info/registration console=ttyS0,115200n8 console=tty0226alice # [ 0.000000] BIOS-provided physical RAM map:227alice # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable228alice # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved229alice # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved230alice # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable231alice # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved232alice # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved233alice # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved234alice # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved235alice # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved236alice # [ 0.000000] NX (Execute Disable) protection: active237alice # [ 0.000000] APIC: Static calls initialized238alice # [ 0.000000] SMBIOS 2.8 present.239alice # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014240alice # [ 0.000000] DMI: Memory slots populated: 1/1241alice # [ 0.000000] tsc: Fast TSC calibration using PIT242alice # [ 0.000000] tsc: Detected 3593.258 MHz processor243alice # [ 0.017672] last_pfn = 0x3ffd8 max_arch_pfn = 0x10000000000244alice # [ 0.018476] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs245alice # [ 0.018683] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT246alice # [ 0.044940] found SMP MP-table at [mem 0x000f5450-0x000f545f]247alice # [ 0.047370] Using GB pages for direct mapping248alice # [ 0.052080] RAMDISK: [mem 0x3e36a000-0x3ffcffff]249alice # [ 0.052663] ACPI: Early table checksum verification disabled250alice # [ 0.053203] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )251alice # [ 0.053591] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)252alice # [ 0.054436] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)253alice # [ 0.055224] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)254alice # [ 0.055323] ACPI: FACS 0x000000003FFE0000 000040255alice # [ 0.055390] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)256alice # [ 0.055421] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)257alice # [ 0.055449] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)258alice # [ 0.055476] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)259alice # [ 0.055613] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]260alice # [ 0.055653] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]261alice # [ 0.055663] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]262bob # [ 0.358489] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns263alice # [ 0.055671] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]264alice # [ 0.055678] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]265alice # [ 0.055685] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]266alice # [ 0.055692] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]267alice # [ 0.061584] No NUMA configuration found268alice # [ 0.061639] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]269alice # [ 0.062407] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]270alice # [ 0.067266] Zone ranges:271alice # [ 0.067316] DMA [mem 0x0000000000001000-0x0000000000ffffff]272alice # [ 0.067417] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]273alice # [ 0.067430] Normal empty274alice # [ 0.067447] Device empty275alice # [ 0.067461] Movable zone start for each node276alice # [ 0.067495] Early memory node ranges277alice # [ 0.067527] node 0: [mem 0x0000000000001000-0x000000000009efff]278alice # [ 0.067744] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]279alice # [ 0.067903] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]280alice # [ 0.069188] On node 0, zone DMA: 1 pages in unavailable ranges281alice # [ 0.069623] On node 0, zone DMA: 97 pages in unavailable ranges282alice # [ 0.085582] On node 0, zone DMA32: 40 pages in unavailable ranges283alice # [ 0.086386] ACPI: PM-Timer IO Port: 0x608284alice # [ 0.087007] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])285alice # [ 0.087528] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23286alice # [ 0.087700] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)287alice # [ 0.088023] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)288alice # [ 0.088085] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)289alice # [ 0.088209] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)290alice # [ 0.088224] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)291alice # [ 0.088476] ACPI: Using ACPI (MADT) for SMP configuration information292alice # [ 0.088534] ACPI: HPET id: 0x8086a201 base: 0xfed00000293alice # [ 0.089065] CPU topo: Max. logical packages: 1294alice # [ 0.089083] CPU topo: Max. logical dies: 1295alice # [ 0.089094] CPU topo: Max. dies per package: 1296alice # [ 0.089161] CPU topo: Max. threads per core: 1297alice # [ 0.089345] CPU topo: Num. cores per package: 1298alice # [ 0.089365] CPU topo: Num. threads per package: 1299alice # [ 0.089375] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs300alice # [ 0.090407] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]301alice # [ 0.090442] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]302alice # [ 0.090577] [mem 0x40000000-0xafffffff] available for PCI devices303alice # [ 0.090643] Booting paravirtualized kernel on bare hardware304alice # [ 0.091271] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns305alice # [ 0.107064] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1306alice # [ 0.110841] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152307alice # [ 0.112568] 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/dm25ifzai99pkp763r7wv9b38z3i6w0n-nixos-system-alice-test/init regInfo=/nix/.ro-store/f14fnyp3hll108i4nmqldhzm1qlpc32a-closure-info/registration console=ttyS0,115200n8 console=tty0308alice # [ 0.114933] Unknown kernel command line parameters "regInfo=/nix/.ro-store/f14fnyp3hll108i4nmqldhzm1qlpc32a-closure-info/registration", will be passed to user space.309alice # [ 0.115747] random: crng init done310alice # [ 0.115849] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes311alice # [ 0.116994] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)312alice # [ 0.117206] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)313alice # [ 0.121284] Fallback order for Node 0: 0314alice # [ 0.121678] Built 1 zonelists, mobility grouping on. Total pages: 262006315alice # [ 0.121702] Policy zone: DMA32316alice # [ 0.124519] mem auto-init: stack:all(zero), heap alloc:on, heap free:off317alice # [ 0.153944] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1318alice # [ 0.158440] allocated 2097152 bytes of page_ext319bob # [ 0.366322] APIC: Switch to symmetric I/O mode setup320alice # [ 0.215451] ftrace: allocating 48787 entries in 192 pages321alice # [ 0.215733] ftrace: allocated 192 pages with 2 groups322alice # [ 0.228144] Dynamic Preempt: lazy323alice # [ 0.233232] rcu: Preemptible hierarchical RCU implementation.324alice # [ 0.233259] rcu: RCU event tracing is enabled.325alice # [ 0.233286] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.326alice # [ 0.233440] Trampoline variant of Tasks RCU enabled.327alice # [ 0.233450] Rude variant of Tasks RCU enabled.328alice # [ 0.233458] Tracing variant of Tasks RCU enabled.329alice # [ 0.233596] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.330alice # [ 0.233634] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1331bob # [ 0.367658] x2apic: IRQ remapping doesn't support X2APIC mode332alice # [ 0.235356] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.333alice # [ 0.235401] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.334alice # [ 0.235414] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.335alice # [ 0.293931] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16336alice # [ 0.307163] rcu: srcu_init: Setting srcu_struct sizes based on contention.337alice # [ 0.308049] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns338alice # [ 0.312701] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)339alice # [ 0.319871] Console: colour VGA+ 80x25340alice # [ 0.320452] printk: legacy console [tty0] enabled341alice # [ 0.331643] printk: legacy console [ttyS0] enabled342alice # [ 0.350264] ACPI: Core revision 20250807343bob # [ 0.374269] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1344alice # [ 0.358672] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns345bob # [ 0.380776] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x33cb127363e, max_idle_ns: 440795305332 ns346bob # [ 0.381983] Calibrating delay loop (skipped), value calculated using timer frequency.. 7186.31 BogoMIPS (lpj=3593156)347alice # [ 0.364974] APIC: Switch to symmetric I/O mode setup348alice # [ 0.366631] x2apic: IRQ remapping doesn't support X2APIC mode349alice # [ 0.372755] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1350bob # [ 0.385571] x86/cpu: User Mode Instruction Prevention (UMIP) activated351alice # [ 0.378707] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x33cb721243a, max_idle_ns: 440795205948 ns352alice # [ 0.380132] Calibrating delay loop (skipped), value calculated using timer frequency.. 7186.51 BogoMIPS (lpj=3593258)353bob # [ 0.401015] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0354bob # [ 0.401456] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0355bob # [ 0.404051] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto356bob # [ 0.405548] Speculative Store Bypass: Vulnerable357bob # [ 0.406078] Spectre V2 : Mitigation: Retpolines358bob # [ 0.406762] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization359bob # [ 0.407267] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT360alice # [ 0.386704] x86/cpu: User Mode Instruction Prevention (UMIP) activated361alice # [ 0.401001] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0362alice # [ 0.401382] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0363alice # [ 0.403894] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto364alice # [ 0.405524] Speculative Store Bypass: Vulnerable365alice # [ 0.406045] Spectre V2 : Mitigation: Retpolines366bob # [ 0.414460] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'367alice # [ 0.406611] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization368alice # [ 0.407067] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT369bob # [ 0.419085] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'370bob # [ 0.419710] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'371bob # [ 0.419948] x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'372bob # [ 0.420179] x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR'373bob # [ 0.420716] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'374bob # [ 0.421209] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256375bob # [ 0.421756] x86/fpu: xstate_offset[3]: 960, xstate_sizes[3]: 64376bob # [ 0.421983] x86/fpu: xstate_offset[4]: 1024, xstate_sizes[4]: 64377bob # [ 0.422838] x86/fpu: xstate_offset[9]: 2688, xstate_sizes[9]: 8378bob # [ 0.423117] x86/fpu: Enabled xstate features 0x21f, context size is 2696 bytes, using 'standard' format.379alice # [ 0.414227] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'380alice # [ 0.418704] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'381alice # [ 0.419347] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'382alice # [ 0.419596] x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers'383alice # [ 0.419822] x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR'384alice # [ 0.420107] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'385alice # [ 0.420767] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256386alice # [ 0.421089] x86/fpu: xstate_offset[3]: 960, xstate_sizes[3]: 64387alice # [ 0.421357] x86/fpu: xstate_offset[4]: 1024, xstate_sizes[4]: 64388alice # [ 0.422121] x86/fpu: xstate_offset[9]: 2688, xstate_sizes[9]: 8389alice # [ 0.422606] x86/fpu: Enabled xstate features 0x21f, context size is 2696 bytes, using 'standard' format.390bob # [ 0.904231] Freeing SMP alternatives memory: 44K391bob # [ 0.906022] pid_max: default: 32768 minimum: 301392alice # [ 0.899873] Freeing SMP alternatives memory: 44K393alice # [ 0.901617] pid_max: default: 32768 minimum: 301394bob # [ 0.918530] LSM: initializing lsm=capability,landlock,yama,bpf,ima395bob # [ 0.922203] landlock: Up and running.396bob # [ 0.922422] Yama: becoming mindful.397bob # [ 0.924009] LSM support for eBPF active398bob # [ 0.930154] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)399bob # [ 0.930737] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)400alice # [ 0.914018] LSM: initializing lsm=capability,landlock,yama,bpf,ima401alice # [ 0.917396] landlock: Up and running.402alice # [ 0.917647] Yama: becoming mindful.403alice # [ 0.919081] LSM support for eBPF active404alice # [ 0.924578] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)405alice # [ 0.925033] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)406bob # [ 1.081647] smpboot: CPU0: AMD QEMU TCG CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)407alice # [ 1.078311] smpboot: CPU0: AMD QEMU TCG CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)408bob # [ 1.103353] Performance Events: PMU not available due to virtualization, using software events only.409bob # [ 1.105401] signal: max sigframe size: 3632410bob # [ 1.108513] rcu: Hierarchical SRCU implementation.411bob # [ 1.109179] rcu: Max phase no-delay instances is 400.412alice # [ 1.097159] Performance Events: PMU not available due to virtualization, using software events only.413alice # [ 1.099190] signal: max sigframe size: 3632414alice # [ 1.102004] rcu: Hierarchical SRCU implementation.415alice # [ 1.102272] rcu: Max phase no-delay instances is 400.416bob # [ 1.122315] NMI watchdog: Perf NMI watchdog permanently disabled417alice # [ 1.112976] NMI watchdog: Perf NMI watchdog permanently disabled418bob # [ 1.129836] smp: Bringing up secondary CPUs ...419bob # [ 1.133326] smp: Brought up 1 node, 1 CPU420bob # [ 1.133946] smpboot: Total of 1 processors activated (7186.31 BogoMIPS)421alice # [ 1.118662] smp: Bringing up secondary CPUs ...422alice # [ 1.121053] smp: Brought up 1 node, 1 CPU423alice # [ 1.121487] smpboot: Total of 1 processors activated (7186.51 BogoMIPS)424alice # [ 1.132817] Memory: 941032K/1048024K available (17247K kernel code, 2727K rwdata, 13616K rodata, 3652K init, 2976K bss, 99604K reserved, 0K cma-reserved)425bob # [ 1.150438] Memory: 941052K/1048024K available (17247K kernel code, 2727K rwdata, 13616K rodata, 3652K init, 2976K bss, 99592K reserved, 0K cma-reserved)426alice # [ 1.143527] devtmpfs: initialized427bob # [ 1.164527] devtmpfs: initialized428alice # [ 1.150073] x86/mm: Memory block size: 128MB429bob # [ 1.171906] x86/mm: Memory block size: 128MB430alice # [ 1.166349] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)431alice # [ 1.167139] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).432alice # [ 1.172012] pinctrl core: initialized pinctrl subsystem433bob # [ 1.190817] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)434bob # [ 1.191805] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).435bob # [ 1.197058] pinctrl core: initialized pinctrl subsystem436alice # [ 1.182686] PM: RTC time: 17:55:36, date: 2026-09-22437bob # [ 1.208554] PM: RTC time: 17:55:36, date: 2026-09-22438alice # [ 1.207831] NET: Registered PF_NETLINK/PF_ROUTE protocol family439alice # [ 1.214112] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations440alice # [ 1.215703] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations441alice # [ 1.216562] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations442alice # [ 1.217117] audit: initializing netlink subsys (disabled)443bob # [ 1.234462] NET: Registered PF_NETLINK/PF_ROUTE protocol family444alice # [ 1.220734] audit: type=2000 audit(1790099736.855:1): state=initialized audit_enabled=0 res=1445bob # [ 1.241248] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations446bob # [ 1.242835] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations447bob # [ 1.243793] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations448bob # [ 1.244401] audit: initializing netlink subsys (disabled)449alice # [ 1.227927] thermal_sys: Registered thermal governor 'fair_share'450alice # [ 1.228008] thermal_sys: Registered thermal governor 'bang_bang'451alice # [ 1.228253] thermal_sys: Registered thermal governor 'step_wise'452alice # [ 1.228446] thermal_sys: Registered thermal governor 'user_space'453alice # [ 1.228618] thermal_sys: Registered thermal governor 'power_allocator'454alice # [ 1.229552] cpuidle: using governor menu455bob # [ 1.248207] audit: type=2000 audit(1790099735.882:1): state=initialized audit_enabled=0 res=1456alice # [ 1.232662] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5457alice # [ 1.237844] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]458alice # [ 1.238981] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry459bob # [ 1.256714] thermal_sys: Registered thermal governor 'fair_share'460bob # [ 1.256787] thermal_sys: Registered thermal governor 'bang_bang'461bob # [ 1.257035] thermal_sys: Registered thermal governor 'step_wise'462bob # [ 1.257206] thermal_sys: Registered thermal governor 'user_space'463alice # [ 1.241210] PCI: Using configuration type 1 for base access464bob # [ 1.257375] thermal_sys: Registered thermal governor 'power_allocator'465bob # [ 1.259000] cpuidle: using governor menu466bob # [ 1.262268] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5467alice # [ 1.245717] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.468bob # [ 1.268172] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]469bob # [ 1.269485] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry470bob # [ 1.272062] PCI: Using configuration type 1 for base access471bob # [ 1.277063] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.472alice # [ 1.269486] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages473alice # [ 1.269790] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page474alice # [ 1.269999] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages475alice # [ 1.270178] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page476bob # [ 1.298058] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages477bob # [ 1.298361] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page478bob # [ 1.298579] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages479bob # [ 1.298823] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page480alice # [ 1.333191] ACPI: Added _OSI(Module Device)481alice # [ 1.337374] ACPI: Added _OSI(Processor Device)482alice # [ 1.337573] ACPI: Added _OSI(Processor Aggregator Device)483bob # [ 1.376542] ACPI: Added _OSI(Module Device)484bob # [ 1.380968] ACPI: Added _OSI(Processor Device)485bob # [ 1.381161] ACPI: Added _OSI(Processor Aggregator Device)486alice # [ 1.446617] ACPI: 1 ACPI AML tables successfully acquired and loaded487bob # [ 1.498579] ACPI: 1 ACPI AML tables successfully acquired and loaded488alice # [ 1.503034] ACPI: Interpreter enabled489alice # [ 1.506812] ACPI: PM: (supports S0 S3 S4 S5)490alice # [ 1.507081] ACPI: Using IOAPIC for interrupt routing491alice # [ 1.517468] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug492alice # [ 1.517889] PCI: Using E820 reservations for host bridge windows493alice # [ 1.522965] ACPI: Enabled 2 GPEs in block 00 to 3F494bob # [ 1.555419] ACPI: Interpreter enabled495bob # [ 1.559469] ACPI: PM: (supports S0 S3 S4 S5)496bob # [ 1.559763] ACPI: Using IOAPIC for interrupt routing497bob # [ 1.570784] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug498bob # [ 1.571171] PCI: Using E820 reservations for host bridge windows499bob # [ 1.578259] ACPI: Enabled 2 GPEs in block 00 to 3F500alice # [ 1.617576] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])501alice # [ 1.618680] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]502alice # [ 1.621785] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]503alice # [ 1.624082] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]504alice # [ 1.632151] PCI host bridge to bus 0000:00505alice # [ 1.632892] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]506alice # [ 1.633395] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]507alice # [ 1.633604] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]508alice # [ 1.633823] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]509alice # [ 1.634046] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]510alice # [ 1.634360] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]511alice # [ 1.634912] pci_bus 0000:00: root bus resource [bus 00-ff]512alice # [ 1.640079] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint513alice # [ 1.646971] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint514alice # [ 1.649595] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]515alice # [ 1.650380] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]516alice # [ 1.650590] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]517alice # [ 1.651493] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]518alice # [ 1.653458] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint519bob # [ 1.669478] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])520bob # [ 1.670942] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]521alice # [ 1.655461] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]522alice # [ 1.656533] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]523alice # [ 1.656756] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]524bob # [ 1.673942] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]525alice # [ 1.657014] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]526alice # [ 1.659041] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint527bob # [ 1.676180] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]528alice # [ 1.661395] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]529alice # [ 1.661686] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]530alice # [ 1.661906] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]531alice # [ 1.663646] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint532alice # [ 1.665401] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]533alice # [ 1.665697] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]534alice # [ 1.665884] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]535bob # [ 1.684990] PCI host bridge to bus 0000:00536bob # [ 1.685795] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]537bob # [ 1.686172] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]538bob # [ 1.686390] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]539bob # [ 1.686736] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]540bob # [ 1.687007] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]541bob # [ 1.687246] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]542alice # [ 1.670090] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint543bob # [ 1.688027] pci_bus 0000:00: root bus resource [bus 00-ff]544alice # [ 1.673411] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]545alice # [ 1.673727] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]546alice # [ 1.673906] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]547alice # [ 1.674342] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]548alice # [ 1.675887] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint549bob # [ 1.693474] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint550alice # [ 1.678374] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]551alice # [ 1.678714] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]552alice # [ 1.680603] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint553alice # [ 1.683432] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]554alice # [ 1.683782] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]555bob # [ 1.701298] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint556alice # [ 1.685756] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint557bob # [ 1.703980] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]558bob # [ 1.704969] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]559bob # [ 1.705185] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]560alice # [ 1.687441] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]561alice # [ 1.688348] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]562bob # [ 1.705949] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]563alice # [ 1.690718] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint564bob # [ 1.708454] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint565alice # [ 1.693444] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]566alice # [ 1.693748] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]567bob # [ 1.711837] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]568bob # [ 1.712752] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]569alice # [ 1.695954] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint570bob # [ 1.713702] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]571bob # [ 1.713995] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]572bob # [ 1.715917] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint573alice # [ 1.698398] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]574alice # [ 1.698712] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]575alice # [ 1.698900] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]576alice # [ 1.700579] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint577bob # [ 1.717725] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]578bob # [ 1.718922] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]579bob # [ 1.719122] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]580bob # [ 1.720903] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint581alice # [ 1.702405] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]582alice # [ 1.703563] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]583alice # [ 1.704544] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]584bob # [ 1.724733] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]585bob # [ 1.725041] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]586bob # [ 1.725236] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]587alice # [ 1.708810] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint588bob # [ 1.727174] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint589alice # [ 1.710809] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]590bob # [ 1.728738] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]591bob # [ 1.729042] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]592bob # [ 1.729243] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]593alice # [ 1.712627] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint594bob # [ 1.729706] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]595alice # [ 1.713873] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]596bob # [ 1.731311] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint597alice # [ 1.715845] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint598alice # [ 1.717372] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]599bob # [ 1.732797] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]600bob # [ 1.734895] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]601alice # [ 1.719351] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint602alice # [ 1.720722] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]603bob # [ 1.738313] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint604alice # [ 1.722866] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint605alice # [ 1.723892] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO606bob # [ 1.741726] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]607bob # [ 1.742040] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]608alice # [ 1.725728] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint609bob # [ 1.743953] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint610alice # [ 1.727421] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]611alice # [ 1.727715] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]612alice # [ 1.729485] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint613bob # [ 1.746723] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]614bob # [ 1.747045] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]615alice # [ 1.731364] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]616bob # [ 1.748771] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint617bob # [ 1.751275] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]618bob # [ 1.751567] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]619bob # [ 1.753251] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint620bob # [ 1.755747] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]621bob # [ 1.756030] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]622bob # [ 1.756809] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]623alice # [ 1.741227] ACPI: PCI: Interrupt link LNKA configured for IRQ 10624bob # [ 1.758457] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint625alice # [ 1.743774] ACPI: PCI: Interrupt link LNKB configured for IRQ 10626alice # [ 1.744906] ACPI: PCI: Interrupt link LNKC configured for IRQ 11627bob # [ 1.762741] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]628bob # [ 1.763031] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]629alice # [ 1.746238] ACPI: PCI: Interrupt link LNKD configured for IRQ 11630bob # [ 1.763222] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]631alice # [ 1.747583] ACPI: PCI: Interrupt link LNKE configured for IRQ 10632bob # [ 1.764900] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint633alice # [ 1.748820] ACPI: PCI: Interrupt link LNKF configured for IRQ 10634bob # [ 1.766083] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]635alice # [ 1.750071] ACPI: PCI: Interrupt link LNKG configured for IRQ 11636alice # [ 1.751127] ACPI: PCI: Interrupt link LNKH configured for IRQ 11637bob # [ 1.768129] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint638alice # [ 1.751788] ACPI: PCI: Interrupt link GSIA configured for IRQ 16639alice # [ 1.752158] ACPI: PCI: Interrupt link GSIB configured for IRQ 17640bob # [ 1.769119] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]641alice # [ 1.752594] ACPI: PCI: Interrupt link GSIC configured for IRQ 18642alice # [ 1.753628] ACPI: PCI: Interrupt link GSID configured for IRQ 19643alice # [ 1.753966] ACPI: PCI: Interrupt link GSIE configured for IRQ 20644alice # [ 1.754463] ACPI: PCI: Interrupt link GSIF configured for IRQ 21645alice # [ 1.754773] ACPI: PCI: Interrupt link GSIG configured for IRQ 22646alice # [ 1.755073] ACPI: PCI: Interrupt link GSIH configured for IRQ 23647bob # [ 1.771872] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint648bob # [ 1.775175] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]649bob # [ 1.777274] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint650alice # [ 1.761782] iommu: Default domain type: Translated651alice # [ 1.762079] iommu: DMA domain TLB invalidation policy: lazy mode652bob # [ 1.778786] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]653bob # [ 1.780758] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint654alice # [ 1.764213] ACPI: bus type USB registered655bob # [ 1.781709] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO656alice # [ 1.765428] usbcore: registered new interface driver usbfs657alice # [ 1.766151] usbcore: registered new interface driver hub658alice # [ 1.766561] usbcore: registered new device driver usb659bob # [ 1.783396] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint660bob # [ 1.785741] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]661bob # [ 1.786027] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]662bob # [ 1.787809] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint663bob # [ 1.789162] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]664alice # [ 1.782966] NetLabel: Initializing665alice # [ 1.783184] NetLabel: domain hash size = 128666alice # [ 1.783363] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO667alice # [ 1.784876] NetLabel: unlabeled traffic allowed by default668alice # [ 1.785263] PCI: Using ACPI for IRQ routing669bob # [ 1.800918] ACPI: PCI: Interrupt link LNKA configured for IRQ 10670bob # [ 1.802783] ACPI: PCI: Interrupt link LNKB configured for IRQ 10671bob # [ 1.804145] ACPI: PCI: Interrupt link LNKC configured for IRQ 11672bob # [ 1.805878] ACPI: PCI: Interrupt link LNKD configured for IRQ 11673bob # [ 1.807926] ACPI: PCI: Interrupt link LNKE configured for IRQ 10674bob # [ 1.810491] ACPI: PCI: Interrupt link LNKF configured for IRQ 10675alice # [ 1.796024] pci 0000:00:01.0: vgaarb: setting as boot VGA device676alice # [ 1.796311] pci 0000:00:01.0: vgaarb: bridge control possible677bob # [ 1.812021] ACPI: PCI: Interrupt link LNKG configured for IRQ 11678alice # [ 1.796311] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none679alice # [ 1.796423] vgaarb: loaded680bob # [ 1.813502] ACPI: PCI: Interrupt link LNKH configured for IRQ 11681alice # [ 1.798166] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0682alice # [ 1.798543] hpet0: 3 comparators, 64-bit 100.000000 MHz counter683bob # [ 1.814184] ACPI: PCI: Interrupt link GSIA configured for IRQ 16684bob # [ 1.814879] ACPI: PCI: Interrupt link GSIB configured for IRQ 17685bob # [ 1.815261] ACPI: PCI: Interrupt link GSIC configured for IRQ 18686bob # [ 1.816033] ACPI: PCI: Interrupt link GSID configured for IRQ 19687bob # [ 1.817155] ACPI: PCI: Interrupt link GSIE configured for IRQ 20688bob # [ 1.817546] ACPI: PCI: Interrupt link GSIF configured for IRQ 21689bob # [ 1.817995] ACPI: PCI: Interrupt link GSIG configured for IRQ 22690bob # [ 1.818356] ACPI: PCI: Interrupt link GSIH configured for IRQ 23691alice # [ 1.804311] clocksource: Switched to clocksource tsc-early692bob # [ 1.825189] iommu: Default domain type: Translated693bob # [ 1.825447] iommu: DMA domain TLB invalidation policy: lazy mode694bob # [ 1.827808] ACPI: bus type USB registered695bob # [ 1.828998] usbcore: registered new interface driver usbfs696bob # [ 1.829889] usbcore: registered new interface driver hub697bob # [ 1.830351] usbcore: registered new device driver usb698alice # [ 1.820704] VFS: Disk quotas dquot_6.6.0699alice # [ 1.821300] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)700alice # [ 1.828168] pnp: PnP ACPI init701bob # [ 1.847919] NetLabel: Initializing702bob # [ 1.848136] NetLabel: domain hash size = 128703bob # [ 1.848279] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO704alice # [ 1.832806] ACPI: IRQ 4 override to edge(!), high(!)705bob # [ 1.849881] NetLabel: unlabeled traffic allowed by default706bob # [ 1.850300] PCI: Using ACPI for IRQ routing707alice # [ 1.835052] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved708alice # [ 1.839176] pnp: PnP ACPI: found 5 devices709bob # [ 1.861231] pci 0000:00:01.0: vgaarb: setting as boot VGA device710bob # [ 1.861637] pci 0000:00:01.0: vgaarb: bridge control possible711bob # [ 1.861647] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none712bob # [ 1.861775] vgaarb: loaded713bob # [ 1.863725] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0714bob # [ 1.864040] hpet0: 3 comparators, 64-bit 100.000000 MHz counter715bob # [ 1.869369] clocksource: Switched to clocksource tsc-early716bob # [ 1.890782] VFS: Disk quotas dquot_6.6.0717bob # [ 1.891664] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)718bob # [ 1.896357] pnp: PnP ACPI init719alice # [ 1.883818] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns720bob # [ 1.900935] ACPI: IRQ 4 override to edge(!), high(!)721alice # [ 1.884645] clocksource: Switched to clocksource acpi_pm722alice # [ 1.886344] NET: Registered PF_INET protocol family723bob # [ 1.903435] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved724alice # [ 1.888902] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)725bob # [ 1.907678] pnp: PnP ACPI: found 5 devices726bob # [ 1.947722] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns727bob # [ 1.948494] clocksource: Switched to clocksource acpi_pm728bob # [ 1.950282] NET: Registered PF_INET protocol family729bob # [ 1.952694] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)730alice # [ 1.989998] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)731alice # [ 1.991081] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)732alice # [ 1.991677] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)733alice # [ 1.992756] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)734alice # [ 1.993222] TCP: Hash tables configured (established 8192 bind 8192)735alice # [ 1.995756] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)736alice # [ 1.996635] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)737alice # [ 1.997259] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)738alice # [ 2.000357] NET: Registered PF_UNIX/PF_LOCAL protocol family739alice # [ 2.001343] NET: Registered PF_XDP protocol family740alice # [ 2.002919] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]741alice # [ 2.003191] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]742alice # [ 2.003373] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]743alice # [ 2.003687] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]744alice # [ 2.003876] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]745alice # [ 2.004066] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]746alice # [ 2.011356] ACPI: \_SB_.GSIA: Enabled at IRQ 16747alice # [ 2.021429] pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x7c0 took 15968 usecs748alice # [ 2.025935] ACPI: \_SB_.GSIB: Enabled at IRQ 17749alice # [ 2.033652] ACPI: \_SB_.GSIC: Enabled at IRQ 18750bob # [ 2.050319] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)751bob # [ 2.051421] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)752bob # [ 2.052085] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)753bob # [ 2.053345] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)754bob # [ 2.053959] TCP: Hash tables configured (established 8192 bind 8192)755bob # [ 2.057158] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)756alice # [ 2.041866] ACPI: \_SB_.GSID: Enabled at IRQ 19757bob # [ 2.058217] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)758bob # [ 2.059132] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)759bob # [ 2.061771] NET: Registered PF_UNIX/PF_LOCAL protocol family760bob # [ 2.062903] NET: Registered PF_XDP protocol family761bob # [ 2.064431] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]762bob # [ 2.064822] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]763alice # [ 2.048412] PCI: CLS 0 bytes, default 64764bob # [ 2.065025] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]765bob # [ 2.065221] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]766bob # [ 2.065481] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]767bob # [ 2.065863] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]768bob # [ 2.073441] ACPI: \_SB_.GSIA: Enabled at IRQ 16769alice # [ 2.056427] Trying to unpack rootfs image as initramfs...770bob # [ 2.083488] pci 0000:00:1d.0: quirk_usb_early_handoff+0x0/0x7c0 took 16099 usecs771bob # [ 2.087417] ACPI: \_SB_.GSIB: Enabled at IRQ 17772bob # [ 2.095247] ACPI: \_SB_.GSIC: Enabled at IRQ 18773bob # [ 2.101954] ACPI: \_SB_.GSID: Enabled at IRQ 19774bob # [ 2.107827] PCI: CLS 0 bytes, default 64775bob # [ 2.119219] Trying to unpack rootfs image as initramfs...776alice # [ 2.343093] Initialise system trusted keyrings777alice # [ 2.347952] workingset: timestamp_bits=40 max_order=18 bucket_order=0778bob # [ 2.409210] Initialise system trusted keyrings779bob # [ 2.413997] workingset: timestamp_bits=40 max_order=18 bucket_order=0780alice # [ 2.531192] Key type asymmetric registered781alice # [ 2.531793] Asymmetric key parser 'x509' registered782alice # [ 2.535092] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)783alice # [ 2.540270] io scheduler mq-deadline registered784alice # [ 2.540701] io scheduler kyber registered785alice # [ 2.565083] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled786alice # [ 2.580145] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A787bob # [ 2.603093] Key type asymmetric registered788bob # [ 2.603719] Asymmetric key parser 'x509' registered789bob # [ 2.606969] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)790bob # [ 2.609923] io scheduler mq-deadline registered791bob # [ 2.610370] io scheduler kyber registered792bob # [ 2.631197] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled793alice # [ 2.615933] Linux agpgart interface v0.103794alice # [ 2.617008] ACPI: bus type drm_connector registered795bob # [ 2.649062] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A796alice # [ 2.644065] usbcore: registered new interface driver usbserial_generic797alice # [ 2.644995] usbserial: USB Serial support registered for generic798alice # [ 2.645408] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled799alice # [ 2.652436] drop_monitor: Initializing network drop monitor service800alice # [ 2.656396] NET: Registered PF_INET6 protocol family801bob # [ 2.681771] Linux agpgart interface v0.103802bob # [ 2.685072] ACPI: bus type drm_connector registered803alice # [ 2.686973] Segment Routing with IPv6804bob # [ 2.703386] usbcore: registered new interface driver usbserial_generic805alice # [ 2.689608] In-situ OAM (IOAM) with IPv6806bob # [ 2.706717] usbserial: USB Serial support registered for generic807bob # [ 2.707240] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled808alice # [ 2.697217] IPI shorthand broadcast: enabled809bob # [ 2.712494] drop_monitor: Initializing network drop monitor service810bob # [ 2.718805] NET: Registered PF_INET6 protocol family811bob # [ 2.748385] Segment Routing with IPv6812bob # [ 2.749211] In-situ OAM (IOAM) with IPv6813bob # [ 2.761417] IPI shorthand broadcast: enabled814alice # [ 2.770823] sched_clock: Marking stable (2714041786, 56428349)->(2787103314, -16633179)815alice # [ 2.777161] registered taskstats version 1816alice # [ 2.786907] Loading compiled-in X.509 certificates817bob # [ 2.838783] sched_clock: Marking stable (2780094128, 58482912)->(2859648096, -21071056)818bob # [ 2.847877] registered taskstats version 1819bob # [ 2.855826] Loading compiled-in X.509 certificates820alice # [ 2.915862] Demotion targets for Node 0: null821alice # [ 2.922866] Key type .fscrypt registered822alice # [ 2.923104] Key type fscrypt-provisioning registered823alice # [ 2.932161] ima: No TPM chip found, activating TPM-bypass!824alice # [ 2.932941] ima: Allocated hash algorithm: sha1825alice # [ 2.940197] ima: No architecture policies found826alice # [ 2.951815] PM: Magic number: 10:367:947827alice # [ 2.952301] tty tty4: hash matches828alice # [ 2.952734] memory memory0: hash matches829alice # [ 2.969087] RAS: Correctable Errors collector initialized.830bob # [ 2.986838] Demotion targets for Node 0: null831bob # [ 2.989176] Key type .fscrypt registered832bob # [ 2.989423] Key type fscrypt-provisioning registered833bob # [ 3.003159] ima: No TPM chip found, activating TPM-bypass!834bob # [ 3.003529] ima: Allocated hash algorithm: sha1835bob # [ 3.011135] ima: No architecture policies found836bob # [ 3.024348] PM: Magic number: 10:367:947837bob # [ 3.024945] tty tty4: hash matches838bob # [ 3.025181] memory memory0: hash matches839bob # [ 3.041963] RAS: Correctable Errors collector initialized.840alice # [ 3.045303] clk: Disabling unused clocks841alice # [ 3.045976] PM: genpd: Disabling unused power domains842alice # [ 3.084771] tsc: Refined TSC clocksource calibration: 3593.237 MHz843alice # [ 3.085423] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x33cb5f13e99, max_idle_ns: 440795391341 ns844bob # [ 3.120462] clk: Disabling unused clocks845bob # [ 3.123208] PM: genpd: Disabling unused power domains846bob # [ 3.150917] tsc: Refined TSC clocksource calibration: 3593.235 MHz847bob # [ 3.151716] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x33cb5c753f5, max_idle_ns: 440795263286 ns848alice # [ 5.060214] Freeing initrd memory: 29080K849bob # [ 5.188574] Freeing initrd memory: 29068K850alice # [ 5.188664] Freeing unused decrypted memory: 2028K851alice # [ 5.267467] Freeing unused kernel image (initmem) memory: 3652K852alice # [ 5.268418] Write protecting the kernel read-only data: 32768k853alice # [ 5.273917] Freeing unused kernel image (text/rodata gap) memory: 1184K854alice # [ 5.275721] Freeing unused kernel image (rodata/data gap) memory: 720K855bob # [ 5.302361] Freeing unused decrypted memory: 2028K856bob # [ 5.379513] Freeing unused kernel image (initmem) memory: 3652K857bob # [ 5.380410] Write protecting the kernel read-only data: 32768k858bob # [ 5.385005] Freeing unused kernel image (text/rodata gap) memory: 1184K859bob # [ 5.386745] Freeing unused kernel image (rodata/data gap) memory: 720K860alice # [ 5.487329] x86/mm: Checked W+X mappings: passed, no W+X pages found.861alice # [ 5.488239] Run /init as init process862bob # [ 5.607627] x86/mm: Checked W+X mappings: passed, no W+X pages found.863bob # [ 5.608592] Run /init as init process864alice # [ 5.811096] systemd[1]: Inserted module 'autofs4'865bob # [ 5.887862] systemd[1]: Inserted module 'autofs4'866alice # [ 5.987809] fuse: init (API version 7.45)867bob # [ 6.048016] fuse: init (API version 7.45)868alice # [ 6.052596] ACPI: \_SB_.GSIG: Enabled at IRQ 22869alice # [ 6.060088] ACPI: \_SB_.GSIH: Enabled at IRQ 23870alice # [ 6.077829] ACPI: \_SB_.GSIE: Enabled at IRQ 20871alice # [ 6.082959] ACPI: \_SB_.GSIF: Enabled at IRQ 21872bob # [ 6.106503] ACPI: \_SB_.GSIG: Enabled at IRQ 22873bob # [ 6.113952] ACPI: \_SB_.GSIH: Enabled at IRQ 23874alice # [ 6.097870] virtiofs virtio5: discovered new tag: nix-store875alice # [ 6.106715] virtiofs virtio5: virtio_fs_setup_dax: No cache capability876bob # [ 6.131070] ACPI: \_SB_.GSIE: Enabled at IRQ 20877alice # [ 6.117926] virtiofs virtio6: discovered new tag: shared878bob # [ 6.135398] ACPI: \_SB_.GSIF: Enabled at IRQ 21879alice # [ 6.120232] virtiofs virtio6: virtio_fs_setup_dax: No cache capability880alice # [ 6.127645] virtiofs virtio7: discovered new tag: xchg881bob # [ 6.146683] virtiofs virtio5: discovered new tag: nix-store882alice # [ 6.130925] virtiofs virtio7: virtio_fs_setup_dax: No cache capability883bob # [ 6.153948] virtiofs virtio5: virtio_fs_setup_dax: No cache capability884bob # [ 6.162892] virtiofs virtio6: discovered new tag: shared885bob # [ 6.164731] virtiofs virtio6: virtio_fs_setup_dax: No cache capability886bob # [ 6.170700] virtiofs virtio7: discovered new tag: xchg887bob # [ 6.172504] virtiofs virtio7: virtio_fs_setup_dax: No cache capability888alice # [ 6.268830] systemd[1]: Successfully made /usr/ read-only.889bob # [ 6.285685] systemd[1]: Successfully made /usr/ read-only.890bob # [ 6.644055] 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)891bob # [ 6.645190] systemd[1]: Detected virtualization qemu.892bob # [ 6.646068] systemd[1]: Detected architecture x86-64.893bob # [ 6.646351] systemd[1]: Running in initrd.894alice # [ 6.629743] 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)895alice # [ 6.631266] systemd[1]: Detected virtualization qemu.896alice # [ 6.632306] systemd[1]: Detected architecture x86-64.897alice # [ 6.632812] systemd[1]: Running in initrd.898bob # [ 6.658874] systemd[1]: Initializing machine ID from random generator.899alice # [ 6.647873] systemd[1]: Initializing machine ID from random generator.900bob # [ 6.664389] systemd[1]: Hostname set to <bob>.901alice # [ 6.654356] systemd[1]: Hostname set to <alice>.902bob # [ 7.775046] systemd[1]: bpf-restrict-fs: LSM BPF program attached903alice # [ 7.998926] systemd[1]: bpf-restrict-fs: LSM BPF program attached904bob # [ 8.892051] systemd[1]: Queued start job for default target Initrd Default Target.905bob # [ 8.966186] systemd[1]: Created slice Slice /system/modprobe.906bob # [ 8.973854] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.907bob # [ 8.975896] systemd[1]: Expecting device /dev/disk/by-label/nixos...908bob # [ 8.977191] systemd[1]: Reached target Path Units.909bob # [ 8.978230] systemd[1]: Reached target Slice Units.910bob # [ 8.979253] systemd[1]: Reached target Swaps.911bob # [ 8.980216] systemd[1]: Reached target Timer Units.912bob # [ 8.987135] systemd[1]: Listening on D-Bus System Message Bus Socket.913bob # [ 8.991046] systemd[1]: Listening on Journal Socket (/dev/log).914bob # [ 8.993492] systemd[1]: Listening on Journal Sockets.915bob # [ 8.996412] systemd[1]: Listening on udev Control Socket.916bob # [ 8.998778] systemd[1]: Listening on udev Kernel Socket.917bob # [ 8.999765] systemd[1]: Reached target Socket Units.918bob # [ 9.041383] systemd[1]: Starting Create List of Static Device Nodes...919bob # [ 9.090707] systemd[1]: Starting Load Kernel Module configfs...920bob # [ 9.239027] systemd[1]: Starting Journal Service...921alice # [ 9.284116] systemd[1]: Queued start job for default target Initrd Default Target.922alice # [ 9.353770] systemd[1]: Created slice Slice /system/modprobe.923alice # [ 9.361094] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.924alice # [ 9.363109] systemd[1]: Expecting device /dev/disk/by-label/nixos...925alice # [ 9.364364] systemd[1]: Reached target Path Units.926alice # [ 9.365284] systemd[1]: Reached target Slice Units.927alice # [ 9.366065] systemd[1]: Reached target Swaps.928alice # [ 9.367009] systemd[1]: Reached target Timer Units.929alice # [ 9.374247] systemd[1]: Listening on D-Bus System Message Bus Socket.930bob # [ 9.391178] systemd[1]: Starting Load Kernel Modules...931alice # [ 9.378378] systemd[1]: Listening on Journal Socket (/dev/log).932alice # [ 9.381187] systemd[1]: Listening on Journal Sockets.933alice # [ 9.383976] systemd[1]: Listening on udev Control Socket.934alice # [ 9.386213] systemd[1]: Listening on udev Kernel Socket.935alice # [ 9.387061] systemd[1]: Reached target Socket Units.936bob # [ 9.429157] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os937alice # [ 9.427046] systemd[1]: Starting Create List of Static Device Nodes...938alice # [ 9.476210] systemd[1]: Starting Load Kernel Module configfs...939bob # [ 9.603675] systemd[1]: Starting Coldplug All udev Devices...940alice # [ 9.619911] systemd[1]: Starting Journal Service...941alice # [ 9.785414] systemd[1]: Starting Load Kernel Modules...942bob # [ 9.815000] systemd[1]: Finished Create List of Static Device Nodes.943alice # [ 9.819298] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os944bob # [ 9.999295] systemd[1]: modprobe@configfs.service: Deactivated successfully.945alice # [ 10.006428] systemd[1]: Starting Coldplug All udev Devices...946bob # [ 10.057206] systemd[1]: Finished Load Kernel Module configfs.947bob # [ 10.131162] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config948bob # [ 10.215736] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...949alice # [ 10.215073] systemd[1]: Finished Create List of Static Device Nodes.950alice # [ 10.394685] systemd[1]: modprobe@configfs.service: Deactivated successfully.951alice # [ 10.454955] systemd[1]: Finished Load Kernel Module configfs.952bob # [ 10.492395] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.953bob # [ 10.509088] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev954alice # [ 10.533423] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config955alice # [ 10.647029] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...956alice # [ 10.870992] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.957bob # [ 10.902112] systemd[1]: Finished Load Kernel Modules.958alice # [ 10.888915] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev959bob # [ 10.987997] systemd[1]: Starting Apply Kernel Variables...960bob # [ 11.153009] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.961bob # [ 11.277452] systemd-journald[66]: Collecting audit messages is disabled.962alice # [ 11.269215] systemd[1]: Finished Load Kernel Modules.963bob # [ 11.306909] systemd[1]: Starting Create Static Device Nodes in /dev...964alice # [ 11.341331] systemd[1]: Starting Apply Kernel Variables...965alice # [ 11.567370] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.966alice # [ 11.713250] systemd-journald[66]: Collecting audit messages is disabled.967alice # [ 11.744133] systemd[1]: Starting Create Static Device Nodes in /dev...968bob # [ 12.018227] systemd[1]: Finished Apply Kernel Variables.969bob # [ 12.254156] systemd[1]: Finished Create Static Device Nodes in /dev.970bob # [ 12.284385] systemd[1]: Reached target Preparation for Local File Systems.971bob # [ 12.287478] systemd[1]: Reached target Local File Systems.972alice # [ 12.310842] systemd[1]: Finished Apply Kernel Variables.973bob # [ 12.397392] systemd[1]: Starting Rule-based Manager for Device Events and Files...974alice # [ 12.619183] systemd[1]: Finished Create Static Device Nodes in /dev.975alice # [ 12.645128] systemd[1]: Reached target Preparation for Local File Systems.976alice # [ 12.647462] systemd[1]: Reached target Local File Systems.977alice # [ 12.735015] systemd[1]: Starting Rule-based Manager for Device Events and Files...978bob # [ 16.455969] systemd[1]: Started Journal Service.979bob # [ 16.437424] systemd-modules-load[67]: Inserted module 'dm_mod'980bob # [ 16.611920] systemd-modules-load[67]: Inserted module 'virtio_balloon'981bob # [ 16.662469] systemd-modules-load[67]: Inserted module 'virtio_gpu'982bob # [ 16.748919] systemd-udevd[73]: Using default interface naming scheme 'v261'.983bob # [ 16.802668] systemd[1]: Starting Create System Files and Directories...984alice # [ 17.022346] systemd[1]: Started Journal Service.985alice # [ 17.007994] systemd-modules-load[67]: Inserted module 'dm_mod'986alice # [ 17.119803] systemd-modules-load[67]: Inserted module 'virtio_balloon'987alice # [ 17.195896] systemd-modules-load[67]: Inserted module 'virtio_gpu'988alice # [ 17.288008] systemd-udevd[73]: Using default interface naming scheme 'v261'.989alice # [ 17.377982] systemd[1]: Starting Create System Files and Directories...990bob # [ 18.081447] systemd[1]: Finished Create System Files and Directories.991alice # [ 18.870846] systemd[1]: Finished Create System Files and Directories.992bob # [ 18.936878] systemd[1]: Started Rule-based Manager for Device Events and Files.993alice # [ 19.564307] systemd[1]: Started Rule-based Manager for Device Events and Files.994bob # [ 25.257562] systemd[1]: Finished Coldplug All udev Devices.995bob # [ 25.267718] systemd[1]: Reached target System Initialization.996bob # [ 25.281434] systemd[1]: Reached target Basic System.997alice # [ 28.252327] systemd[1]: Finished Coldplug All udev Devices.998alice # [ 28.264616] systemd[1]: Reached target System Initialization.999alice # [ 28.273745] systemd[1]: Reached target Basic System.1000bob: Guest root shell did not produce any data yet...1001bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1002alice # [ 40.241839] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121003alice # [ 40.296305] serio: i8042 KBD port at 0x60,0x64 irq 11004alice # [ 40.297285] serio: i8042 AUX port at 0x60,0x64 irq 121005bob # [ 40.461196] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,121006bob # [ 40.522203] serio: i8042 KBD port at 0x60,0x64 irq 11007bob # [ 40.538175] serio: i8042 AUX port at 0x60,0x64 irq 121008bob # [ 40.655163] virtio_blk virtio2: 1/0/0 default/read/poll queues1009bob # [ 40.806942] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1010alice # [ 40.960034] virtio_blk virtio2: 1/0/0 default/read/poll queues1011alice # [ 41.016246] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1012alice # [ 41.088121] uhci_hcd 0000:00:1d.0: UHCI Host Controller1013alice # [ 41.094598] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11014alice # [ 41.107018] uhci_hcd 0000:00:1d.0: detected 2 ports1015alice # [ 41.123851] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801016alice # [ 41.203121] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181017alice # [ 41.203971] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11018alice # [ 41.204339] usb usb1: Product: UHCI Host Controller1019alice # [ 41.214859] usb usb1: Manufacturer: Linux 6.18.52 uhci_hcd1020alice # [ 41.215377] usb usb1: SerialNumber: 0000:00:1d.01021alice # [ 41.259971] hub 1-0:1.0: USB hub found1022bob # [ 41.288374] uhci_hcd 0000:00:1d.0: UHCI Host Controller1023alice # [ 41.272326] hub 1-0:1.0: 2 ports detected1024bob # [ 41.298191] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 11025bob # [ 41.306005] uhci_hcd 0000:00:1d.0: detected 2 ports1026bob # [ 41.313497] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c1801027bob # [ 41.370706] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181028bob # [ 41.371125] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=11029bob # [ 41.371503] usb usb1: Product: UHCI Host Controller1030bob # [ 41.371945] usb usb1: Manufacturer: Linux 6.18.52 uhci_hcd1031bob # [ 41.372159] usb usb1: SerialNumber: 0000:00:1d.01032alice # [ 41.357163] uhci_hcd 0000:00:1d.1: UHCI Host Controller1033alice # [ 41.363785] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 21034alice # [ 41.364173] uhci_hcd 0000:00:1d.1: detected 2 ports1035alice # [ 41.365151] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01036alice # [ 41.376348] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181037alice # [ 41.376946] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11038alice # [ 41.377345] usb usb2: Product: UHCI Host Controller1039alice # [ 41.383993] usb usb2: Manufacturer: Linux 6.18.52 uhci_hcd1040alice # [ 41.384278] usb usb2: SerialNumber: 0000:00:1d.11041alice # [ 41.398313] hub 2-0:1.0: USB hub found1042alice # [ 41.402067] hub 2-0:1.0: 2 ports detected1043alice # [ 41.440338] uhci_hcd 0000:00:1d.2: UHCI Host Controller1044alice # [ 41.446739] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 31045alice # [ 41.447163] uhci_hcd 0000:00:1d.2: detected 2 ports1046alice # [ 41.448025] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01047bob # [ 41.464459] hub 1-0:1.0: USB hub found1048bob # [ 41.475395] hub 1-0:1.0: 2 ports detected1049alice # [ 41.462009] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181050alice # [ 41.462315] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11051alice # [ 41.462743] usb usb3: Product: UHCI Host Controller1052alice # [ 41.463030] usb usb3: Manufacturer: Linux 6.18.52 uhci_hcd1053alice # [ 41.463228] usb usb3: SerialNumber: 0000:00:1d.21054alice # [ 41.477253] hub 3-0:1.0: USB hub found1055alice # [ 41.481745] hub 3-0:1.0: 2 ports detected1056bob # [ 41.515714] uhci_hcd 0000:00:1d.1: UHCI Host Controller1057bob # [ 41.516146] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 21058bob # [ 41.519809] uhci_hcd 0000:00:1d.1: detected 2 ports1059bob # [ 41.520722] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a01060bob # [ 41.530373] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181061bob # [ 41.530906] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=11062bob # [ 41.531146] usb usb2: Product: UHCI Host Controller1063bob # [ 41.531341] usb usb2: Manufacturer: Linux 6.18.52 uhci_hcd1064bob # [ 41.531492] usb usb2: SerialNumber: 0000:00:1d.11065bob # [ 41.543468] hub 2-0:1.0: USB hub found1066bob # [ 41.549024] hub 2-0:1.0: 2 ports detected1067bob # [ 41.598908] uhci_hcd 0000:00:1d.2: UHCI Host Controller1068bob # [ 41.599401] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 31069bob # [ 41.599983] uhci_hcd 0000:00:1d.2: detected 2 ports1070bob # [ 41.607228] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c01071bob # [ 41.619242] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.181072bob # [ 41.619882] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=11073bob # [ 41.620094] usb usb3: Product: UHCI Host Controller1074bob # [ 41.620247] usb usb3: Manufacturer: Linux 6.18.52 uhci_hcd1075bob # [ 41.620492] usb usb3: SerialNumber: 0000:00:1d.21076bob # [ 41.633875] hub 3-0:1.0: USB hub found1077bob # [ 41.641211] hub 3-0:1.0: 2 ports detected1078alice # [ 42.559659] ehci-pci 0000:00:1d.7: EHCI Host Controller1079alice # [ 42.560314] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 41080alice # [ 42.580397] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001081alice # [ 42.593180] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001082alice # [ 42.604254] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181083alice # [ 42.605289] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11084alice # [ 42.608937] usb usb4: Product: EHCI Host Controller1085alice # [ 42.609213] usb usb4: Manufacturer: Linux 6.18.52 ehci_hcd1086alice # [ 42.609357] usb usb4: SerialNumber: 0000:00:1d.71087alice # [ 42.622099] hub 4-0:1.0: USB hub found1088alice # [ 42.627914] hub 4-0:1.0: 6 ports detected1089alice # [ 42.693430] hub 1-0:1.0: USB hub found1090alice # [ 42.707251] hub 1-0:1.0: 2 ports detected1091alice # [ 42.777380] hub 2-0:1.0: USB hub found1092alice # [ 42.795464] hub 2-0:1.0: 2 ports detected1093alice # [ 42.842407] hub 3-0:1.0: USB hub found1094alice # [ 42.848228] hub 3-0:1.0: 2 ports detected1095alice # [ 42.934463] usb 4-1: new high-speed USB device number 2 using ehci-pci1096bob # [ 43.075255] ehci-pci 0000:00:1d.7: EHCI Host Controller1097bob # [ 43.091490] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 41098bob # [ 43.136962] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb0001099bob # [ 43.163865] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.001100alice # [ 43.155947] usb 4-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001101alice # [ 43.157024] usb 4-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101102alice # [ 43.157458] usb 4-1: Product: QEMU USB Tablet1103alice # [ 43.162121] usb 4-1: Manufacturer: QEMU1104alice # [ 43.162996] usb 4-1: SerialNumber: 28754-0000:00:1d.7-11105bob # [ 43.196048] usb usb4: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.181106bob # [ 43.209043] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=11107bob # [ 43.209742] usb usb4: Product: EHCI Host Controller1108bob # [ 43.210093] usb usb4: Manufacturer: Linux 6.18.52 ehci_hcd1109bob # [ 43.211164] usb usb4: SerialNumber: 0000:00:1d.71110bob # [ 43.257025] hub 4-0:1.0: USB hub found1111bob # [ 43.272504] hub 4-0:1.0: 6 ports detected1112bob # [ 43.380878] hrtimer: interrupt took 2348343 ns1113bob # [ 43.436114] hub 1-0:1.0: USB hub found1114bob # [ 43.446454] hub 1-0:1.0: 2 ports detected1115bob # [ 43.537250] hub 2-0:1.0: USB hub found1116bob # [ 43.553603] hub 2-0:1.0: 2 ports detected1117bob # [ 43.667132] hub 3-0:1.0: USB hub found1118bob # [ 43.673413] hub 3-0:1.0: 2 ports detected1119bob # [ 43.701517] usb 4-1: new high-speed USB device number 2 using ehci-pci1120bob # [ 43.943185] usb 4-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.001121bob # [ 43.949011] usb 4-1: New USB device strings: Mfr=1, Product=3, SerialNumber=101122bob # [ 43.956315] usb 4-1: Product: QEMU USB Tablet1123bob # [ 43.962459] usb 4-1: Manufacturer: QEMU1124bob # [ 43.971035] usb 4-1: SerialNumber: 28754-0000:00:1d.7-11125alice # [ 44.257107] SCSI subsystem initialized1126bob # [ 45.858250] SCSI subsystem initialized1127alice # [ 46.007269] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1128alice # [ 46.008421] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1129alice # [ 46.027140] ahci 0000:00:1f.2: flags: 64bit ncq only1130alice # [ 46.279424] scsi host0: ahci1131alice # [ 46.306048] scsi host1: ahci1132alice # [ 46.323407] scsi host2: ahci1133alice # [ 46.340391] scsi host3: ahci1134alice # [ 46.355434] scsi host4: ahci1135alice # [ 46.376090] scsi host5: ahci1136alice # [ 46.386303] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11137alice # [ 46.389901] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11138alice # [ 46.390321] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11139alice # [ 46.394285] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11140alice # [ 46.395027] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11141alice # [ 46.395346] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11142alice # [ 46.750399] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1143alice # [ 46.784415] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001144alice # [ 46.797746] ata3.00: applying bridge limits1145alice # [ 46.807081] ata5: SATA link down (SStatus 0 SControl 300)1146alice # [ 46.816948] ata4: SATA link down (SStatus 0 SControl 300)1147alice # [ 46.817858] ata6: SATA link down (SStatus 0 SControl 300)1148alice # [ 46.819260] ata1: SATA link down (SStatus 0 SControl 300)1149alice # [ 46.820240] ata2: SATA link down (SStatus 0 SControl 300)1150alice # [ 46.830317] ata3.00: configured for UDMA/1001151alice # [ 46.883974] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51152bob # [ 47.025883] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode1153bob # [ 47.026431] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)1154bob # [ 47.033262] ahci 0000:00:1f.2: flags: 64bit ncq only1155bob # [ 47.216168] scsi host0: ahci1156bob # [ 47.252884] scsi host1: ahci1157bob # [ 47.278921] scsi host2: ahci1158bob # [ 47.317136] scsi host3: ahci1159bob # [ 47.344034] scsi host4: ahci1160bob # [ 47.382399] scsi host5: ahci1161bob # [ 47.411032] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 11162bob # [ 47.412148] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 11163bob # [ 47.419127] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 11164bob # [ 47.420302] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 11165bob # [ 47.429036] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 11166bob # [ 47.430158] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 11167bob # [ 47.808624] ata2: SATA link down (SStatus 0 SControl 300)1168bob # [ 47.839408] ata5: SATA link down (SStatus 0 SControl 300)1169bob # [ 47.843492] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)1170bob # [ 47.877159] ata6: SATA link down (SStatus 0 SControl 300)1171bob # [ 47.885092] ata4: SATA link down (SStatus 0 SControl 300)1172bob # [ 47.887454] ata1: SATA link down (SStatus 0 SControl 300)1173bob # [ 47.912943] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/1001174bob # [ 47.924315] ata3.00: applying bridge limits1175bob # [ 47.948439] ata3.00: configured for UDMA/1001176bob # [ 48.065521] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 51177bob: Guest root shell did not produce any data yet...1178bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1179alice # [ 58.966872] systemd[1]: Starting Virtual Console Setup...1180bob # [ 59.151729] systemd[1]: Starting Virtual Console Setup...1181bob # [ 60.672341] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01182alice # [ 60.733849] systemd-vconsole-setup[205]: Configuration of first virtual console was skipped, ignoring remaining ones.1183bob # [ 60.784637] systemd-vconsole-setup[210]: Configuration of first virtual console was skipped, ignoring remaining ones.1184alice # [ 60.805907] systemd[1]: Finished Virtual Console Setup.1185bob # [ 60.840912] systemd[1]: Finished Virtual Console Setup.1186bob # [ 61.042763] (udev-worker)[209]: Network interface NamePolicy= disabled on kernel command line.1187bob # [ 61.076907] (udev-worker)[203]: Network interface NamePolicy= disabled on kernel command line.1188alice # [ 61.536109] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input01189alice # [ 61.908881] (udev-worker)[212]: Network interface NamePolicy= disabled on kernel command line.1190alice # [ 61.946885] (udev-worker)[213]: Network interface NamePolicy= disabled on kernel command line.1191bob # [ 62.623902] systemd[1]: Found device /dev/disk/by-label/nixos.1192bob # [ 62.633669] systemd[1]: Reached target Initrd Root Device.1193bob # [ 62.698740] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1194bob # [ 63.686634] systemd-fsck[226]: nixos: clean, 12/65536 files, 13019/262144 blocks1195bob # [ 63.782868] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1196bob # [ 63.840692] systemd[1]: Mounting /sysroot...1197bob # [ 66.062904] EXT4-fs (vda): mounted filesystem bf4151ed-ddcc-484b-a344-da467ef50d4f r/w with ordered data mode. Quota mode: none.1198alice # [ 66.007723] systemd[1]: Found device /dev/disk/by-label/nixos.1199alice # [ 66.017815] systemd[1]: Reached target Initrd Root Device.1200alice # [ 66.046438] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1201bob # [ 66.155707] systemd[1]: Mounted /sysroot.1202bob # [ 66.176923] systemd[1]: Reached target Initrd Root File System.1203bob # [ 66.313833] systemd[1]: Mounting /sysroot/nix/.ro-store...1204bob # [ 66.443018] systemd[1]: Mounting /sysroot/nix/.rw-store...1205bob # [ 66.689772] systemd[1]: Mounting /sysroot/run...1206bob # [ 66.998753] systemd[1]: Mounting /sysroot/tmp/shared...1207alice # [ 67.066589] systemd-fsck[242]: nixos: clean, 12/65536 files, 13019/262144 blocks1208bob # [ 67.215948] systemd[1]: Mounting /sysroot/tmp/xchg...1209alice # [ 67.222575] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1210alice # [ 67.306559] systemd[1]: Mounting /sysroot...1211bob # [ 67.456425] systemd[1]: Starting Mountpoints Configured in the Real Root...1212bob # [ 68.408763] systemd-sysroot-fstab-check[250]: /sysroot should be mounted in the initrd, will request daemon-reload.1213bob # [ 68.551623] systemd[1]: Mounted /sysroot/nix/.ro-store.1214bob # [ 68.556410] systemd[1]: Mounted /sysroot/nix/.rw-store.1215bob # [ 68.562835] systemd[1]: Mounted /sysroot/run.1216bob # [ 68.570854] systemd[1]: Mounted /sysroot/tmp/shared.1217bob # [ 68.577927] systemd[1]: Mounted /sysroot/tmp/xchg.1218bob # [ 68.656774] systemd[1]: Reload requested from client PID 250 ('systemd-sysroot') (unit initrd-parse-etc.service)...1219bob # [ 68.665457] systemd[1]: Reloading...1220alice # [ 69.356938] EXT4-fs (vda): mounted filesystem 97b8a4f6-291d-4747-878d-587587bb26a7 r/w with ordered data mode. Quota mode: none.1221alice # [ 69.457593] systemd[1]: Mounted /sysroot.1222alice # [ 69.470628] systemd[1]: Reached target Initrd Root File System.1223alice # [ 69.567439] systemd[1]: Mounting /sysroot/nix/.ro-store...1224alice # [ 69.661203] systemd[1]: Mounting /sysroot/nix/.rw-store...1225alice # [ 69.818923] systemd[1]: Mounting /sysroot/run...1226alice # [ 70.076063] systemd[1]: Mounting /sysroot/tmp/shared...1227alice # [ 70.563991] systemd[1]: Mounting /sysroot/tmp/xchg...1228bob # [ 70.628623] systemd[1]: Reloading finished in 1934 ms.1229bob # [ 70.811866] systemd-sysroot-fstab-check[250]: Requesting initrd-fs.target/start/replace...1230bob # [ 70.881847] systemd-sysroot-fstab-check[250]: Requesting swap.target/start/replace...1231alice # [ 70.875429] systemd[1]: Starting Mountpoints Configured in the Real Root...1232bob # [ 70.940328] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1233bob # [ 70.953867] systemd[1]: Finished Mountpoints Configured in the Real Root.1234bob # [ 70.960681] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1235bob # [ 71.040477] systemd[1]: Starting rw-sysroot-nix-store.service...1236bob # [ 73.561330] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1237bob # [ 73.648727] systemd[1]: Finished rw-sysroot-nix-store.service.1238bob # [ 74.224643] systemd[1]: Mounting /sysroot/nix/store...1239alice # [ 78.206393] systemd-sysroot-fstab-check[266]: /sysroot should be mounted in the initrd, will request daemon-reload.1240bob # [ 79.131232] systemd[1]: Mounted /sysroot/nix/store.1241bob # [ 79.347513] systemd[1]: Reached target Initrd File Systems.1242bob # [ 79.719426] systemd[1]: Starting Find NixOS closure...1243bob # [ 80.534930] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1244alice # [ 82.138875] systemd[1]: Mounted /sysroot/nix/.ro-store.1245alice # [ 82.261652] systemd[1]: Mounted /sysroot/nix/.rw-store.1246alice # [ 82.302993] systemd[1]: Mounted /sysroot/run.1247alice # [ 82.362754] systemd[1]: Mounted /sysroot/tmp/shared.1248alice # [ 82.429442] systemd[1]: Mounted /sysroot/tmp/xchg.1249alice # [ 82.954124] systemd[1]: Reload requested from client PID 266 ('systemd-sysroot') (unit initrd-parse-etc.service)...1250alice # [ 82.993066] systemd[1]: Reloading...1251bob # [ 86.111078] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1252bob # [ 86.812402] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1253bob: Guest root shell did not produce any data yet...1254bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1255bob # [ 89.696747] systemd[1]: Finished Find NixOS closure.1256bob # [ 89.762394] systemd[1]: Reached target Initrd Default Target.1257bob # [ 90.032900] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1258alice # [ 92.699020] systemd[1]: Reloading finished in 9587 ms.1259bob # [ 93.939916] systemd[1]: Stopped target Initrd Default Target.1260alice # [ 93.936383] systemd-sysroot-fstab-check[266]: Requesting initrd-fs.target/start/replace...1261bob # [ 94.018014] systemd[1]: Stopped target Basic System.1262bob # [ 94.126557] systemd[1]: Stopped target Initrd Root Device.1263bob # [ 94.176275] systemd[1]: Stopped target Path Units.1264bob # [ 94.231714] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1265alice # [ 94.248189] systemd-sysroot-fstab-check[266]: Requesting swap.target/start/replace...1266bob # [ 94.317715] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1267bob # [ 94.408373] systemd[1]: Stopped target Slice Units.1268bob # [ 94.470053] systemd[1]: Stopped target Socket Units.1269bob # [ 94.559537] systemd[1]: Stopped target System Initialization.1270alice # [ 94.563510] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1271alice # [ 94.620442] systemd[1]: Finished Mountpoints Configured in the Real Root.1272bob # [ 94.692170] systemd[1]: Stopped target Swaps.1273alice # [ 94.753915] systemd[1]: initrd-parse-etc.service: Consumed 1.562s CPU time over 23.574s wall clock time, 2.1M memory peak.1274bob # [ 94.842732] systemd[1]: Stopped target Timer Units.1275alice # [ 94.863604] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1276bob # [ 94.887764] systemd[1]: dbus.socket: Deactivated successfully.1277bob # [ 94.974220] systemd[1]: Closed D-Bus System Message Bus Socket.1278bob # [ 95.043262] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1279bob # [ 95.136684] systemd[1]: Stopped Find NixOS closure.1280alice # [ 95.165986] systemd[1]: Starting rw-sysroot-nix-store.service...1281bob # [ 95.283941] systemd[1]: initrd-find-nixos-closure.service: Consumed 2.817s CPU time over 15.456s wall clock time, 1.9M memory peak.1282bob # [ 96.018302] systemd[1]: Starting rw-sysroot-nix-store.service...1283bob # [ 96.132072] systemd[1]: systemd-sysctl.service: Deactivated successfully.1284bob # [ 96.190208] systemd[1]: Stopped Apply Kernel Variables.1285bob # [ 96.379030] systemd[1]: systemd-modules-load.service: Deactivated successfully.1286bob # [ 96.546894] systemd[1]: Stopped Load Kernel Modules.1287bob # [ 96.809068] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1288bob # [ 97.103502] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1289bob # [ 97.180618] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Consumed 1.189s CPU time over 16.563s wall clock time, 2M memory peak.1290bob # [ 97.306575] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1291bob # [ 97.490498] systemd[1]: Stopped Create System Files and Directories.1292bob # [ 97.772862] systemd[1]: Stopped target Local File Systems.1293bob # [ 97.884509] systemd[1]: Stopped target Preparation for Local File Systems.1294alice # [ 97.877549] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1295bob # [ 97.931972] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1296alice # [ 97.910053] systemd[1]: Finished rw-sysroot-nix-store.service.1297bob # [ 98.139749] systemd[1]: Stopped Coldplug All udev Devices.1298bob # [ 98.196490] systemd[1]: systemd-udev-trigger.service: Consumed 5.263s CPU time over 1min 28.471s wall clock time, 3M memory peak.1299bob # [ 98.250301] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1300bob # [ 98.325755] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1301bob # [ 98.381356] systemd[1]: Stopped Virtual Console Setup.1302alice # [ 98.609758] systemd[1]: Mounting /sysroot/nix/store...1303bob # [ 100.254337] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1304bob # [ 100.288751] systemd[1]: Finished rw-sysroot-nix-store.service.1305bob # [ 100.315453] systemd[1]: rw-sysroot-nix-store.service: Consumed 1.002s CPU time over 4.343s wall clock time, 1.9M memory peak.1306bob # [ 100.606771] systemd[1]: initrd-cleanup.service: Deactivated successfully.1307bob # [ 100.666387] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1308bob # [ 100.704074] systemd[1]: initrd-cleanup.service: Consumed 1.531s CPU time over 10.591s wall clock time, 1.9M memory peak.1309bob # [ 104.243836] systemd[1]: systemd-udevd.service: Deactivated successfully.1310bob # [ 104.385225] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1311bob # [ 104.486648] systemd[1]: systemd-udevd.service: Consumed 39.401s CPU time over 1min 31.922s wall clock time, 19.9M memory peak.1312bob # [ 104.526546] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1313bob # [ 104.555569] systemd[1]: Closed udev Control Socket.1314bob # [ 104.678399] systemd[1]: Starting Cleanup udev Database...1315bob # [ 104.697950] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1316bob # [ 104.735246] systemd[1]: Stopped Create Static Device Nodes in /dev.1317bob # [ 104.811414] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1318bob # [ 104.882412] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1319bob # [ 104.997221] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1320bob # [ 105.062992] systemd[1]: Stopped Create List of Static Device Nodes.1321alice # [ 105.751282] systemd[1]: Mounted /sysroot/nix/store.1322alice # [ 105.832244] systemd[1]: Reached target Initrd File Systems.1323alice # [ 105.989332] systemd[1]: Starting Find NixOS closure...1324alice # [ 106.212115] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1325bob # [ 108.055494] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1326bob # [ 108.087846] systemd[1]: Finished Cleanup udev Database.1327bob # [ 108.114395] systemd[1]: initrd-udevadm-cleanup-db.service: Consumed 2.135s CPU time over 3.334s wall clock time, 2M memory peak.1328bob # [ 108.166714] systemd[1]: Reached target Switch Root.1329bob # [ 108.277036] systemd[1]: Starting NixOS Activation...1330alice # [ 112.612065] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1331alice # [ 113.003936] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1332alice # [ 115.182147] systemd[1]: Finished Find NixOS closure.1333alice # [ 115.246824] systemd[1]: Reached target Initrd Default Target.1334alice # [ 115.613790] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1335bob # [ 117.293448] initrd-nixos-activation-start[303]: booting system configuration /nix/store/p8hwydl4ilpb66vfs3pdc12192v1qv90-nixos-system-bob-test1336alice # [ 118.433441] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray1337bob: Guest root shell did not produce any data yet...1338bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1339alice # [ 118.685589] cdrom: Uniform CD-ROM driver Revision: 3.201340alice # [ 120.110183] systemd[1]: Stopped target Initrd Default Target.1341alice # [ 120.164744] systemd[1]: Stopped target Basic System.1342alice # [ 120.208104] systemd[1]: Stopped target Initrd Root Device.1343alice # [ 120.292811] systemd[1]: Stopped target Path Units.1344alice # [ 120.352565] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1345alice # [ 120.621890] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1346alice # [ 121.126812] systemd[1]: Stopped target Slice Units.1347alice # [ 121.169458] systemd[1]: Stopped target Socket Units.1348alice # [ 121.213726] systemd[1]: Stopped target System Initialization.1349alice # [ 121.260114] systemd[1]: Stopped target Swaps.1350alice # [ 121.322424] systemd[1]: Stopped target Timer Units.1351alice # [ 121.375911] systemd[1]: dbus.socket: Deactivated successfully.1352alice # [ 121.475352] systemd[1]: Closed D-Bus System Message Bus Socket.1353alice # [ 121.550313] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1354alice # [ 121.604830] systemd[1]: Stopped Find NixOS closure.1355alice # [ 121.664066] systemd[1]: initrd-find-nixos-closure.service: Consumed 2.576s CPU time over 15.617s wall clock time, 2M memory peak.1356bob # [ 121.866537] initrd-nixos-activation-start[303]: running activation script...1357alice # [ 122.259098] systemd[1]: Starting rw-sysroot-nix-store.service...1358alice # [ 122.322457] systemd[1]: systemd-sysctl.service: Deactivated successfully.1359alice # [ 122.376273] systemd[1]: Stopped Apply Kernel Variables.1360alice # [ 122.436729] systemd[1]: systemd-modules-load.service: Deactivated successfully.1361alice # [ 122.484457] systemd[1]: Stopped Load Kernel Modules.1362alice # [ 122.555259] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1363alice # [ 122.607863] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1364alice # [ 122.654254] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Consumed 1.370s CPU time over 16.390s wall clock time, 1.9M memory peak.1365alice # [ 122.684249] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1366alice # [ 122.759048] systemd[1]: Stopped Create System Files and Directories.1367alice # [ 122.852900] systemd[1]: Stopped target Local File Systems.1368alice # [ 122.929897] systemd[1]: Stopped target Preparation for Local File Systems.1369alice # [ 123.015138] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1370alice # [ 123.217102] systemd[1]: Stopped Coldplug All udev Devices.1371alice # [ 123.269092] systemd[1]: systemd-udev-trigger.service: Consumed 5.811s CPU time over 1min 53.148s wall clock time, 3.1M memory peak.1372alice # [ 123.353943] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1373alice # [ 123.386883] systemd[1]: Stopped Virtual Console Setup.1374alice # [ 125.409449] systemd[1]: initrd-cleanup.service: Deactivated successfully.1375alice # [ 125.446416] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1376alice # [ 125.471392] systemd[1]: initrd-cleanup.service: Consumed 1.676s CPU time over 9.763s wall clock time, 1.9M memory peak.1377alice # [ 125.527808] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1378alice # [ 125.576998] systemd[1]: Finished rw-sysroot-nix-store.service.1379alice # [ 125.601999] systemd[1]: rw-sysroot-nix-store.service: Consumed 1.021s CPU time over 3.523s wall clock time, 2M memory peak.1380alice # [ 129.217966] systemd[1]: systemd-udevd.service: Deactivated successfully.1381alice # [ 129.316190] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1382alice # [ 129.345353] systemd[1]: systemd-udevd.service: Consumed 44.391s CPU time over 1min 56.512s wall clock time, 21M memory peak.1383alice # [ 129.417275] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1384alice # [ 129.522108] systemd[1]: Closed udev Control Socket.1385alice # [ 129.768417] systemd[1]: Starting Cleanup udev Database...1386alice # [ 129.788921] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1387alice # [ 129.865024] systemd[1]: Stopped Create Static Device Nodes in /dev.1388alice # [ 129.904577] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1389alice # [ 129.932296] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1390alice # [ 129.987283] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1391alice # [ 130.029839] systemd[1]: Stopped Create List of Static Device Nodes.1392alice # [ 132.576419] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1393alice # [ 132.603694] systemd[1]: Finished Cleanup udev Database.1394alice # [ 132.648434] systemd[1]: initrd-udevadm-cleanup-db.service: Consumed 1.668s CPU time over 2.770s wall clock time, 2M memory peak.1395alice # [ 132.746776] systemd[1]: Reached target Switch Root.1396alice # [ 132.895403] systemd[1]: Starting NixOS Activation...1397alice # [ 144.000085] initrd-nixos-activation-start[317]: booting system configuration /nix/store/dm25ifzai99pkp763r7wv9b38z3i6w0n-nixos-system-alice-test1398alice # [ 148.290398] initrd-nixos-activation-start[317]: running activation script...1399bob: Guest root shell did not produce any data yet...1400bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1401alice # [ 153.259691] hrtimer: interrupt took 3373054 ns1402bob # [ 161.704381] initrd-nixos-activation-start[326]: setting up /etc...1403bob: Guest root shell did not produce any data yet...1404bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1405bob # [ 183.436168] initrd-nixos-activation-start[326]: setting up age secrets...1406alice # [ 190.352673] initrd-nixos-activation-start[340]: setting up /etc...1407bob # [ 191.605925] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1408bob # [ 191.617644] systemd[1]: Finished NixOS Activation.1409bob # [ 191.636890] systemd[1]: initrd-nixos-activation.service: Consumed 56.227s CPU time over 1min 23.314s wall clock time, 26.5M memory peak.1410bob # [ 191.679821] systemd[1]: Starting Switch Root...1411bob # [ 192.054735] systemd[1]: Switching root.1412bob # [ 192.612223] systemd-journald[66]: Received SIGTERM from PID 1 (systemd).1413alice # [ 194.505615] initrd-nixos-activation-start[340]: setting up age secrets...1414bob # [ 194.598893] NET: Registered PF_VSOCK protocol family1415bob # [ 195.418992] 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)1416bob # [ 195.421038] systemd[1]: Detected virtualization qemu.1417bob # [ 195.422337] systemd[1]: Detected architecture x86-64.1418bob # [ 195.424871] systemd[1]: Detected first boot.1419bob # [ 195.459148] systemd[1]: Initializing machine ID from random generator.1420alice # [ 196.653380] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1421alice # [ 196.692072] systemd[1]: Finished NixOS Activation.1422alice # [ 196.716095] systemd[1]: initrd-nixos-activation.service: Consumed 42.949s CPU time over 1min 3.733s wall clock time, 26.5M memory peak.1423alice # [ 196.873648] systemd[1]: Starting Switch Root...1424alice # [ 198.835597] systemd[1]: Switching root.1425bob # [ 199.789737] systemd[1]: bpf-restrict-fs: LSM BPF program attached1426alice # [ 200.093677] systemd-journald[66]: Received SIGTERM from PID 1 (systemd).1427alice # [ 208.131007] NET: Registered PF_VSOCK protocol family1428bob: Guest root shell did not produce any data yet...1429bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1430bob # [ 208.830986] systemd[1]: Applying preset policy.1431alice # [ 209.660471] 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)1432alice # [ 209.662962] systemd[1]: Detected virtualization qemu.1433alice # [ 209.664763] systemd[1]: Detected architecture x86-64.1434alice # [ 209.670733] systemd[1]: Detected first boot.1435alice # [ 209.744494] systemd[1]: Initializing machine ID from random generator.1436alice # [ 213.121226] systemd[1]: bpf-restrict-fs: LSM BPF program attached1437bob # [ 214.320008] systemd[1]: Populated /etc with preset unit settings.1438alice # [ 214.805318] systemd[1]: Applying preset policy.1439alice # [ 217.763747] systemd[1]: Populated /etc with preset unit settings.1440bob # [ 218.655301] systemd[1]: initrd-switch-root.service: Deactivated successfully.1441bob # [ 218.666513] systemd[1]: Stopped initrd-switch-root.service.1442bob # [ 218.743321] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1443bob # [ 218.765398] systemd[1]: Created slice Slice /system/getty.1444bob # [ 218.785304] systemd[1]: Created slice User and Session Slice.1445bob # [ 218.792837] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1446bob # [ 218.795462] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1447bob # [ 218.797413] systemd[1]: Expecting device /dev/hvc0...1448bob # [ 218.798456] systemd[1]: Expecting device /dev/ttyS0...1449bob # [ 218.799739] systemd[1]: Reached target Local Encrypted Volumes.1450bob # [ 218.801143] systemd[1]: Stopped target initrd-fs.target.1451bob # [ 218.802722] systemd[1]: Stopped target initrd-root-fs.target.1452bob # [ 218.803757] systemd[1]: Stopped target initrd-switch-root.target.1453bob # [ 218.804917] systemd[1]: Reached target Virtual Machines and Containers.1454bob # [ 218.806338] systemd[1]: Reached target Path Units.1455bob # [ 218.807814] systemd[1]: Reached target Remote File Systems.1456bob # [ 218.809006] systemd[1]: Reached target Slice Units.1457bob # [ 218.810132] systemd[1]: Reached target Swaps.1458bob # [ 218.847392] systemd[1]: Listening on Query the User Interactively for a Password.1459bob # [ 218.889874] systemd[1]: Listening on Process Core Dump Socket.1460bob # [ 218.923794] systemd[1]: Listening on Credential Encryption/Decryption.1461bob # [ 218.970160] systemd[1]: Listening on Factory Reset Management.1462bob # [ 218.975452] systemd[1]: Listening on Hostname Service Socket.1463bob # [ 219.048702] systemd[1]: Starting Journal Log Access Socket...1464bob # [ 219.086485] systemd[1]: Listening on Journal Audit Socket.1465bob # [ 219.132715] systemd[1]: Listening on Console Output Muting Service Socket.1466bob # [ 219.139025] systemd[1]: Listening on Network Management Metrics Varlink Socket.1467bob # [ 219.147468] systemd[1]: Listening on Network Management Varlink Socket.1468bob # [ 219.153342] systemd[1]: Listening on Network Management Netlink Socket.1469bob # [ 219.160992] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1470bob # [ 219.164929] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1471bob # [ 219.166741] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1472bob # [ 219.243861] systemd[1]: Listening on Disk Repartitioning Service Socket.1473bob # [ 219.250748] systemd[1]: Listening on Resolve Monitor Varlink Socket.1474bob # [ 219.256074] systemd[1]: Listening on Resolve Service Varlink Socket.1475bob # [ 219.261166] systemd[1]: Listening on udev Control Socket.1476bob # [ 219.267405] systemd[1]: Listening on udev Varlink Socket.1477bob # [ 219.346425] systemd[1]: Mounting Huge Pages File System...1478bob # [ 219.473184] systemd[1]: Mounting POSIX Message Queue File System...1479bob # [ 219.682136] systemd[1]: Mounting Kernel Debug File System...1480bob # [ 219.969163] systemd[1]: Mounting Kernel Trace File System...1481bob # [ 220.407354] systemd[1]: Starting Create List of Static Device Nodes...1482bob # [ 220.891104] systemd[1]: Starting Load Kernel Module configfs...1483bob # [ 220.919248] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1484bob # [ 220.951395] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1485bob # [ 220.990431] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1486bob # [ 221.603188] systemd[1]: Mounting FUSE Control File System...1487bob # [ 221.653157] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671488bob # [ 222.363100] systemd[1]: Starting Journal Service...1489bob # [ 222.642325] systemd[1]: Starting Load Kernel Modules...1490alice # [ 223.067809] systemd[1]: initrd-switch-root.service: Deactivated successfully.1491alice # [ 223.074946] systemd[1]: Stopped initrd-switch-root.service.1492alice # [ 223.079077] systemd[1]: initrd-switch-root.service: Consumed 1.099s CPU time over 26.148s wall clock time, 2M memory peak.1493alice # [ 223.127844] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1494alice # [ 223.147021] systemd[1]: Created slice Slice /system/getty.1495alice # [ 223.162698] systemd[1]: Created slice User and Session Slice.1496alice # [ 223.168595] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1497alice # [ 223.171151] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1498alice # [ 223.173899] systemd[1]: Expecting device /dev/hvc0...1499alice # [ 223.174921] systemd[1]: Expecting device /dev/ttyS0...1500alice # [ 223.176026] systemd[1]: Reached target Local Encrypted Volumes.1501alice # [ 223.177261] systemd[1]: Stopped target initrd-fs.target.1502alice # [ 223.178829] systemd[1]: Stopped target initrd-root-fs.target.1503alice # [ 223.179922] systemd[1]: Stopped target initrd-switch-root.target.1504alice # [ 223.180994] systemd[1]: Reached target Virtual Machines and Containers.1505alice # [ 223.182314] systemd[1]: Reached target Path Units.1506alice # [ 223.183729] systemd[1]: Reached target Remote File Systems.1507alice # [ 223.184631] systemd[1]: Reached target Slice Units.1508alice # [ 223.185705] systemd[1]: Reached target Swaps.1509alice # [ 223.217914] systemd[1]: Listening on Query the User Interactively for a Password.1510alice # [ 223.254916] systemd[1]: Listening on Process Core Dump Socket.1511alice # [ 223.284295] systemd[1]: Listening on Credential Encryption/Decryption.1512alice # [ 223.314521] systemd[1]: Listening on Factory Reset Management.1513alice # [ 223.317614] systemd[1]: Listening on Hostname Service Socket.1514alice # [ 223.367246] systemd[1]: Starting Journal Log Access Socket...1515alice # [ 223.394308] systemd[1]: Listening on Journal Audit Socket.1516alice # [ 223.435503] systemd[1]: Listening on Console Output Muting Service Socket.1517alice # [ 223.439917] systemd[1]: Listening on Network Management Metrics Varlink Socket.1518alice # [ 223.444113] systemd[1]: Listening on Network Management Varlink Socket.1519alice # [ 223.448698] systemd[1]: Listening on Network Management Netlink Socket.1520alice # [ 223.453740] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1521alice # [ 223.456522] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1522alice # [ 223.457720] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1523alice # [ 223.511605] systemd[1]: Listening on Disk Repartitioning Service Socket.1524alice # [ 223.514802] systemd[1]: Listening on Resolve Monitor Varlink Socket.1525alice # [ 223.516986] systemd[1]: Listening on Resolve Service Varlink Socket.1526alice # [ 223.519614] systemd[1]: Listening on udev Control Socket.1527alice # [ 223.523757] systemd[1]: Listening on udev Varlink Socket.1528alice # [ 223.564165] systemd[1]: Mounting Huge Pages File System...1529alice # [ 223.652198] systemd[1]: Mounting POSIX Message Queue File System...1530alice # [ 223.779230] systemd[1]: Mounting Kernel Debug File System...1531alice # [ 223.957993] systemd[1]: Mounting Kernel Trace File System...1532bob # [ 224.062746] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1533alice # [ 224.249916] systemd[1]: Starting Create List of Static Device Nodes...1534bob # [ 224.530221] systemd[1]: Starting Remount Root and Kernel File Systems...1535bob # [ 224.579070] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1536alice # [ 224.568858] systemd[1]: Starting Load Kernel Module configfs...1537alice # [ 224.584502] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1538alice # [ 224.611049] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1539alice # [ 224.634741] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1540alice # [ 225.042913] systemd[1]: Mounting FUSE Control File System...1541alice # [ 225.060297] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671542bob # [ 225.118456] systemd[1]: Starting Coldplug All udev Devices...1543bob # [ 225.801955] systemd[1]: Listening on Journal Log Access Socket.1544bob # [ 225.815472] systemd[1]: Mounted Huge Pages File System.1545bob # [ 225.828075] systemd[1]: Mounted POSIX Message Queue File System.1546bob # [ 225.839876] systemd[1]: Mounted Kernel Debug File System.1547bob # [ 225.850925] systemd[1]: Mounted Kernel Trace File System.1548bob # [ 225.899309] systemd[1]: Finished Create List of Static Device Nodes.1549alice # [ 225.933430] systemd[1]: Starting Journal Service...1550bob # [ 226.106134] systemd[1]: modprobe@configfs.service: Deactivated successfully.1551bob # [ 226.170308] systemd[1]: Finished Load Kernel Module configfs.1552alice # [ 226.192715] systemd[1]: Starting Load Kernel Modules...1553bob # [ 226.231878] systemd[1]: Mounted FUSE Control File System.1554bob # [ 227.035029] loop: module loaded1555bob # [ 227.047098] systemd[1]: Mounting Kernel Configuration File System...1556bob # [ 227.049481] systemd-journald[420]: Collecting audit messages is enabled.1557bob # [ 227.865216] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1558alice # [ 228.356531] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1559bob # [ 228.631524] systemd[1]: Finished Load Kernel Modules.1560bob # [ 229.186115] EXT4-fs (vda): re-mounted bf4151ed-ddcc-484b-a344-da467ef50d4f.1561alice # [ 229.301874] systemd[1]: Starting Remount Root and Kernel File Systems...1562alice # [ 229.339508] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1563bob # [ 229.430743] systemd[1]: Queued start job for default target Multi-User System.1564bob # [ 229.551613] systemd[1]: systemd-journald.service: Deactivated successfully.1565bob # [ 229.642231] systemd[1]: systemd-journald.service: Consumed 5.779s CPU time over 3min 29.323s wall clock time, 3.6M memory peak.1566bob # [ 229.756488] systemd-modules-load[421]: Inserted module 'loop'1567bob # [ 229.999206] systemd[1]: Starting Firewall...1568alice # [ 230.700412] systemd[1]: Starting Coldplug All udev Devices...1569bob # [ 231.177081] systemd[1]: Starting Apply Kernel Variables...1570alice # [ 231.282658] systemd[1]: Listening on Journal Log Access Socket.1571alice # [ 231.307512] systemd[1]: Mounted Huge Pages File System.1572alice # [ 231.318268] systemd[1]: Mounted POSIX Message Queue File System.1573alice # [ 231.342336] systemd[1]: Mounted Kernel Debug File System.1574alice # [ 231.352666] systemd[1]: Mounted Kernel Trace File System.1575alice # [ 231.433291] systemd[1]: Finished Create List of Static Device Nodes.1576alice # [ 231.467013] systemd[1]: modprobe@configfs.service: Deactivated successfully.1577alice # [ 231.580910] systemd[1]: Finished Load Kernel Module configfs.1578alice # [ 232.023268] systemd[1]: Mounted FUSE Control File System.1579bob # [ 232.243333] systemd[1]: Started Journal Service.1580alice # [ 232.527721] systemd[1]: Mounting Kernel Configuration File System...1581alice # [ 232.551520] systemd-journald[426]: Collecting audit messages is enabled.1582alice # [ 233.596304] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1583alice # [ 233.600508] loop: module loaded1584alice # [ 234.410751] systemd[1]: Finished Load Kernel Modules.1585bob # [ 234.872611] systemd[1]: Finished Remount Root and Kernel File Systems.1586alice # [ 235.488596] systemd[1]: Queued start job for default target Multi-User System.1587alice # [ 235.628599] systemd[1]: systemd-journald.service: Deactivated successfully.1588alice # [ 235.835180] EXT4-fs (vda): re-mounted 97b8a4f6-291d-4747-878d-587587bb26a7.1589alice # [ 235.767986] systemd[1]: systemd-journald.service: Consumed 5.811s CPU time over 3min 33.374s wall clock time, 3.6M memory peak.1590alice # [ 235.962496] systemd-modules-load[427]: Inserted module 'loop'1591bob # [ 236.031684] systemd[1]: Mounted Kernel Configuration File System.1592alice # [ 236.611250] systemd[1]: Starting Firewall...1593alice # [ 238.148212] systemd[1]: Starting Apply Kernel Variables...1594bob: Guest root shell did not produce any data yet...1595bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1596bob # [ 238.536036] systemd[1]: Listening on Disk Image Download Service Socket.1597alice # [ 239.095808] systemd[1]: Started Journal Service.1598bob # [ 239.224625] systemd-oomd[423]: No swap; memory pressure usage will be degraded1599bob # [ 239.316987] systemd[1]: Starting Flush Journal to Persistent Storage...1600bob # [ 239.449719] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1601bob # [ 241.065822] systemd[1]: Starting Load/Save OS Random Seed...1602bob # [ 241.092257] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1603bob # [ 241.357880] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1604bob # [ 241.503346] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1605alice # [ 241.712282] systemd[1]: Finished Remount Root and Kernel File Systems.1606bob # [ 242.707909] systemd[1]: Finished Apply Kernel Variables.1607bob # [ 244.068477] systemd-journald[420]: Received client request to flush runtime journal.1608alice # [ 244.423098] systemd[1]: Mounted Kernel Configuration File System.1609alice # [ 247.719272] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1610alice # [ 248.497288] systemd-oomd[429]: No swap; memory pressure usage will be degraded1611alice # [ 248.928768] systemd[1]: Listening on Disk Image Download Service Socket.1612alice # [ 249.936581] systemd[1]: Starting Flush Journal to Persistent Storage...1613alice # [ 250.316118] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1614alice # [ 251.611705] systemd[1]: Starting Load/Save OS Random Seed...1615bob # [ 252.447409] systemd[1]: Starting Network Name Resolution...1616bob # [ 252.743334] systemd[1]: Starting Create Static Device Nodes in /dev...1617bob # [ 252.949384] systemd[1]: Finished Load/Save OS Random Seed.1618bob # [ 253.035521] systemd[1]: Reached target First Boot Complete.1619bob # [ 253.115541] systemd[1]: Finished Flush Journal to Persistent Storage.1620alice # [ 253.304520] systemd[1]: Starting Create Static Device Nodes in /dev...1621alice # [ 253.357771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1622alice # [ 253.633891] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1623alice # [ 254.870537] systemd[1]: Finished Apply Kernel Variables.1624alice # [ 255.570454] systemd-journald[426]: Received client request to flush runtime journal.1625bob # [ 257.995190] systemd[1]: Finished Create Static Device Nodes in /dev.1626bob # [ 258.321503] systemd[1]: Reached target Preparation for Local File Systems.1627bob # [ 258.840737] systemd[1]: Mounting /run/wrappers...1628bob # [ 259.969909] systemd[1]: Starting Rule-based Manager for Device Events and Files...1629bob # [ 268.056009] systemd[1]: Mounted /run/wrappers.1630bob: Guest root shell did not produce any data yet...1631bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1632alice # [ 310.733325] watchdog: BUG: soft lockup - CPU#0 stuck for 43s! [systemd:1]1633alice # [ 310.744305] Modules linked in: nf_tables sch_fq_codel nfnetlink loop configfs dmi_sysfs qemu_fw_cfg vsock_loopback vmw_vsock_virtio_transport vmw_vsock_virtio_transport_common vsock sr_mod cdrom overlay ext4 crc16 mbcache jbd2 atkbd libps2 vivaldi_fmap ahci libahci libata scsi_mod scsi_common ehci_pci uhci_hcd virtio_blk ehci_hcd virtio_net net_failover failover i8042 serio virtio_gpu virtio_dma_buf virtio_balloon dm_mod virtio_pci virtio_pci_legacy_dev virtio_pci_modern_dev virtiofs fuse virtio_console virtio_rng virtio virtio_ring autofs41634alice # [ 310.755996] CPU: 0 UID: 0 PID: 1 Comm: systemd Not tainted 6.18.52 #1-NixOS PREEMPT(lazy)1635alice # [ 310.756489] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/20141636alice # [ 310.756800] RIP: 0033:0x7f7b100f2b281637alice # [ 310.759050] Code: 48 8d 75 b8 e8 f9 70 03 00 85 c0 75 55 48 39 5d c0 75 df 48 8b 45 b8 48 8b 75 98 48 89 da 48 89 c7 48 89 45 90 e8 88 26 ff ff <85> c0 75 c4 48 8b 7d 88 48 85 ff 74 2b 48 8b 55 90 31 c9 48 89 171638alice # [ 310.759613] RSP: 002b:00007ffeaee09280 EFLAGS: 000102461639alice # [ 310.760128] RAX: 0000000000000000 RBX: 0000000000000002 RCX: 00000000000000021640alice # [ 310.760182] RDX: 0000000000000002 RSI: 00007f7b1013c225 RDI: 000055908ba88f831641alice # [ 310.760196] RBP: 00007ffeaee09300 R08: 0000000000000000 R09: 00000000000000001642alice # [ 310.760210] R10: 0000000000000000 R11: 0000000000000000 R12: 00007ffeaee093381643alice # [ 310.760238] R13: 00007ffeaee09330 R14: 00007ffeaee093a0 R15: 000055908bad7dd01644alice # [ 310.760323] FS: 00007f7b1027e840 GS: 00000000000000001645alice # [ 310.792115] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 42906215952 wd_nsec: 01646bob # [ 310.751818] watchdog: BUG: soft lockup - CPU#0 stuck for 43s! [systemd:1]1647bob # [ 310.766807] Modules linked in: nf_tables nfnetlink sch_fq_codel loop configfs dmi_sysfs qemu_fw_cfg vsock_loopback vmw_vsock_virtio_transport vmw_vsock_virtio_transport_common vsock overlay ext4 crc16 mbcache jbd2 atkbd libps2 vivaldi_fmap ahci libahci libata scsi_mod scsi_common ehci_pci uhci_hcd ehci_hcd virtio_net net_failover virtio_blk failover i8042 serio virtio_gpu virtio_dma_buf virtio_balloon dm_mod virtio_pci virtio_pci_legacy_dev virtio_pci_modern_dev virtiofs fuse virtio_console virtio_rng virtio virtio_ring autofs41648bob # [ 310.778074] CPU: 0 UID: 0 PID: 1 Comm: systemd Not tainted 6.18.52 #1-NixOS PREEMPT(lazy)1649bob # [ 310.780632] Hardware name: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/20141650bob # [ 310.780976] RIP: 0033:0x7f538cf640921651bob # [ 310.785595] Code: 84 0a 8a d8 ff 0f b6 47 2c 41 89 f4 89 c2 c0 ea 03 83 e2 01 40 38 f2 0f 84 db 00 00 00 89 f2 83 e0 f7 83 e2 01 c1 e2 03 09 d0 <88> 47 2c 48 8b 47 08 40 84 f6 75 42 48 8d 57 38 48 8b 78 10 48 891652bob # [ 310.786779] RSP: 002b:00007ffd783c4610 EFLAGS: 000102021653bob # [ 310.786907] RAX: 0000000000000001 RBX: 00005600e076e240 RCX: 00000000000000001654bob # [ 310.786933] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00005600e076e2401655bob # [ 310.786952] RBP: 00007ffd783c4620 R08: 0000000000000000 R09: 000000000004234a1656bob # [ 310.786971] R10: 0000000000000000 R11: 0000000000000000 R12: 00000000000000001657bob # [ 310.786988] R13: 000000000000000e R14: 00005600e076e240 R15: 00005600e076fbf01658bob # [ 310.787072] FS: 00007f538c8fc840 GS: 00000000000000001659bob # [ 310.813055] clocksource: Long readout interval, skipping watchdog check: cs_nsec: 42927001909 wd_nsec: 01660alice # [ 273.351428] systemd[1]: Starting Network Name Resolution...1661alice # [ 273.428614] systemd[1]: Finished Load/Save OS Random Seed.1662bob: Guest root shell did not produce any data yet...1663bob: To debug, enter the VM and run 'systemctl status backdoor.service'.1664cleanup1665kill QemuMachine (pid 47)1666alice # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)1667alice # [2026-09-22T18:01:57Z INFO virtiofsd] Client disconnected, shutting down1668alice # [2026-09-22T18:01:57Z INFO virtiofsd] Client disconnected, shutting down1669alice # [2026-09-22T18:01:57Z INFO virtiofsd] Client disconnected, shutting down1670kill QemuMachine (pid 48)1671bob # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)1672bob # [2026-09-22T18:01:58Z INFO virtiofsd] Client disconnected, shutting down1673bob # [2026-09-22T18:01:58Z INFO virtiofsd] Client disconnected, shutting down1674bob # [2026-09-22T18:01:58Z INFO virtiofsd] Client disconnected, shutting down1675(finished: cleanup, in 1.45 seconds)1676Traceback (most recent call last):1677 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1678 sys.exit(main())1679 ~~~~^^1680 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main1681 driver.run_tests()1682 ~~~~~~~~~~~~~~~~^^1683 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests1684 self.test_script()1685 ~~~~~~~~~~~~~~~~^^1686 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script1687 exec(self.tests, symbols, None)1688 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^1689 File "<string>", line 5, in <module>1690 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 541, in wait_until_succeeds1691 retry(check_success, as_timedelta(timeout))1692 ~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1693 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 141, in retry1694 if fn(False):1695 ~~^^^^^^^1696 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 537, in check_success1697 status, output = self.execute(command, timeout=timeout)1698 ~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^1699 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 722, in execute1700 return self._execute(1701 ~~~~~~~~~~~~~^1702 command=command,1703 ^^^^^^^^^^^^^^^^1704 ...<2 lines>...1705 timeout=as_timedelta(timeout) if timeout is not None else None,1706 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1707 )1708 ^1709 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 983, in _execute1710 self.connect()1711 ~~~~~~~~~~~~^^1712 File "/nix/store/dfqkqnafwd5cfzvqwzq1sfwyyx0lhrr4-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 1172, in connect1713 raise RuntimeError("Shell did not start in time")1714RuntimeError: Shell did not start in time