Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: alice, bob, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs alice: starting vm bob: starting vm bob: QEMU running (pid 47) alice # Disk image does not exist, creating the virtualisation disk image... alice: QEMU running (pid 48) bob # Disk image does not exist, creating the virtualisation disk image... alice # Formatting '/build/vm-state-alice/tmp.V7VKwGks6y', fmt=raw size=1073741824 bob # Formatting '/build/vm-state-bob/tmp.Idp7tldIzp', fmt=raw size=1073741824 alice # mke2fs 1.47.4 (6-Mar-2025) bob # mke2fs 1.47.4 (6-Mar-2025) alice # Discarding device blocks: 0/262144 done bob # Discarding device blocks: 0/262144 done (finished: start all VMs, in 0.45 seconds) bob # Creating filesystem with 262144 4k blocks and 65536 inodes bob: waiting for unit harmonia.socket bob # Filesystem UUID: b831230d-1413-4128-a4e5-d926726902a4 bob: waiting for the VM to finish booting alice # Creating filesystem with 262144 4k blocks and 65536 inodes bob # Superblock backups stored on blocks: alice # Filesystem UUID: c4ab55f6-310c-49d7-a08d-c55bd390ce71 bob # 32768, 98304, 163840, 229376 alice # Superblock backups stored on blocks: bob # alice # 32768, 98304, 163840, 229376 bob # Allocating group tables: 0/8 done alice # bob # Writing inode tables: 0/8 done alice # Allocating group tables: 0/8 done bob # Creating journal (8192 blocks): done alice # Writing inode tables: 0/8 done bob # Writing superblocks and filesystem accounting information: 0/8 done alice # Creating journal (8192 blocks): done bob # alice # Writing superblocks and filesystem accounting information: 0/8 done bob # Virtualisation disk image created. alice # alice # Virtualisation disk image created. bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] bob # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 23 12:27:10 UTC 2026 bob # [ 0.000000] KASLR enabled bob # [ 0.000000] random: crng init done bob # [ 0.000000] Machine model: linux,dummy-virt bob # [ 0.000000] efi: UEFI not found. bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f] bob # [ 0.000000] Zone ranges: bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] DMA32 empty bob # [ 0.000000] Normal empty bob # [ 0.000000] Device empty bob # [ 0.000000] Movable zone start for each node bob # [ 0.000000] Early memory node ranges bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 bob # [ 0.000000] psci: probing for conduit method from DT. bob # [ 0.000000] psci: PSCIv1.3 detected in firmware. bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs bob # [ 0.000000] psci: Trusted OS migration not required bob # [ 0.000000] psci: SMC Calling Convention v1.1 bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 bob # [ 0.000000] Detected PIPT I-cache on CPU0 bob # [ 0.000000] CPU features: detected: GICv3 CPU interface bob # [ 0.000000] CPU features: detected: Spectre-v4 bob # [ 0.000000] CPU features: detected: Spectre-BHB bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) bob # [ 0.000000] CPU features: detected: ARM erratum 1418040 bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing bob # [ 0.000000] alternatives: applying boot alternatives bob # [ 0.000000] Kernel command line: console=ttyAMA0 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/mbyx6gscz2qj9k3sidmghvbfyz6dn512-nixos-system-bob-test/init regInfo=/nix/store/0fjqy322lv3c885zxvvh7vdd87fsm55i-closure-info/registration console=ttyAMA0,115200n8 console=tty0 bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/0fjqy322lv3c885zxvvh7vdd87fsm55i-closure-info/registration", will be passed to user space. bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB bob # [ 0.000000] software IO TLB: area num 1. bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) bob # [ 0.000000] Fallback order for Node 0: 0 bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 bob # [ 0.000000] Policy zone: DMA bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 bob # [ 0.000000] allocated 2097152 bytes of page_ext bob # [ 0.000000] ftrace: allocating 74884 entries in 294 pages bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups bob # [ 0.000000] rcu: Hierarchical RCU implementation. bob # [ 0.000000] rcu: RCU event tracing is enabled. bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. bob # [ 0.000000] Trampoline variant of Tasks RCU enabled. bob # [ 0.000000] Rude variant of Tasks RCU enabled. bob # [ 0.000000] Tracing variant of Tasks RCU enabled. bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 bob # [ 0.000000] GICv3: 256 SPIs implemented bob # [ 0.000000] GICv3: 0 Extended SPIs implemented alice # [ 0.000000] Linux version 6.18.46 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 23 12:27:10 UTC 2026 bob # [ 0.000000] Root IRQ handler: gic_handle_irq alice # [ 0.000000] KASLR enabled alice # [ 0.000000] random: crng init done bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 alice # [ 0.000000] Machine model: linux,dummy-virt bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 alice # [ 0.000000] efi: UEFI not found. bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f] alice # [ 0.000000] Zone ranges: bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] alice # [ 0.000000] DMA32 empty bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 alice # [ 0.000000] Normal empty alice # [ 0.000000] Device empty bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 alice # [ 0.000000] Movable zone start for each node alice # [ 0.000000] Early memory node ranges bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 alice # [ 0.000000] psci: probing for conduit method from DT. bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). alice # [ 0.000000] psci: PSCIv1.3 detected in firmware. alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns alice # [ 0.000000] psci: Trusted OS migration not required bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns alice # [ 0.000000] psci: SMC Calling Convention v1.1 bob # [ 0.000046] arm-pv: using stolen time PV alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) bob # [ 0.000341] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 bob # [ 0.000612] Console: colour dummy device 80x25 alice # [ 0.000000] Detected PIPT I-cache on CPU0 bob # [ 0.000624] printk: legacy console [tty0] enabled alice # [ 0.000000] CPU features: detected: GICv3 CPU interface alice # [ 0.000000] CPU features: detected: Spectre-v4 bob # [ 0.000845] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) alice # [ 0.000000] CPU features: detected: Spectre-BHB bob # [ 0.000851] pid_max: default: 32768 minimum: 301 alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR bob # [ 0.000928] LSM: initializing lsm=capability,landlock,yama,bpf,ima bob # [ 0.001049] landlock: Up and running. alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) bob # [ 0.001051] Yama: becoming mindful. alice # [ 0.000000] CPU features: detected: ARM erratum 1418040 bob # [ 0.001386] LSM support for eBPF active alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion bob # [ 0.001544] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing bob # [ 0.001563] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) alice # [ 0.000000] alternatives: applying boot alternatives bob # [ 0.003350] cacheinfo: Unable to detect cache hierarchy for CPU 0 bob # [ 0.004240] rcu: Hierarchical SRCU implementation. bob # [ 0.004245] rcu: Max phase no-delay instances is 1000. bob # [ 0.005197] fsl-mc MSI: its@8080000 domain created bob # [ 0.005355] EFI services will not be available. bob # [ 0.005436] smp: Bringing up secondary CPUs ... bob # [ 0.005464] smp: Brought up 1 node, 1 CPU alice # [ 0.000000] Kernel command line: console=ttyAMA0 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/hklypvhc4194rrwldqvywb5vgyg80akl-nixos-system-alice-test/init regInfo=/nix/store/rg45z54mbfb69r08fa27927chxnmkaj4-closure-info/registration console=ttyAMA0,115200n8 console=tty0 bob # [ 0.005466] SMP: Total of 1 processors activated. bob # [ 0.005468] CPU: All CPU(s) started at EL1 bob # [ 0.005480] CPU features: detected: 32-bit EL0 Support alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/rg45z54mbfb69r08fa27927chxnmkaj4-closure-info/registration", will be passed to user space. bob # [ 0.005483] CPU features: detected: Data cache clean to the PoU not required for I/D coherence alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes bob # [ 0.005486] CPU features: detected: Common not Private translations alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) bob # [ 0.005488] CPU features: detected: CRC32 instructions alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) bob # [ 0.005490] CPU features: detected: Data cache clean to Point of Persistence alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB bob # [ 0.005492] CPU features: detected: Enhanced Virtualization Traps alice # [ 0.000000] software IO TLB: area num 1. bob # [ 0.005502] CPU features: detected: RCpc load-acquire (LDAPR) bob # [ 0.005504] CPU features: detected: LSE atomic instructions alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) alice # [ 0.000000] Fallback order for Node 0: 0 bob # [ 0.005506] CPU features: detected: Privileged Access Never bob # [ 0.005508] CPU features: detected: PMUv3 alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 bob # [ 0.005510] CPU features: detected: RAS Extension Support alice # [ 0.000000] Policy zone: DMA bob # [ 0.005514] CPU features: detected: Speculative Store Bypassing Safe (SSBS) alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off bob # [ 0.005548] alternatives: applying system-wide alternatives alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 bob # [ 0.006997] CPU features: detected: Hardware dirty bit management on CPU0 alice # [ 0.000000] allocated 2097152 bytes of page_ext alice # [ 0.000000] ftrace: allocating 74884 entries in 294 pages alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups bob # [ 0.007157] Memory: 891560K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115744K reserved, 32768K cma-reserved) alice # [ 0.000000] rcu: Hierarchical RCU implementation. bob # [ 0.007611] devtmpfs: initialized alice # [ 0.000000] rcu: RCU event tracing is enabled. bob # [ 0.009115] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. alice # [ 0.000000] Trampoline variant of Tasks RCU enabled. bob # [ 0.009140] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). alice # [ 0.000000] Rude variant of Tasks RCU enabled. bob # [ 0.009273] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL alice # [ 0.000000] Tracing variant of Tasks RCU enabled. bob # [ 0.009277] 0 pages in range for non-PLT usage bob # [ 0.009278] 508288 pages in range for PLT usage alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. bob # [ 0.009417] pinctrl core: initialized pinctrl subsystem alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 bob # [ 0.010212] DMI not present or invalid. bob # [ 0.013548] NET: Registered PF_NETLINK/PF_ROUTE protocol family alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. bob # [ 0.016136] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. bob # [ 0.016269] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. bob # [ 0.016425] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 bob # [ 0.016442] audit: initializing netlink subsys (disabled) alice # [ 0.000000] GICv3: 256 SPIs implemented bob # [ 0.017006] thermal_sys: Registered thermal governor 'fair_share' bob # [ 0.017008] thermal_sys: Registered thermal governor 'bang_bang' alice # [ 0.000000] GICv3: 0 Extended SPIs implemented bob # [ 0.017011] thermal_sys: Registered thermal governor 'step_wise' alice # [ 0.000000] Root IRQ handler: gic_handle_irq alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI bob # [ 0.017014] thermal_sys: Registered thermal governor 'user_space' alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 bob # [ 0.017015] thermal_sys: Registered thermal governor 'power_allocator' alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 bob # [ 0.017041] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] bob # [ 0.017056] cpuidle: using governor ladder bob # [ 0.017061] cpuidle: using governor menu alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) bob # [ 0.017185] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. bob # [ 0.017206] ASID allocator initialised with 32768 entries alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) bob # [ 0.017911] Serial: AMBA PL011 UART driver alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 bob # [ 0.021130] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 bob # [ 0.021295] printk: console [ttyAMA0] enabled alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns alice # [ 0.000045] arm-pv: using stolen time PV alice # [ 0.000318] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) alice # [ 0.000564] Console: colour dummy device 80x25 alice # [ 0.000575] printk: legacy console [tty0] enabled alice # [ 0.000760] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) alice # [ 0.000765] pid_max: default: 32768 minimum: 301 alice # [ 0.000843] LSM: initializing lsm=capability,landlock,yama,bpf,ima alice # [ 0.000956] landlock: Up and running. alice # [ 0.000958] Yama: becoming mindful. alice # [ 0.001276] LSM support for eBPF active bob # [ 0.092698] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages bob # [ 0.092719] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page alice # [ 0.001408] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) bob # [ 0.092726] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages alice # [ 0.001428] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) bob # [ 0.092730] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page alice # [ 0.003179] cacheinfo: Unable to detect cache hierarchy for CPU 0 alice # [ 0.003891] rcu: Hierarchical SRCU implementation. bob # [ 0.092733] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages alice # [ 0.003896] rcu: Max phase no-delay instances is 1000. bob # [ 0.092736] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page alice # [ 0.004897] fsl-mc MSI: its@8080000 domain created bob # [ 0.092739] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages alice # [ 0.005043] EFI services will not be available. alice # [ 0.005131] smp: Bringing up secondary CPUs ... bob # [ 0.092742] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page alice # [ 0.005156] smp: Brought up 1 node, 1 CPU alice # [ 0.005159] SMP: Total of 1 processors activated. alice # [ 0.005161] CPU: All CPU(s) started at EL1 alice # [ 0.005172] CPU features: detected: 32-bit EL0 Support bob # [ 0.097722] fbcon: Taking over console alice # [ 0.005174] CPU features: detected: Data cache clean to the PoU not required for I/D coherence bob # [ 0.097740] ACPI: Interpreter disabled. alice # [ 0.005177] CPU features: detected: Common not Private translations bob # [ 0.098952] iommu: Default domain type: Translated alice # [ 0.005179] CPU features: detected: CRC32 instructions bob # [ 0.098962] iommu: DMA domain TLB invalidation policy: strict mode alice # [ 0.005181] CPU features: detected: Data cache clean to Point of Persistence bob # [ 0.100076] SCSI subsystem initialized alice # [ 0.005184] CPU features: detected: Enhanced Virtualization Traps alice # [ 0.005193] CPU features: detected: RCpc load-acquire (LDAPR) bob # [ 0.100616] usbcore: registered new interface driver usbfs alice # [ 0.005196] CPU features: detected: LSE atomic instructions bob # [ 0.100658] usbcore: registered new interface driver hub alice # [ 0.005198] CPU features: detected: Privileged Access Never bob # [ 0.100667] usbcore: registered new device driver usb alice # [ 0.005199] CPU features: detected: PMUv3 alice # [ 0.005201] CPU features: detected: RAS Extension Support alice # [ 0.005205] CPU features: detected: Speculative Store Bypassing Safe (SSBS) alice # [ 0.005236] alternatives: applying system-wide alternatives alice # [ 0.006715] CPU features: detected: Hardware dirty bit management on CPU0 alice # [ 0.006934] Memory: 891304K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115740K reserved, 32768K cma-reserved) alice # [ 0.007355] devtmpfs: initialized alice # [ 0.008728] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) alice # [ 0.008750] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). alice # [ 0.008869] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL alice # [ 0.008873] 0 pages in range for non-PLT usage alice # [ 0.008874] 508288 pages in range for PLT usage alice # [ 0.008984] pinctrl core: initialized pinctrl subsystem alice # [ 0.009691] DMI not present or invalid. alice # [ 0.012741] NET: Registered PF_NETLINK/PF_ROUTE protocol family alice # [ 0.015123] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations bob # [ 0.108906] pps_core: LinuxPPS API ver. 1 registered alice # [ 0.015253] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations bob # [ 0.108916] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti bob # [ 0.108944] PTP clock support registered bob # [ 0.108982] EDAC MC: Ver: 3.0.0 alice # [ 0.015403] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations alice # [ 0.015420] audit: initializing netlink subsys (disabled) bob # [ 0.110777] scmi_core: SCMI protocol bus registered alice # [ 0.015953] thermal_sys: Registered thermal governor 'fair_share' alice # [ 0.015956] thermal_sys: Registered thermal governor 'bang_bang' bob # [ 0.111498] FPGA manager framework alice # [ 0.015959] thermal_sys: Registered thermal governor 'step_wise' bob # [ 0.112492] vgaarb: loaded alice # [ 0.015961] thermal_sys: Registered thermal governor 'user_space' alice # [ 0.015963] thermal_sys: Registered thermal governor 'power_allocator' bob # [ 0.112957] clocksource: Switched to clocksource arch_sys_counter alice # [ 0.015986] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 alice # [ 0.016001] cpuidle: using governor ladder alice # [ 0.016006] cpuidle: using governor menu alice # [ 0.016139] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. alice # [ 0.016158] ASID allocator initialised with 32768 entries alice # [ 0.016809] Serial: AMBA PL011 UART driver alice # [ 0.019800] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 alice # [ 0.019951] printk: console [ttyAMA0] enabled bob # [ 0.119352] VFS: Disk quotas dquot_6.6.0 bob # [ 0.119387] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) bob # [ 0.121699] netfs: FS-Cache loaded bob # [ 0.121815] pnp: PnP ACPI: disabled alice # [ 0.093855] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages alice # [ 0.093875] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page alice # [ 0.093882] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages alice # [ 0.093885] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page bob # [ 0.124172] NET: Registered PF_INET protocol family alice # [ 0.093889] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages alice # [ 0.093892] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page bob # [ 0.124359] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) alice # [ 0.093895] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages alice # [ 0.093898] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page alice # [ 0.098962] fbcon: Taking over console alice # [ 0.098980] ACPI: Interpreter disabled. alice # [ 0.100198] iommu: Default domain type: Translated alice # [ 0.100208] iommu: DMA domain TLB invalidation policy: strict mode alice # [ 0.101363] SCSI subsystem initialized alice # [ 0.101924] usbcore: registered new interface driver usbfs alice # [ 0.101962] usbcore: registered new interface driver hub alice # [ 0.101972] usbcore: registered new device driver usb alice # [ 0.103436] pps_core: LinuxPPS API ver. 1 registered alice # [ 0.103449] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti alice # [ 0.103456] PTP clock support registered alice # [ 0.103487] EDAC MC: Ver: 3.0.0 alice # [ 0.110157] scmi_core: SCMI protocol bus registered alice # [ 0.110931] FPGA manager framework alice # [ 0.111937] vgaarb: loaded alice # [ 0.112365] clocksource: Switched to clocksource arch_sys_counter alice # [ 0.121434] VFS: Disk quotas dquot_6.6.0 alice # [ 0.121470] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) alice # [ 0.123762] netfs: FS-Cache loaded alice # [ 0.123884] pnp: PnP ACPI: disabled alice # [ 0.126235] NET: Registered PF_INET protocol family bob # [ 0.148081] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) alice # [ 0.126419] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) bob # [ 0.148110] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) bob # [ 0.148122] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) bob # [ 0.148161] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) bob # [ 0.148229] TCP: Hash tables configured (established 8192 bind 8192) bob # [ 0.148334] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) bob # [ 0.148387] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) bob # [ 0.148438] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) bob # [ 0.148546] NET: Registered PF_UNIX/PF_LOCAL protocol family bob # [ 0.148585] NET: Registered PF_XDP protocol family bob # [ 0.148616] PCI: CLS 0 bytes, default 64 bob # [ 0.148786] Trying to unpack rootfs image as initramfs... bob # [ 0.162946] kvm [1]: HYP mode not available alice # [ 0.150345] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) alice # [ 0.150374] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) alice # [ 0.150387] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) alice # [ 0.150425] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) alice # [ 0.150493] TCP: Hash tables configured (established 8192 bind 8192) alice # [ 0.150591] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) alice # [ 0.150620] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) alice # [ 0.150643] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) alice # [ 0.150770] NET: Registered PF_UNIX/PF_LOCAL protocol family alice # [ 0.150809] NET: Registered PF_XDP protocol family alice # [ 0.150830] PCI: CLS 0 bytes, default 64 alice # [ 0.151002] Trying to unpack rootfs image as initramfs... alice # [ 0.162515] kvm [1]: HYP mode not available bob # [ 0.226733] Initialise system trusted keyrings bob # [ 0.227241] workingset: timestamp_bits=42 max_order=18 bucket_order=0 bob # [ 0.228156] squashfs: version 4.0 (2009/01/31) Phillip Lougher bob # [ 0.228652] 9p: Installing v9fs 9p2000 file system support bob # [ 0.248060] Key type asymmetric registered bob # [ 0.248086] Asymmetric key parser 'x509' registered bob # [ 0.248137] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) alice # [ 0.226448] Initialise system trusted keyrings alice # [ 0.226949] workingset: timestamp_bits=42 max_order=18 bucket_order=0 alice # [ 0.227896] squashfs: version 4.0 (2009/01/31) Phillip Lougher bob # [ 0.257066] io scheduler mq-deadline registered bob # [ 0.257080] io scheduler kyber registered bob # [ 0.259907] pl061_gpio 9030000.pl061: PL061 GPIO chip registered bob # [ 0.260681] ledtrig-cpu: registered to indicate activity on CPUs bob # [ 0.261481] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: alice # [ 0.228418] 9p: Installing v9fs 9p2000 file system support bob # [ 0.261505] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 bob # [ 0.261519] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 bob # [ 0.261525] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 bob # [ 0.261563] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits bob # [ 0.261590] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] bob # [ 0.261663] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 bob # [ 0.261682] pci_bus 0000:00: root bus resource [bus 00-ff] bob # [ 0.261687] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] bob # [ 0.261690] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] bob # [ 0.261694] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] bob # [ 0.261770] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint bob # [ 0.262206] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint bob # [ 0.262336] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.262348] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.262368] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.262379] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] bob # [ 0.262690] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint bob # [ 0.262817] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.262828] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.262848] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.247278] Key type asymmetric registered bob # [ 0.263158] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint alice # [ 0.247300] Asymmetric key parser 'x509' registered bob # [ 0.263283] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] alice # [ 0.247347] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) bob # [ 0.263294] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.263314] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.263622] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint bob # [ 0.263747] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.263758] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.263778] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.264088] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint bob # [ 0.264211] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.264223] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.252465] io scheduler mq-deadline registered alice # [ 0.252480] io scheduler kyber registered bob # [ 0.264243] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.264550] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint bob # [ 0.264686] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] bob # [ 0.264697] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.264717] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.289114] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint bob # [ 0.289253] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.289264] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.289289] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.289300] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] bob # [ 0.289632] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint bob # [ 0.289762] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.289783] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.290101] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint alice # [ 0.260570] pl061_gpio 9030000.pl061: PL061 GPIO chip registered bob # [ 0.290230] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.260902] ledtrig-cpu: registered to indicate activity on CPUs bob # [ 0.290251] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.261221] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: bob # [ 0.290519] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint alice # [ 0.261242] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 bob # [ 0.290644] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] alice # [ 0.261257] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 bob # [ 0.290814] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint bob # [ 0.291025] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] alice # [ 0.261263] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 bob # [ 0.291038] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.261293] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits bob # [ 0.291059] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.261315] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] bob # [ 0.291383] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint alice # [ 0.261382] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 bob # [ 0.291513] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.291524] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.261401] pci_bus 0000:00: root bus resource [bus 00-ff] alice # [ 0.261405] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] bob # [ 0.291545] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.261409] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] bob # [ 0.291974] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned alice # [ 0.261413] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] bob # [ 0.291986] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned alice # [ 0.261498] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint bob # [ 0.291990] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned bob # [ 0.292025] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned alice # [ 0.261933] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint alice # [ 0.262066] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.292057] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned alice # [ 0.262078] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292091] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned alice # [ 0.262099] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292123] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned alice # [ 0.262110] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] bob # [ 0.292154] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned alice # [ 0.262434] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint bob # [ 0.292185] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned alice # [ 0.262564] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] alice # [ 0.262577] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292218] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned alice # [ 0.262598] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292248] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned alice # [ 0.262919] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint bob # [ 0.292279] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned alice # [ 0.263046] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] bob # [ 0.292362] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned alice # [ 0.263057] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292443] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned alice # [ 0.263079] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292458] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned alice # [ 0.263402] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint bob # [ 0.292472] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned alice # [ 0.263531] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.292486] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned alice # [ 0.263542] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292499] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned alice # [ 0.263561] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292513] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned alice # [ 0.263893] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint bob # [ 0.292528] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned alice # [ 0.264023] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.292542] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned alice # [ 0.264034] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292556] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned alice # [ 0.264055] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292570] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned alice # [ 0.264396] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint bob # [ 0.292584] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned alice # [ 0.264525] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] bob # [ 0.292605] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned alice # [ 0.264537] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292619] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned alice # [ 0.264557] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292632] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned alice # [ 0.264884] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint bob # [ 0.292646] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned alice # [ 0.265016] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] bob # [ 0.292659] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned alice # [ 0.265027] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292678] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned alice # [ 0.265051] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292692] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned alice # [ 0.265062] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] bob # [ 0.292705] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned bob # [ 0.292719] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned alice # [ 0.265391] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint bob # [ 0.292733] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned alice # [ 0.265523] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] bob # [ 0.292750] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] alice # [ 0.265544] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] bob # [ 0.292756] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] alice # [ 0.265870] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint bob # [ 0.292760] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] alice # [ 0.266001] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.266023] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.266311] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint alice # [ 0.266438] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] alice # [ 0.266617] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint alice # [ 0.266906] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] alice # [ 0.266921] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.266942] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.267268] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint alice # [ 0.267399] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] alice # [ 0.267410] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] alice # [ 0.267431] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] alice # [ 0.267865] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned alice # [ 0.267877] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned alice # [ 0.267882] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned alice # [ 0.267916] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned bob # [ 0.329617] pci 0000:00:0a.0: enabling device (0000 -> 0002) alice # [ 0.267949] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned alice # [ 0.267982] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned alice # [ 0.268015] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned alice # [ 0.268047] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned alice # [ 0.268080] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned alice # [ 0.268114] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned alice # [ 0.268146] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned alice # [ 0.268178] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned alice # [ 0.268266] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned alice # [ 0.268315] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned alice # [ 0.268330] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned bob # [ 0.336070] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) alice # [ 0.268344] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned alice # [ 0.268357] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned alice # [ 0.316439] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned alice # [ 0.316466] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned alice # [ 0.316481] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned alice # [ 0.316497] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned alice # [ 0.316512] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned bob # [ 0.345960] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) alice # [ 0.316527] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned bob # [ 0.348775] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) alice # [ 0.316542] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned alice # [ 0.316556] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned alice # [ 0.316571] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned alice # [ 0.316585] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned alice # [ 0.316599] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned alice # [ 0.316613] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned alice # [ 0.316631] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned alice # [ 0.316646] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned alice # [ 0.316660] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned alice # [ 0.316673] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned alice # [ 0.316687] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned alice # [ 0.316708] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] alice # [ 0.316714] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] alice # [ 0.316718] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] alice # [ 0.317484] pci 0000:00:0a.0: enabling device (0000 -> 0002) bob # [ 0.357970] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) bob # [ 0.360008] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) bob # [ 0.363333] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) alice # [ 0.341781] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) bob # [ 0.369066] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) alice # [ 0.343705] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) bob # [ 0.371910] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) alice # [ 0.346530] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) bob # [ 0.382353] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) bob # [ 0.384406] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) alice # [ 0.352799] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) alice # [ 0.355470] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) alice # [ 0.357179] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) alice # [ 0.358922] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) bob # [ 0.394058] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) bob # [ 0.398499] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled alice # [ 0.368815] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) alice # [ 0.370755] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) alice # [ 0.372361] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) bob # [ 0.405450] msm_serial: driver initialized bob # [ 0.405540] SuperH (H)SCI(F) driver initialized bob # [ 0.405576] STM32 USART driver initialized alice # [ 0.382787] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) alice # [ 0.389929] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled alice # [ 0.391389] msm_serial: driver initialized alice # [ 0.391473] SuperH (H)SCI(F) driver initialized alice # [ 0.391508] STM32 USART driver initialized bob # [ 0.425399] loop: module loaded bob # [ 0.425538] virtio_blk virtio5: 1/0/0 default/read/poll queues bob # [ 0.426106] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) bob # [ 0.429320] megasas: 07.734.00.00-rc1 bob # [ 0.429749] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] bob # [ 0.441896] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 bob # [ 0.441919] Intel/Sharp Extended Query Table at 0x0031 bob # [ 0.443476] Using buffer write method bob # [ 0.443527] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] alice # [ 0.417867] loop: module loaded alice # [ 0.418016] virtio_blk virtio5: 1/0/0 default/read/poll queues alice # [ 0.418618] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) bob # [ 0.448177] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 bob # [ 0.448198] Intel/Sharp Extended Query Table at 0x0031 bob # [ 0.450745] Using buffer write method bob # [ 0.450767] Concatenating MTD devices: bob # [ 0.450769] (0): "0.flash" bob # [ 0.450772] (1): "0.flash" bob # [ 0.450775] into device "0.flash" alice # [ 0.424758] megasas: 07.734.00.00-rc1 alice # [ 0.425194] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] alice # [ 0.429432] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 alice # [ 0.429452] Intel/Sharp Extended Query Table at 0x0031 alice # [ 0.430966] Using buffer write method alice # [ 0.431019] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] alice # [ 0.440383] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 alice # [ 0.440401] Intel/Sharp Extended Query Table at 0x0031 alice # [ 0.443747] Using buffer write method alice # [ 0.443769] Concatenating MTD devices: alice # [ 0.443771] (0): "0.flash" alice # [ 0.443774] (1): "0.flash" alice # [ 0.443777] into device "0.flash" bob # [ 0.645515] Freeing initrd memory: 26940K bob # [ 0.652138] tun: Universal TUN/TAP device driver, 1.6 bob # [ 0.654679] thunder_xcv, ver 1.0 bob # [ 0.654705] thunder_bgx, ver 1.0 bob # [ 0.654716] nicpf, ver 1.0 bob # [ 0.655005] e1000: Intel(R) PRO/1000 Network Driver bob # [ 0.655013] e1000: Copyright (c) 1999-2006 Intel Corporation. bob # [ 0.655036] e1000e: Intel(R) PRO/1000 Network Driver bob # [ 0.655043] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. bob # [ 0.655056] igb: Intel(R) Gigabit Ethernet Network Driver bob # [ 0.655059] igb: Copyright (c) 2007-2014 Intel Corporation. bob # [ 0.655069] igbvf: Intel(R) Gigabit Virtual Function Network Driver bob # [ 0.655073] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. bob # [ 0.655138] sky2: driver version 1.30 bob # [ 0.655909] usbcore: registered new interface driver usb-storage bob # [ 0.655999] usbcore: registered new interface driver usbserial_generic bob # [ 0.656008] usbserial: USB Serial support registered for generic bob # [ 0.656288] hv_vmbus: registering driver hyperv_keyboard bob # [ 0.657317] ehci-pci 0000:00:0a.0: EHCI Host Controller bob # [ 0.657346] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 bob # [ 0.657676] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 bob # [ 0.665540] rtc-pl031 9010000.pl031: registered as rtc0 bob # [ 0.665579] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T12:30:49 UTC (1788179449) bob # [ 0.665745] i2c_dev: i2c /dev entries driver bob # [ 0.668425] sdhci: Secure Digital Host Controller Interface driver bob # [ 0.668440] sdhci: Copyright(c) Pierre Ossman bob # [ 0.668575] Synopsys Designware Multimedia Card Interface Driver bob # [ 0.668789] sdhci-pltfm: SDHCI platform and OF driver helper bob # [ 0.668994] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 bob # [ 0.669344] hub 1-0:1.0: USB hub found bob # [ 0.669367] hub 1-0:1.0: 6 ports detected alice # [ 0.652704] Freeing initrd memory: 26936K alice # [ 0.659479] tun: Universal TUN/TAP device driver, 1.6 alice # [ 0.662054] thunder_xcv, ver 1.0 alice # [ 0.662082] thunder_bgx, ver 1.0 alice # [ 0.662093] nicpf, ver 1.0 alice # [ 0.662383] e1000: Intel(R) PRO/1000 Network Driver alice # [ 0.662391] e1000: Copyright (c) 1999-2006 Intel Corporation. alice # [ 0.662414] e1000e: Intel(R) PRO/1000 Network Driver alice # [ 0.662421] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. alice # [ 0.662435] igb: Intel(R) Gigabit Ethernet Network Driver alice # [ 0.662438] igb: Copyright (c) 2007-2014 Intel Corporation. alice # [ 0.662448] igbvf: Intel(R) Gigabit Virtual Function Network Driver alice # [ 0.662452] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. alice # [ 0.662515] sky2: driver version 1.30 alice # [ 0.663298] usbcore: registered new interface driver usb-storage alice # [ 0.663395] usbcore: registered new interface driver usbserial_generic alice # [ 0.663403] usbserial: USB Serial support registered for generic alice # [ 0.663680] hv_vmbus: registering driver hyperv_keyboard alice # [ 0.664706] ehci-pci 0000:00:0a.0: EHCI Host Controller alice # [ 0.664737] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 alice # [ 0.664923] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 alice # [ 0.672958] rtc-pl031 9010000.pl031: registered as rtc0 alice # [ 0.673002] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T12:30:49 UTC (1788179449) alice # [ 0.673172] i2c_dev: i2c /dev entries driver alice # [ 0.675910] sdhci: Secure Digital Host Controller Interface driver alice # [ 0.675927] sdhci: Copyright(c) Pierre Ossman alice # [ 0.676057] Synopsys Designware Multimedia Card Interface Driver alice # [ 0.676218] sdhci-pltfm: SDHCI platform and OF driver helper alice # [ 0.678139] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 alice # [ 0.678495] hub 1-0:1.0: USB hub found alice # [ 0.678518] hub 1-0:1.0: 6 ports detected alice # [ 0.680597] hid: raw HID events driver (C) Jiri Kosina bob # [ 0.673100] hid: raw HID events driver (C) Jiri Kosina bob # [ 0.673242] usbcore: registered new interface driver usbhid alice # [ 0.680742] usbcore: registered new interface driver usbhid bob # [ 0.673246] usbhid: USB HID core driver alice # [ 0.680747] usbhid: USB HID core driver alice # [ 0.689222] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available bob # [ 0.718064] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available alice # [ 0.689962] drop_monitor: Initializing network drop monitor service bob # [ 0.718863] drop_monitor: Initializing network drop monitor service alice # [ 0.690126] NET: Registered PF_INET6 protocol family bob # [ 0.718985] NET: Registered PF_INET6 protocol family alice # [ 0.692302] Segment Routing with IPv6 bob # [ 0.721294] Segment Routing with IPv6 alice # [ 0.692328] In-situ OAM (IOAM) with IPv6 bob # [ 0.721317] In-situ OAM (IOAM) with IPv6 alice # [ 0.693013] NET: Registered PF_PACKET protocol family bob # [ 0.721369] NET: Registered PF_PACKET protocol family alice # [ 0.693545] 9pnet: Installing 9P2000 support alice # [ 0.695047] Key type dns_resolver registered bob # [ 0.722414] 9pnet: Installing 9P2000 support bob # [ 0.723948] Key type dns_resolver registered bob # [ 0.727432] registered taskstats version 1 bob # [ 0.727604] Loading compiled-in X.509 certificates alice # [ 0.698519] registered taskstats version 1 alice # [ 0.698685] Loading compiled-in X.509 certificates bob # [ 0.732878] Demotion targets for Node 0: null alice # [ 0.704153] Demotion targets for Node 0: null bob # [ 0.732947] Key type .fscrypt registered alice # [ 0.704219] Key type .fscrypt registered bob # [ 0.732952] Key type fscrypt-provisioning registered alice # [ 0.704224] Key type fscrypt-provisioning registered alice # [ 0.704335] ima: No TPM chip found, activating TPM-bypass! bob # [ 0.734327] ima: No TPM chip found, activating TPM-bypass! alice # [ 0.704347] ima: Allocated hash algorithm: sha1 bob # [ 0.734346] ima: Allocated hash algorithm: sha1 bob # [ 0.734398] ima: No architecture policies found alice # [ 0.706352] ima: No architecture policies found bob # [ 0.735955] input: gpio-keys as /devices/platform/gpio-keys/input/input0 alice # [ 0.707191] input: gpio-keys as /devices/platform/gpio-keys/input/input0 bob # [ 0.746036] clk: Disabling unused clocks alice # [ 0.717482] clk: Disabling unused clocks bob # [ 0.746053] PM: genpd: Disabling unused power domains alice # [ 0.717499] PM: genpd: Disabling unused power domains bob # [ 0.749141] Freeing unused kernel memory: 4736K bob # [ 0.749227] Run /init as init process alice # [ 0.720640] Freeing unused kernel memory: 4736K alice # [ 0.720728] Run /init as init process bob # [ 0.771724] systemd[1]: Successfully made /usr/ read-only. alice # [ 0.743030] systemd[1]: Successfully made /usr/ read-only. bob # [ 0.941018] usb 1-1: new high-speed USB device number 2 using ehci-pci alice # [ 0.924424] usb 1-1: new high-speed USB device number 2 using ehci-pci bob # [ 1.092976] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 alice # [ 1.074440] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 bob # [ 1.106663] systemd[1]: systemd 261.1 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) bob # [ 1.114145] systemd[1]: Detected virtualization qemu. alice # [ 1.078185] systemd[1]: systemd 261.1 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) bob # [ 1.115270] systemd[1]: Detected architecture arm64. alice # [ 1.078229] systemd[1]: Detected virtualization qemu. bob # [ 1.116344] systemd[1]: Running in initrd. alice # [ 1.078274] systemd[1]: Detected architecture arm64. alice # [ 1.078290] systemd[1]: Running in initrd. bob # [ 1.118170] systemd[1]: Initializing machine ID from random generator. alice # [ 1.079043] systemd[1]: Initializing machine ID from random generator. bob # [ 1.119859] systemd[1]: Hostname set to . alice # [ 1.079326] systemd[1]: Hostname set to . bob # [ 1.177146] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 alice # [ 1.152546] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 bob # [ 1.296990] usb 1-2: new high-speed USB device number 3 using ehci-pci alice # [ 1.272419] usb 1-2: new high-speed USB device number 3 using ehci-pci bob # [ 1.385778] systemd[1]: bpf-restrict-fs: LSM BPF program attached alice # [ 1.361227] systemd[1]: bpf-restrict-fs: LSM BPF program attached bob # [ 1.449049] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 alice # [ 1.422307] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 bob # [ 1.451974] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 alice # [ 1.428523] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 bob # [ 1.486249] systemd[1]: Queued start job for default target Initrd Default Target. alice # [ 1.464076] systemd[1]: Queued start job for default target Initrd Default Target. bob # [ 1.494774] systemd[1]: Created slice Slice /system/modprobe. bob # [ 1.495650] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. bob # [ 1.496595] systemd[1]: Expecting device /dev/disk/by-label/nixos... bob # [ 1.497493] systemd[1]: Reached target Path Units. bob # [ 1.498088] systemd[1]: Reached target Slice Units. bob # [ 1.498679] systemd[1]: Reached target Swaps. bob # [ 1.499211] systemd[1]: Reached target Timer Units. bob # [ 1.500001] systemd[1]: Listening on D-Bus System Message Bus Socket. bob # [ 1.500914] systemd[1]: Listening on Journal Socket (/dev/log). bob # [ 1.501812] systemd[1]: Listening on Journal Sockets. bob # [ 1.502546] systemd[1]: Listening on udev Control Socket. bob # [ 1.503315] systemd[1]: Listening on udev Kernel Socket. bob # [ 1.503959] systemd[1]: Reached target Socket Units. alice # [ 1.474884] systemd[1]: Created slice Slice /system/modprobe. alice # [ 1.476546] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. bob # [ 1.505929] systemd[1]: Starting Create List of Static Device Nodes... alice # [ 1.477709] systemd[1]: Expecting device /dev/disk/by-label/nixos... alice # [ 1.478643] systemd[1]: Reached target Path Units. alice # [ 1.479361] systemd[1]: Reached target Slice Units. alice # [ 1.480136] systemd[1]: Reached target Swaps. alice # [ 1.480921] systemd[1]: Reached target Timer Units. alice # [ 1.481915] systemd[1]: Listening on D-Bus System Message Bus Socket. alice # [ 1.483065] systemd[1]: Listening on Journal Socket (/dev/log). bob # [ 1.512728] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 1.484182] systemd[1]: Listening on Journal Sockets. alice # [ 1.485168] systemd[1]: Listening on udev Control Socket. bob # [ 1.513667] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs alice # [ 1.486121] systemd[1]: Listening on udev Kernel Socket. alice # [ 1.486949] systemd[1]: Reached target Socket Units. alice # [ 1.489279] systemd[1]: Starting Create List of Static Device Nodes... alice # [ 1.492795] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 1.493783] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs bob # [ 1.525762] systemd[1]: Mounting Kernel Configuration File System... alice # [ 1.504569] systemd[1]: Mounting Kernel Configuration File System... bob # [ 1.541574] systemd[1]: Starting Journal Service... bob # [ 1.543105] systemd[1]: Starting Load Kernel Modules... bob # [ 1.543772] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os bob # [ 1.556491] systemd[1]: Starting Coldplug All udev Devices... alice # [ 1.532649] systemd[1]: Starting Journal Service... alice # [ 1.534521] systemd[1]: Starting Load Kernel Modules... alice # [ 1.535257] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os bob # [ 1.569076] systemd[1]: Finished Create List of Static Device Nodes. bob # [ 1.570187] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. bob # [ 1.570358] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 1.544475] systemd[1]: Starting Coldplug All udev Devices... bob # [ 1.577308] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... bob # [ 1.578092] systemd[1]: Mounted Kernel Configuration File System. alice # [ 1.557450] systemd[1]: Finished Create List of Static Device Nodes. alice # [ 1.558293] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 1.558469] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 1.558669] systemd[1]: Mounted Kernel Configuration File System. bob # [ 1.608483] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. alice # [ 1.580484] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... bob # [ 1.613141] systemd-journald[73]: Collecting audit messages is disabled. bob # [ 1.618935] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev bob # [ 1.624322] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 bob # [ 1.624740] [drm] features: -virgl +edid -resource_blob -host_visible alice # [ 1.596010] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. bob # [ 1.624746] [drm] features: -context_init alice # [ 1.597640] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. bob # [ 1.629332] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. alice # [ 1.600874] systemd-journald[73]: Collecting audit messages is disabled. bob # [ 1.633175] systemd[1]: Starting Create Static Device Nodes in /dev... alice # [ 1.605155] systemd[1]: Starting Create Static Device Nodes in /dev... alice # [ 1.612444] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev bob # [ 1.649337] [drm] number of scanouts: 1 bob # [ 1.649357] [drm] number of cap sets: 0 alice # [ 1.620591] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 alice # [ 1.620806] [drm] features: -virgl +edid -resource_blob -host_visible alice # [ 1.620811] [drm] features: -context_init alice # [ 1.621268] [drm] number of scanouts: 1 alice # [ 1.621282] [drm] number of cap sets: 0 bob # [ 1.650799] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic bob # [ 1.650813] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 bob # [ 1.665327] systemd[1]: Finished Create Static Device Nodes in /dev. bob # [ 1.665470] systemd[1]: Reached target Preparation for Local File Systems. bob # [ 1.665499] systemd[1]: Reached target Local File Systems. bob # [ 1.668079] systemd[1]: Starting Rule-based Manager for Device Events and Files... alice # [ 1.636648] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic alice # [ 1.636661] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 bob # [ 1.677305] Console: switching to colour frame buffer device 160x50 alice # [ 1.652772] systemd[1]: Finished Create Static Device Nodes in /dev. bob # [ 1.681982] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device alice # [ 1.653069] systemd[1]: Reached target Preparation for Local File Systems. alice # [ 1.653102] systemd[1]: Reached target Local File Systems. alice # [ 1.655657] systemd[1]: Starting Rule-based Manager for Device Events and Files... alice # [ 1.660715] Console: switching to colour frame buffer device 160x50 alice # [ 1.665397] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device bob # [ 1.701300] systemd[1]: Finished Load Kernel Modules. bob # [ 1.698379] systemd-modules-load[74]: Inserted module 'dm_mod' bob # [ 1.699232] systemd-modules-load[74]: Module 'virtio_balloon' is built in bob # [ 1.705280] systemd[1]: Starting Apply Kernel Variables... bob # [ 1.705438] systemd[1]: Started Journal Service. bob # [ 1.699986] systemd-modules-load[74]: Module 'virtio_console' is built in alice # [ 1.678453] systemd[1]: Finished Load Kernel Modules. bob # [ 1.703411] systemd-modules-load[74]: Inserted module 'virtio_gpu' alice # [ 1.680458] systemd[1]: Starting Apply Kernel Variables... bob # [ 1.708193] systemd-modules-load[74]: Module 'virtio_rng' is built in alice # [ 1.684191] systemd-modules-load[74]: Inserted module 'dm_mod' alice # [ 1.684951] systemd-modules-load[74]: Module 'virtio_balloon' is built in alice # [ 1.685709] systemd-modules-load[74]: Module 'virtio_console' is built in alice # [ 1.686407] systemd-modules-load[74]: Inserted module 'virtio_gpu' alice # [ 1.687038] systemd-modules-load[74]: Module 'virtio_rng' is built in alice # [ 1.700284] systemd[1]: Started Journal Service. bob # [ 1.735123] systemd[1]: Starting Create System Files and Directories... bob # [ 1.738678] systemd-udevd[80]: Using default interface naming scheme 'v261'. alice # [ 1.709103] systemd[1]: Starting Create System Files and Directories... bob # [ 1.748431] systemd[1]: Finished Apply Kernel Variables. bob # [ 1.756940] systemd[1]: Finished Create System Files and Directories. alice # [ 1.728595] systemd[1]: Finished Apply Kernel Variables. alice # [ 1.732247] systemd-udevd[80]: Using default interface naming scheme 'v261'. bob # [ 1.769410] systemd[1]: Started Rule-based Manager for Device Events and Files. alice # [ 1.737937] systemd[1]: Finished Create System Files and Directories. alice # [ 1.752061] systemd[1]: Started Rule-based Manager for Device Events and Files. bob # [ 1.807776] systemd[1]: Starting Virtual Console Setup... alice # [ 1.787193] systemd[1]: Starting Virtual Console Setup... bob # [ 1.840301] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. bob # [ 1.842615] systemd[1]: Finished Virtual Console Setup. alice # [ 1.824321] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. alice # [ 1.826479] systemd[1]: Finished Virtual Console Setup. bob # [ 2.053247] systemd[1]: Finished Coldplug All udev Devices. bob # [ 2.053863] systemd[1]: Reached target System Initialization. bob # [ 2.056452] systemd[1]: Reached target Basic System. alice # [ 2.056827] systemd[1]: Finished Coldplug All udev Devices. alice # [ 2.057416] systemd[1]: Reached target System Initialization. alice # [ 2.060157] systemd[1]: Reached target Basic System. bob # [ 2.139356] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. bob # [ 2.164759] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. alice # [ 2.138477] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. alice # [ 2.164912] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. bob # [ 2.215904] systemd[1]: Found device /dev/disk/by-label/nixos. bob # [ 2.225102] systemd[1]: Reached target Initrd Root Device. bob # [ 2.228898] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... alice # [ 2.215034] systemd[1]: Found device /dev/disk/by-label/nixos. alice # [ 2.217092] systemd[1]: Reached target Initrd Root Device. alice # [ 2.219119] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... bob # [ 2.269580] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks bob # [ 2.285291] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. alice # [ 2.264352] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks alice # [ 2.271148] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. bob # [ 2.564092] systemd[1]: Mounting /sysroot... alice # [ 2.552753] systemd[1]: Mounting /sysroot... bob # [ 2.589052] EXT4-fs (vda): mounted filesystem b831230d-1413-4128-a4e5-d926726902a4 r/w with ordered data mode. Quota mode: none. bob # [ 2.587092] systemd[1]: Mounted /sysroot. bob # [ 2.589835] systemd[1]: Reached target Initrd Root File System. bob # [ 2.591547] systemd[1]: Starting Mountpoints Configured in the Real Root... alice # [ 2.582461] EXT4-fs (vda): mounted filesystem c4ab55f6-310c-49d7-a08d-c55bd390ce71 r/w with ordered data mode. Quota mode: none. bob # [ 2.610302] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. alice # [ 2.581228] systemd[1]: Mounted /sysroot. alice # [ 2.581676] systemd[1]: Reached target Initrd Root File System. bob # [ 2.615238] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... alice # [ 2.584416] systemd[1]: Starting Mountpoints Configured in the Real Root... bob # [ 2.618680] systemd[1]: Reloading... alice # [ 2.602481] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. alice # [ 2.607856] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... alice # [ 2.611311] systemd[1]: Reloading... bob # [ 2.773602] systemd[1]: Reloading finished in 154 ms. bob # [ 2.800945] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... alice # [ 2.770714] systemd[1]: Reloading finished in 160 ms. bob # [ 2.804713] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... bob # [ 2.806441] systemd[1]: Starting Load Kernel Module 9pnet_virtio... bob # [ 2.811927] systemd[1]: initrd-parse-etc.service: Deactivated successfully. bob # [ 2.817454] systemd[1]: Finished Mountpoints Configured in the Real Root. bob # [ 2.818178] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. alice # [ 2.787641] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... alice # [ 2.789824] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... alice # [ 2.793440] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 2.794330] systemd[1]: initrd-parse-etc.service: Deactivated successfully. bob # [ 2.829153] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 2.797073] systemd[1]: Finished Mountpoints Configured in the Real Root. bob # [ 2.829813] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 2.798869] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. alice # [ 2.819028] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 2.819763] systemd[1]: Finished Load Kernel Module 9pnet_virtio. bob # [ 2.954766] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory bob # [ 2.958834] (udev-worker)[95]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory bob # [ 2.963373] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. bob # [ 2.967539] systemd[1]: Stopped Virtual Console Setup. bob # [ 2.968124] systemd[1]: Stopping Virtual Console Setup... bob # [ 2.968905] systemd[1]: Starting Virtual Console Setup... bob # [ 2.986497] systemd-vconsole-setup[140]: Configuration of first virtual console was skipped, ignoring remaining ones. bob # [ 2.988662] systemd[1]: Finished Virtual Console Setup. alice # [ 2.968684] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory alice # [ 2.972713] (udev-worker)[97]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory alice # [ 2.989081] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. alice # [ 2.991477] systemd[1]: Stopped Virtual Console Setup. alice # [ 2.992257] systemd[1]: Stopping Virtual Console Setup... alice # [ 2.995773] systemd[1]: Starting Virtual Console Setup... alice # [ 3.014365] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones. alice # [ 3.015909] systemd[1]: Finished Virtual Console Setup. bob # [ 3.565438] systemd[1]: Mounting /sysroot/nix/.ro-store... bob # [ 3.573567] systemd[1]: Mounting /sysroot/nix/.rw-store... bob # [ 3.584257] systemd[1]: Mounting /sysroot/run... alice # [ 3.554026] systemd[1]: Mounting /sysroot/nix/.ro-store... alice # [ 3.565609] systemd[1]: Mounting /sysroot/nix/.rw-store... alice # [ 3.567490] systemd[1]: Mounting /sysroot/run... bob # [ 3.602360] systemd[1]: Mounting /sysroot/tmp/shared... alice # [ 3.579997] systemd[1]: Mounting /sysroot/tmp/shared... bob # [ 3.616584] systemd[1]: Mounting /sysroot/tmp/xchg... alice # [ 3.596275] systemd[1]: Mounting /sysroot/tmp/xchg... bob # [ 3.641187] systemd[1]: Mounted /sysroot/nix/.ro-store. bob # [ 3.643393] systemd[1]: Mounted /sysroot/nix/.rw-store. bob # [ 3.647760] systemd[1]: Mounted /sysroot/run. bob # [ 3.656340] systemd[1]: Starting rw-sysroot-nix-store.service... bob # [ 3.660493] systemd[1]: Mounted /sysroot/tmp/shared. alice # [ 3.631077] systemd[1]: Mounted /sysroot/nix/.rw-store. bob # [ 3.663124] systemd[1]: Mounted /sysroot/tmp/xchg. alice # [ 3.637580] systemd[1]: Mounted /sysroot/nix/.ro-store. alice # [ 3.639914] systemd[1]: Mounted /sysroot/run. alice # [ 3.642367] systemd[1]: Mounted /sysroot/tmp/shared. alice # [ 3.648740] systemd[1]: Starting rw-sysroot-nix-store.service... bob # [ 3.681726] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. bob # [ 3.683275] systemd[1]: Finished rw-sysroot-nix-store.service. alice # [ 3.653769] systemd[1]: Mounted /sysroot/tmp/xchg. alice # [ 3.667145] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. alice # [ 3.668771] systemd[1]: Finished rw-sysroot-nix-store.service. bob # [ 4.562981] systemd[1]: Mounting /sysroot/nix/store... alice # [ 4.550966] systemd[1]: Mounting /sysroot/nix/store... bob # [ 4.605194] systemd[1]: Mounted /sysroot/nix/store. bob # [ 4.606959] systemd[1]: Reached target Initrd File Systems. bob # [ 4.611454] systemd[1]: Starting Find NixOS closure... bob # [ 4.620618] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... alice # [ 4.593714] systemd[1]: Mounted /sysroot/nix/store. alice # [ 4.595894] systemd[1]: Reached target Initrd File Systems. alice # [ 4.599619] systemd[1]: Starting Find NixOS closure... alice # [ 4.608352] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... bob # [ 4.663188] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. bob # [ 4.666530] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. alice # [ 4.646612] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. bob # [ 4.685137] systemd[1]: Finished Find NixOS closure. alice # [ 4.652352] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. bob # [ 4.687189] systemd[1]: Reached target Initrd Default Target. bob # [ 4.690805] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... alice # [ 4.667356] systemd[1]: Finished Find NixOS closure. alice # [ 4.669950] systemd[1]: Reached target Initrd Default Target. alice # [ 4.672208] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... bob # [ 4.717938] systemd[1]: Stopped target Initrd Default Target. bob # [ 4.719864] systemd[1]: Stopped target Basic System. bob # [ 4.721159] systemd[1]: Stopped target Initrd Root Device. bob # [ 4.722392] systemd[1]: Stopped target Path Units. bob # [ 4.724162] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. bob # [ 4.728201] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. bob # [ 4.729272] systemd[1]: Stopped target Slice Units. bob # [ 4.730212] systemd[1]: Stopped target Socket Units. bob # [ 4.732210] systemd[1]: Stopped target System Initialization. bob # [ 4.736179] systemd[1]: Stopped target Swaps. bob # [ 4.736795] systemd[1]: Stopped target Timer Units. bob # [ 4.737446] systemd[1]: dbus.socket: Deactivated successfully. bob # [ 4.738205] systemd[1]: Closed D-Bus System Message Bus Socket. bob # [ 4.738976] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. alice # [ 4.706545] systemd[1]: initrd-cleanup.service: Deactivated successfully. alice # [ 4.708090] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. alice # [ 4.711253] systemd[1]: Stopped target Initrd Default Target. alice # [ 4.713204] systemd[1]: Stopped target Basic System. bob # [ 4.739978] systemd[1]: Stopped Find NixOS closure. alice # [ 4.716211] systemd[1]: Stopped target Initrd Root Device. bob # [ 4.748723] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 4.717054] systemd[1]: Stopped target Path Units. bob # [ 4.749529] systemd[1]: Starting rw-sysroot-nix-store.service... bob # [ 4.750304] systemd[1]: systemd-sysctl.service: Deactivated successfully. alice # [ 4.718065] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. bob # [ 4.751168] systemd[1]: Stopped Apply Kernel Variables. bob # [ 4.751885] systemd[1]: systemd-modules-load.service: Deactivated successfully. alice # [ 4.724134] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. alice # [ 4.725259] systemd[1]: Stopped target Slice Units. alice # [ 4.725988] systemd[1]: Stopped target Socket Units. alice # [ 4.726747] systemd[1]: Stopped target System Initialization. alice # [ 4.727588] systemd[1]: Stopped target Swaps. bob # [ 4.763248] systemd[1]: Stopped Load Kernel Modules. alice # [ 4.732170] systemd[1]: Stopped target Timer Units. alice # [ 4.732891] systemd[1]: dbus.socket: Deactivated successfully. alice # [ 4.733686] systemd[1]: Closed D-Bus System Message Bus Socket. bob # [ 4.765864] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. alice # [ 4.734488] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. alice # [ 4.735560] systemd[1]: Stopped Find NixOS closure. bob # [ 4.769458] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. bob # [ 4.771864] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. alice # [ 4.740280] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 4.743091] systemd[1]: Starting rw-sysroot-nix-store.service... bob # [ 4.777418] systemd[1]: Stopped Create System Files and Directories. alice # [ 4.745333] systemd[1]: systemd-sysctl.service: Deactivated successfully. alice # [ 4.746634] systemd[1]: Stopped Apply Kernel Variables. bob # [ 4.779007] systemd[1]: Stopped target Local File Systems. alice # [ 4.747350] systemd[1]: systemd-modules-load.service: Deactivated successfully. bob # [ 4.781790] systemd[1]: Stopped target Preparation for Local File Systems. bob # [ 4.783428] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. bob # [ 4.785718] systemd[1]: Stopped Coldplug All udev Devices. bob # [ 4.787216] systemd[1]: Stopping Rule-based Manager for Device Events and Files... bob # [ 4.788612] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. alice # [ 4.757288] systemd[1]: Stopped Load Kernel Modules. alice # [ 4.757919] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. bob # [ 4.791245] systemd[1]: Stopped Virtual Console Setup. bob # [ 4.791949] systemd[1]: systemd-udevd.service: Deactivated successfully. bob # [ 4.793813] systemd[1]: Stopped Rule-based Manager for Device Events and Files. bob # [ 4.794457] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. bob # [ 4.795086] systemd[1]: Finished rw-sysroot-nix-store.service. bob # [ 4.795629] systemd[1]: initrd-cleanup.service: Deactivated successfully. alice # [ 4.764262] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. alice # [ 4.765721] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. bob # [ 4.799351] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. bob # [ 4.799970] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 4.768253] systemd[1]: Stopped Create System Files and Directories. alice # [ 4.768914] systemd[1]: Stopped target Local File Systems. bob # [ 4.800784] systemd[1]: Finished Load Kernel Module 9pnet_virtio. bob # [ 4.801385] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. bob # [ 4.802005] systemd[1]: Closed udev Control Socket. bob # [ 4.802447] systemd[1]: Starting Cleanup udev Database... bob # [ 4.802916] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. alice # [ 4.772284] systemd[1]: Stopped target Preparation for Local File Systems. alice # [ 4.772963] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. alice # [ 4.773638] systemd[1]: Stopped Coldplug All udev Devices. alice # [ 4.774180] systemd[1]: Stopping Rule-based Manager for Device Events and Files... bob # [ 4.803554] systemd[1]: Stopped Create Static Device Nodes in /dev. alice # [ 4.774854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. alice # [ 4.775568] systemd[1]: Stopped Virtual Console Setup. alice # [ 4.777042] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 4.777727] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 4.778305] systemd[1]: systemd-udevd.service: Deactivated successfully. alice # [ 4.778927] systemd[1]: Stopped Rule-based Manager for Device Events and Files. alice # [ 4.779709] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. bob # [ 4.812136] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. bob # [ 4.812849] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. bob # [ 4.813685] systemd[1]: kmod-static-nodes.service: Deactivated successfully. bob # [ 4.814347] systemd[1]: Stopped Create List of Static Device Nodes. alice # [ 4.780498] systemd[1]: Closed udev Control Socket. alice # [ 4.781063] systemd[1]: Starting Cleanup udev Database... alice # [ 4.781519] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. alice # [ 4.782137] systemd[1]: Stopped Create Static Device Nodes in /dev. alice # [ 4.782653] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. alice # [ 4.783290] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. alice # [ 4.788128] systemd[1]: kmod-static-nodes.service: Deactivated successfully. alice # [ 4.788777] systemd[1]: Stopped Create List of Static Device Nodes. bob # [ 4.823810] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. bob # [ 4.824824] systemd[1]: Finished Cleanup udev Database. bob # [ 4.825333] systemd[1]: Reached target Switch Root. alice # [ 4.792167] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. alice # [ 4.792893] systemd[1]: Finished rw-sysroot-nix-store.service. bob # [ 4.828808] systemd[1]: Starting NixOS Activation... alice # [ 4.803199] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. alice # [ 4.803906] systemd[1]: Finished Cleanup udev Database. alice # [ 4.807722] systemd[1]: Reached target Switch Root. alice # [ 4.808947] systemd[1]: Starting NixOS Activation... bob # [ 5.004875] initrd-nixos-activation-start[177]: booting system configuration /nix/store/mbyx6gscz2qj9k3sidmghvbfyz6dn512-nixos-system-bob-test alice # [ 4.994093] initrd-nixos-activation-start[178]: booting system configuration /nix/store/hklypvhc4194rrwldqvywb5vgyg80akl-nixos-system-alice-test bob # [ 5.070382] initrd-nixos-activation-start[177]: running activation script... alice # [ 5.062486] initrd-nixos-activation-start[178]: running activation script... bob # [ 5.512736] initrd-nixos-activation-start[200]: setting up /etc... alice # [ 5.514040] initrd-nixos-activation-start[201]: setting up /etc... bob # [ 5.764046] initrd-nixos-activation-start[200]: setting up age secrets... alice # [ 5.752375] initrd-nixos-activation-start[201]: setting up age secrets... alice # [ 5.903988] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. alice # [ 5.905711] systemd[1]: Finished NixOS Activation. alice # [ 5.908093] systemd[1]: Starting Switch Root... alice # [ 5.924433] systemd[1]: Switching root. bob # [ 5.958145] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. bob # [ 5.959870] systemd[1]: Finished NixOS Activation. bob # [ 5.960698] systemd[1]: Starting Switch Root... bob # [ 5.976562] systemd[1]: Switching root. alice # [ 6.106686] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). bob # [ 6.151265] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). bob # [ 6.739384] systemd[1]: systemd 261.1 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) bob # [ 6.746466] systemd[1]: Detected virtualization qemu. bob # [ 6.748154] systemd[1]: Detected architecture arm64. bob # [ 6.750167] systemd[1]: Detected first boot. alice # [ 6.718732] systemd[1]: systemd 261.1 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) alice # [ 6.725803] systemd[1]: Detected virtualization qemu. bob # [ 6.755595] systemd[1]: Initializing machine ID from random generator. alice # [ 6.727495] systemd[1]: Detected architecture arm64. alice # [ 6.729781] systemd[1]: Detected first boot. alice # [ 6.734808] systemd[1]: Initializing machine ID from random generator. bob # [ 7.044825] systemd[1]: bpf-restrict-fs: LSM BPF program attached alice # [ 7.024293] systemd[1]: bpf-restrict-fs: LSM BPF program attached bob # [ 7.227449] systemd[1]: Applying preset policy. alice # [ 7.199719] systemd[1]: Applying preset policy. bob # [ 7.755627] systemd[1]: Populated /etc with preset unit settings. alice # [ 7.733773] systemd[1]: Populated /etc with preset unit settings. bob # [ 8.290266] systemd[1]: initrd-switch-root.service: Deactivated successfully. bob # [ 8.291111] systemd[1]: Stopped initrd-switch-root.service. bob # [ 8.293121] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. bob # [ 8.295830] systemd[1]: Created slice Slice /system/getty. bob # [ 8.297397] systemd[1]: Created slice User and Session Slice. bob # [ 8.298578] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. alice # [ 8.270889] systemd[1]: initrd-switch-root.service: Deactivated successfully. bob # [ 8.299876] systemd[1]: Started Forward Password Requests to Wall Directory Watch. alice # [ 8.271760] systemd[1]: Stopped initrd-switch-root.service. bob # [ 8.301275] systemd[1]: Expecting device /dev/hvc0... bob # [ 8.302306] systemd[1]: Expecting device /dev/ttyAMA0... alice # [ 8.273841] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. bob # [ 8.303738] systemd[1]: Reached target Local Encrypted Volumes. alice # [ 8.276711] systemd[1]: Created slice Slice /system/getty. bob # [ 8.305246] systemd[1]: Stopped target initrd-fs.target. bob # [ 8.306143] systemd[1]: Stopped target initrd-root-fs.target. alice # [ 8.277675] systemd[1]: Created slice User and Session Slice. alice # [ 8.278394] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. bob # [ 8.307140] systemd[1]: Stopped target initrd-switch-root.target. alice # [ 8.279689] systemd[1]: Started Forward Password Requests to Wall Directory Watch. bob # [ 8.308666] systemd[1]: Reached target Virtual Machines and Containers. alice # [ 8.281024] systemd[1]: Expecting device /dev/hvc0... bob # [ 8.310344] systemd[1]: Reached target Path Units. alice # [ 8.282065] systemd[1]: Expecting device /dev/ttyAMA0... alice # [ 8.283094] systemd[1]: Reached target Local Encrypted Volumes. bob # [ 8.311686] systemd[1]: Reached target Remote File Systems. bob # [ 8.313127] systemd[1]: Reached target Slice Units. alice # [ 8.284127] systemd[1]: Stopped target initrd-fs.target. bob # [ 8.313960] systemd[1]: Reached target Swaps. alice # [ 8.285141] systemd[1]: Stopped target initrd-root-fs.target. alice # [ 8.286114] systemd[1]: Stopped target initrd-switch-root.target. alice # [ 8.287651] systemd[1]: Reached target Virtual Machines and Containers. bob # [ 8.317459] systemd[1]: Listening on Query the User Interactively for a Password. alice # [ 8.289321] systemd[1]: Reached target Path Units. alice # [ 8.290174] systemd[1]: Reached target Remote File Systems. alice # [ 8.291649] systemd[1]: Reached target Slice Units. bob # [ 8.321666] systemd[1]: Listening on Process Core Dump Socket. alice # [ 8.293094] systemd[1]: Reached target Swaps. bob # [ 8.325101] systemd[1]: Listening on Credential Encryption/Decryption. alice # [ 8.296708] systemd[1]: Listening on Query the User Interactively for a Password. bob # [ 8.328519] systemd[1]: Listening on Factory Reset Management. bob # [ 8.329579] systemd[1]: Listening on Hostname Service Socket. alice # [ 8.301126] systemd[1]: Listening on Process Core Dump Socket. alice # [ 8.304615] systemd[1]: Listening on Credential Encryption/Decryption. bob # [ 8.333888] systemd[1]: Starting Journal Log Access Socket... bob # [ 8.335422] systemd[1]: Listening on Journal Audit Socket. alice # [ 8.308249] systemd[1]: Listening on Factory Reset Management. alice # [ 8.309253] systemd[1]: Listening on Hostname Service Socket. bob # [ 8.339093] systemd[1]: Listening on Console Output Muting Service Socket. bob # [ 8.340199] systemd[1]: Listening on Network Management Metrics Varlink Socket. bob # [ 8.341629] systemd[1]: Listening on Network Management Varlink Socket. alice # [ 8.313670] systemd[1]: Starting Journal Log Access Socket... bob # [ 8.343323] systemd[1]: Listening on Network Management Netlink Socket. alice # [ 8.315201] systemd[1]: Listening on Journal Audit Socket. bob # [ 8.345032] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. bob # [ 8.346658] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os alice # [ 8.319174] systemd[1]: Listening on Console Output Muting Service Socket. bob # [ 8.348857] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki alice # [ 8.321115] systemd[1]: Listening on Network Management Metrics Varlink Socket. alice # [ 8.322855] systemd[1]: Listening on Network Management Varlink Socket. alice # [ 8.324553] systemd[1]: Listening on Network Management Netlink Socket. alice # [ 8.326532] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. alice # [ 8.328178] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os alice # [ 8.329905] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki bob # [ 8.358509] systemd[1]: Listening on Disk Repartitioning Service Socket. bob # [ 8.358961] systemd[1]: Listening on Resolve Monitor Varlink Socket. bob # [ 8.359299] systemd[1]: Listening on Resolve Service Varlink Socket. bob # [ 8.359624] systemd[1]: Listening on udev Control Socket. bob # [ 8.359952] systemd[1]: Listening on udev Varlink Socket. bob # [ 8.365135] systemd[1]: Mounting Huge Pages File System... bob # [ 8.368382] systemd[1]: Mounting POSIX Message Queue File System... alice # [ 8.340306] systemd[1]: Listening on Disk Repartitioning Service Socket. alice # [ 8.341921] systemd[1]: Listening on Resolve Monitor Varlink Socket. alice # [ 8.343474] systemd[1]: Listening on Resolve Service Varlink Socket. alice # [ 8.345176] systemd[1]: Listening on udev Control Socket. alice # [ 8.346647] systemd[1]: Listening on udev Varlink Socket. bob # [ 8.377413] systemd[1]: Mounting Kernel Debug File System... alice # [ 8.350552] systemd[1]: Mounting Huge Pages File System... bob # [ 8.381078] systemd[1]: Mounting Kernel Trace File System... alice # [ 8.354399] systemd[1]: Mounting POSIX Message Queue File System... bob # [ 8.389284] systemd[1]: Starting Create List of Static Device Nodes... alice # [ 8.360485] systemd[1]: Mounting Kernel Debug File System... alice # [ 8.371392] systemd[1]: Mounting Kernel Trace File System... bob # [ 8.400672] systemd[1]: Starting Load Kernel Module 9pnet_virtio... bob # [ 8.402850] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs alice # [ 8.381622] systemd[1]: Starting Create List of Static Device Nodes... bob # [ 8.411914] systemd[1]: Mounting Kernel Configuration File System... bob # [ 8.414425] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm alice # [ 8.389049] systemd[1]: Starting Load Kernel Module 9pnet_virtio... alice # [ 8.390205] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs bob # [ 8.419463] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore bob # [ 8.434494] systemd[1]: Starting Load Kernel Module fuse... alice # [ 8.406305] systemd[1]: Mounting Kernel Configuration File System... bob # [ 8.437153] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 alice # [ 8.409730] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm alice # [ 8.411674] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore alice # [ 8.419884] systemd[1]: Starting Load Kernel Module fuse... alice # [ 8.421657] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 bob # [ 8.493071] systemd[1]: Starting Journal Service... alice # [ 8.474534] systemd[1]: Starting Journal Service... bob # [ 8.512020] systemd[1]: Starting Load Kernel Modules... alice # [ 8.500008] systemd[1]: Starting Load Kernel Modules... bob # [ 8.543718] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... bob # [ 8.557757] systemd[1]: Starting Remount Root and Kernel File Systems... bob # [ 8.560606] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os alice # [ 8.538390] fuse: init (API version 7.45) alice # [ 8.538913] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... bob # [ 8.577482] systemd[1]: Starting Coldplug All udev Devices... alice # [ 8.550402] systemd[1]: Starting Remount Root and Kernel File Systems... alice # [ 8.553924] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os bob # [ 8.590754] systemd[1]: Listening on Journal Log Access Socket. bob # [ 8.599954] fuse: init (API version 7.45) bob # [ 8.609158] systemd[1]: Mounted Huge Pages File System. bob # [ 8.611949] systemd[1]: Mounted POSIX Message Queue File System. bob # [ 8.615343] systemd[1]: Mounted Kernel Debug File System. alice # [ 8.588566] systemd[1]: Starting Coldplug All udev Devices... bob # [ 8.618294] systemd[1]: Mounted Kernel Trace File System. bob # [ 8.621921] systemd[1]: Finished Create List of Static Device Nodes. alice # [ 8.596187] systemd[1]: Listening on Journal Log Access Socket. bob # [ 8.626931] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. bob # [ 8.635038] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 8.607811] systemd[1]: Mounted Huge Pages File System. bob # [ 8.639822] systemd[1]: Mounted Kernel Configuration File System. alice # [ 8.614664] systemd[1]: Mounted POSIX Message Queue File System. bob # [ 8.645827] systemd[1]: modprobe@fuse.service: Deactivated successfully. alice # [ 8.619358] systemd[1]: Mounted Kernel Debug File System. bob # [ 8.648748] systemd[1]: Finished Load Kernel Module fuse. alice # [ 8.622008] systemd-journald[287]: Collecting audit messages is enabled. bob # [ 8.652880] systemd-journald[294]: Collecting audit messages is enabled. alice # [ 8.625831] systemd[1]: Mounted Kernel Trace File System. bob # [ 8.657124] systemd[1]: Finished Load Kernel Modules. alice # [ 8.634152] systemd[1]: Finished Create List of Static Device Nodes. bob # [ 8.663339] systemd[1]: Mounting FUSE Control File System... alice # [ 8.636829] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. alice # [ 8.639482] systemd[1]: Finished Load Kernel Module 9pnet_virtio. alice # [ 8.640086] systemd[1]: Mounted Kernel Configuration File System. alice # [ 8.642940] systemd[1]: modprobe@fuse.service: Deactivated successfully. alice # [ 8.636489] systemd[1]: Queued start job for default target Multi-User System. alice # [ 8.638002] systemd[1]: systemd-journald.service: Deactivated successfully. bob # [ 8.669271] systemd[1]: Queued start job for default target Multi-User System. bob # [ 8.673634] systemd[1]: systemd-journald.service: Deactivated successfully. bob # [ 8.674418] systemd-modules-load[295]: Module 'atkbd' is built in bob # [ 8.675060] systemd-modules-load[295]: Module 'loop' is built in alice # [ 8.649309] systemd[1]: Finished Load Kernel Module fuse. alice # [ 8.649861] systemd[1]: Started Journal Service. bob # [ 8.683397] systemd[1]: Starting Firewall... alice # [ 8.648214] systemd-modules-load[288]: Module 'atkbd' is built in alice # [ 8.649359] systemd-modules-load[288]: Module 'loop' is built in alice # [ 8.651221] systemd[1]: Finished Load Kernel Modules. alice # [ 8.656637] systemd[1]: Mounting FUSE Control File System... bob # [ 8.701120] EXT4-fs (vda): re-mounted b831230d-1413-4128-a4e5-d926726902a4. alice # [ 8.670675] systemd[1]: Starting Firewall... bob # [ 8.708054] systemd[1]: Starting Apply Kernel Variables... bob # [ 8.720284] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... alice # [ 8.683624] systemd[1]: Starting Apply Kernel Variables... bob # [ 8.723546] systemd[1]: Started Journal Service. alice # [ 8.696499] EXT4-fs (vda): re-mounted c4ab55f6-310c-49d7-a08d-c55bd390ce71. alice # [ 8.700722] systemd-oomd[289]: No swap; memory pressure usage will be degraded alice # [ 8.704882] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... bob # [ 8.737099] systemd-oomd[296]: No swap; memory pressure usage will be degraded bob # [ 8.740072] systemd[1]: Finished Remount Root and Kernel File Systems. bob # [ 8.746758] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. alice # [ 8.716068] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. alice # [ 8.725278] systemd[1]: Finished Remount Root and Kernel File Systems. bob # [ 8.801008] systemd[1]: Listening on Disk Image Download Service Socket. bob # [ 8.808326] systemd[1]: Starting Flush Journal to Persistent Storage... bob # [ 8.810101] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore alice # [ 8.782163] systemd[1]: Listening on Disk Image Download Service Socket. bob # [ 8.823519] systemd[1]: Starting Load/Save OS Random Seed... alice # [ 8.795533] systemd[1]: Starting Flush Journal to Persistent Storage... bob # [ 8.831001] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os alice # [ 8.799094] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore alice # [ 8.805522] systemd[1]: Starting Load/Save OS Random Seed... bob # [ 8.839728] systemd[1]: Mounted FUSE Control File System. alice # [ 8.812255] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os alice # [ 8.816785] systemd[1]: Mounted FUSE Control File System. bob # [ 8.869072] systemd[1]: Finished Apply Kernel Variables. alice # [ 8.846693] systemd[1]: Finished Apply Kernel Variables. bob # [ 8.886353] systemd-journald[294]: Received client request to flush runtime journal. alice # [ 8.855072] systemd[1]: Starting Network Name Resolution... alice # [ 8.911041] systemd-journald[287]: Received client request to flush runtime journal. bob # [ 8.968321] systemd[1]: Starting Network Name Resolution... bob # [ 8.978530] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. bob # [ 8.979324] systemd[1]: Starting Create Static Device Nodes in /dev... bob # [ 8.981879] systemd[1]: Finished Load/Save OS Random Seed. bob # [ 8.985201] systemd[1]: Reached target First Boot Complete. bob # [ 8.988711] systemd[1]: Finished Flush Journal to Persistent Storage. alice # [ 8.972798] systemd[1]: Finished Load/Save OS Random Seed. alice # [ 8.979982] systemd[1]: Reached target First Boot Complete. alice # [ 8.984492] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. alice # [ 8.988779] systemd[1]: Starting Create Static Device Nodes in /dev... alice # [ 8.995225] systemd[1]: Finished Flush Journal to Persistent Storage. bob # [ 9.046423] systemd[1]: Finished Create Static Device Nodes in /dev. bob # [ 9.047072] systemd[1]: Reached target Preparation for Local File Systems. bob # [ 9.049461] systemd[1]: Starting Rule-based Manager for Device Events and Files... bob # [ 9.072458] systemd-resolved[324]: Positive Trust Anchors: bob # [ 9.073589] systemd-resolved[324]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d alice # [ 9.043221] systemd-resolved[317]: Positive Trust Anchors: bob # [ 9.075991] systemd-resolved[324]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 alice # [ 9.045313] systemd-resolved[317]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d alice # [ 9.048380] systemd-resolved[317]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 bob # [ 9.082282] systemd-resolved[324]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test alice # [ 9.053277] systemd-resolved[317]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test alice # [ 9.081090] systemd[1]: Finished Create Static Device Nodes in /dev. alice # [ 9.082235] systemd[1]: Reached target Preparation for Local File Systems. alice # [ 9.085497] systemd[1]: Starting Rule-based Manager for Device Events and Files... bob # [ 9.192621] systemd-udevd[337]: Using default interface naming scheme 'v261'. alice # [ 9.189370] systemd-udevd[331]: Using default interface naming scheme 'v261'. bob # [ 9.290631] systemd[1]: Mounting /run/wrappers... alice # [ 9.273753] systemd[1]: Mounting /run/wrappers... bob # [ 9.311649] systemd-resolved[324]: Using system hostname 'bob'. bob # [ 9.320535] systemd[1]: Started Network Name Resolution. bob # [ 9.354005] systemd[1]: Mounted /run/wrappers. bob # [ 9.356207] systemd[1]: Reached target Local File Systems. alice # [ 9.325817] systemd-resolved[317]: Using system hostname 'alice'. alice # [ 9.332822] systemd[1]: Started Network Name Resolution. bob # [ 9.367323] systemd[1]: Listening on Boot Loader Control Service Socket. bob # [ 9.373436] systemd[1]: Starting register-nix-paths.service... bob # [ 9.382663] systemd[1]: Starting Create SUID/SGID Wrappers... bob # [ 9.383830] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. alice # [ 9.354529] systemd[1]: Mounted /run/wrappers. alice # [ 9.355816] systemd[1]: Reached target Local File Systems. bob # [ 9.392365] systemd[1]: Starting Save Transient machine-id to Disk... alice # [ 9.360113] systemd[1]: Listening on Boot Loader Control Service Socket. alice # [ 9.364292] systemd[1]: Starting register-nix-paths.service... alice # [ 9.372156] systemd[1]: Starting Create SUID/SGID Wrappers... alice # [ 9.372723] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. alice # [ 9.379630] systemd[1]: Starting Save Transient machine-id to Disk... bob # [ 9.414493] systemd[1]: Starting Create System Files and Directories... bob # [ 9.417963] systemd[1]: Started Rule-based Manager for Device Events and Files. alice # [ 9.419179] systemd[1]: Starting Create System Files and Directories... alice # [ 9.427924] systemd[1]: Started Rule-based Manager for Device Events and Files. bob # [ 9.572208] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. bob # [ 9.588472] systemd[1]: Finished Save Transient machine-id to Disk. alice # [ 9.550817] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. alice # [ 9.561787] systemd[1]: Finished Save Transient machine-id to Disk. bob # [ 9.625421] systemd[1]: Finished Create System Files and Directories. alice # [ 9.594129] systemd[1]: Finished Create System Files and Directories. bob # [ 9.642325] systemd[1]: Starting Rebuild Journal Catalog... alice # [ 9.610636] systemd[1]: Starting Rebuild Journal Catalog... alice # [ 9.613445] systemd[1]: Starting Record System Boot/Shutdown in UTMP... bob # [ 9.646353] systemd[1]: Starting Record System Boot/Shutdown in UTMP... alice # [ 9.723925] systemd[1]: Finished Record System Boot/Shutdown in UTMP. bob # [ 9.782452] systemd[1]: Finished Record System Boot/Shutdown in UTMP. bob # [ 9.790022] systemd[1]: Finished Coldplug All udev Devices. bob # [ 9.810302] systemd[1]: Finished Rebuild Journal Catalog. bob # [ 9.816126] systemd[1]: Starting Update is Completed... alice # [ 9.795611] systemd[1]: Finished Coldplug All udev Devices. alice # [ 9.802438] systemd[1]: Finished Rebuild Journal Catalog. alice # [ 9.811223] systemd[1]: Starting Update is Completed... bob # [ 9.870521] systemd[1]: Finished Update is Completed. alice # [ 9.870867] systemd[1]: Finished Update is Completed. bob # [ 9.937697] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs alice # [ 10.000187] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs bob # [ 10.198762] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. alice # [ 10.209485] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. alice # [ 10.211774] systemd[1]: Finished Create SUID/SGID Wrappers. bob # [ 10.265797] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. bob # [ 10.272231] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. bob # [ 10.275184] systemd[1]: Finished Create SUID/SGID Wrappers. alice # [ 10.292886] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. alice # [ 10.329083] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. bob # [ 10.529512] (udev-worker)[372]: Network interface NamePolicy= disabled on kernel command line. bob # [ 10.542843] (udev-worker)[376]: Network interface NamePolicy= disabled on kernel command line. alice # [ 10.549338] systemd[1]: Finished Firewall. alice # [ 10.552507] systemd[1]: Reached target Preparation for Network. alice # [ 10.554312] systemd[1]: Listening on Network Management Resolve Hook Socket. alice # [ 10.556486] systemd[1]: Starting Network Management... alice # [ 10.570020] systemd[1]: Finished register-nix-paths.service. alice # [ 10.571404] systemd[1]: Reached target System Initialization. bob # [ 10.605213] systemd[1]: Finished register-nix-paths.service. alice # [ 10.572918] systemd[1]: Started Discard unused filesystem blocks once a week. alice # [ 10.574574] systemd[1]: Started Daily Cleanup of Temporary Directories. bob # [ 10.607170] systemd[1]: Reached target System Initialization. alice # [ 10.576188] systemd[1]: Reached target Timer Units. alice # [ 10.577346] systemd[1]: Listening on D-Bus System Message Bus Socket. alice # [ 10.578774] systemd[1]: Listening on Nix Daemon Socket. bob # [ 10.610833] systemd[1]: Started Discard unused filesystem blocks once a week. alice # [ 10.579761] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. bob # [ 10.612731] systemd[1]: Started Daily Cleanup of Temporary Directories. bob # [ 10.614237] systemd[1]: Reached target Timer Units. alice # [ 10.583364] systemd[1]: Reached target Socket Units. bob # [ 10.615318] systemd[1]: Listening on D-Bus System Message Bus Socket. alice # [ 10.586772] systemd[1]: Reached target Basic System. bob # [ 10.619533] systemd[1]: Listening on harmonia binary cache socket. alice # [ 10.589753] systemd[1]: Started backdoor.service. bob # [ 10.621947] systemd[1]: Listening on Nix Daemon Socket. bob # [ 10.624723] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. alice # [ 10.592747] systemd[1]: Starting Import lastlog data into lastlog2 database... bob # [ 10.627823] systemd[1]: Reached target Socket Units. bob # [ 10.631190] systemd[1]: Reached target Basic System. bob # [ 10.633506] systemd[1]: Started backdoor.service. bob # [ 10.637071] systemd[1]: Starting Import lastlog data into lastlog2 database... alice # [ 10.605811] systemd[1]: Starting Name Service Cache Daemon (nsncd)... bob # [ 10.643590] systemd[1]: Starting Name Service Cache Daemon (nsncd)... alice # [ 10.622701] (udev-worker)[436]: Network interface NamePolicy= disabled on kernel command line. alice # [ 10.626466] (udev-worker)[365]: Network interface NamePolicy= disabled on kernel command line. bob # [ 10.661401] systemd[1]: Starting Post-Boot Actions... alice # [ 10.633424] systemd[1]: Starting Post-Boot Actions... bob # [ 10.667951] systemd[1]: Started Reset console on configuration changes. bob # [ 10.676223] systemd[1]: Finished Firewall. alice # [ 10.655326] systemd[1]: Started Reset console on configuration changes. bob # [ 10.712776] systemd[1]: Reached target Preparation for Network. bob # [ 10.714209] systemd[1]: Listening on Network Management Resolve Hook Socket. bob # [ 10.725088] systemd[1]: Starting D-Bus System Message Bus... bob # [ 10.738288] systemd[1]: Starting Network Management... alice # [ 10.721670] systemd[1]: Finished Post-Boot Actions. bob # connecting to host... bob # [ 10.779334] systemd[1]: Finished Post-Boot Actions. alice # [ 10.751634] systemd[1]: Starting D-Bus System Message Bus... bob # [ 10.785724] nsncd[520]: Aug 31 12:30:59.623 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" bob # [ 10.794919] mousedev: PS/2 mouse device common for all mice bob # [ 10.793471] systemd[1]: Started Name Service Cache Daemon (nsncd). bob # [ 10.795667] systemd[1]: Reached target Host and Network Name Lookups. bob # [ 10.799133] systemd[1]: Reached target User and Group Name Lookups. alice # connecting to host... bob # [ 10.812169] systemd[1]: Starting User Login Management... alice # [ 10.779543] nsncd[512]: Aug 31 12:30:59.614 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" alice # [ 10.786953] systemd[1]: Started Name Service Cache Daemon (nsncd). alice # [ 10.791975] systemd[1]: Reached target Host and Network Name Lookups. alice # [ 10.797159] systemd[1]: Reached target User and Group Name Lookups. bob: Guest shell says: b'Spawning backdoor root shell...\n' alice # [ 10.808674] systemd[1]: Starting User Login Management... alice # [ 10.813550] systemd[1]: Finished Import lastlog data into lastlog2 database. bob # [ 10.849162] systemd[1]: Finished Import lastlog data into lastlog2 database. bob: connected to guest root shell bob: (connecting took 11.11 seconds) bob: (finished: waiting for the VM to finish booting, in 11.11 seconds) alice # [ 10.903019] cfg80211: Loading compiled-in X.509 certificates for regulatory database bob # [ 10.973757] systemd-logind[545]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) alice # [ 10.954838] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' alice # [ 10.955349] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' bob # [ 10.979724] systemd-logind[545]: Watching system buttons on /dev/input/event0 (gpio-keys) bob # [ 10.984289] systemd-logind[545]: New seat seat0. bob # [ 10.984845] systemd[1]: Started User Login Management. alice # [ 10.960656] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 alice # [ 10.961024] cfg80211: failed to load regulatory.db bob # [ 10.986504] systemd[1]: Starting linger-users.service... alice # [ 10.969008] systemd-logind[538]: Watching system buttons on /dev/input/event0 (gpio-keys) alice # [ 10.971735] systemd-logind[538]: New seat seat0. alice # [ 10.974576] systemd[1]: Started User Login Management. alice # [ 10.988512] mousedev: PS/2 mouse device common for all mice alice # [ 10.982050] systemd[1]: Starting linger-users.service... bob # [ 11.023058] dbus-broker-launch[525]: Looking up NSS user entry for 'systemd-timesync'... alice # [ 10.996072] dbus-broker-launch[524]: Looking up NSS user entry for 'systemd-timesync'... bob # [ 11.039154] dbus-broker-launch[525]: NSS returned no entry for 'systemd-timesync' bob # [ 11.040189] dbus-broker-launch[525]: Invalid user-name in /nix/store/h74dizp51h61qf6ahzn6gl4w6x7mrd6p-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" bob: (finished: waiting for unit harmonia.socket, in 11.27 seconds) alice # [ 11.013642] dbus-broker-launch[524]: NSS returned no entry for 'systemd-timesync' bob: waiting for TCP port 5000 on localhost alice # [ 11.014881] dbus-broker-launch[524]: Invalid user-name in /nix/store/fk2czr8x1za04pyi7rixxm2n9xrb070j-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" alice # [ 11.026804] systemd-networkd[506]: lo: Link UP alice # [ 11.027353] systemd-networkd[506]: lo: Gained carrier bob # [ 11.067252] systemd[1]: linger-users.service: Deactivated successfully. alice # [ 11.037351] systemd[1]: Started Network Management. bob # [ 11.071154] systemd[1]: Finished linger-users.service. alice # [ 11.040672] systemd-networkd[506]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network alice # [ 11.050579] systemd-networkd[506]: eth1: Configuring with /etc/systemd/network/40-eth1.network. alice # [ 11.051352] systemd[1]: Reached target Network. alice # [ 11.051789] systemd-logind[538]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) bob # [ 11.091374] systemd[1]: Started D-Bus System Message Bus. alice # [ 11.060767] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... alice # [ 11.066962] systemd-networkd[506]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network. alice # [ 11.067872] systemd-networkd[506]: eth1: Link UP alice # [ 11.072231] systemd-networkd[506]: eth1: Gained carrier alice # [ 11.072857] systemd-networkd[506]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network alice # [ 11.081037] systemd[1]: Starting Permit User Sessions... alice # [ 11.081574] systemd-networkd[506]: eth0: Link UP alice # [ 11.082005] systemd-networkd[506]: eth0: Gained carrier alice # [ 11.084899] systemd[1]: linger-users.service: Deactivated successfully. alice # [ 11.085918] systemd-networkd[506]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.2 alice # [ 11.095029] systemd[1]: Finished linger-users.service. bob # [ 11.140845] cfg80211: Loading compiled-in X.509 certificates for regulatory database alice # [ 11.099576] systemd[1]: Started D-Bus System Message Bus. bob # [ 11.153170] dbus-broker-launch[525]: Ready alice # [ 11.138134] dbus-broker-launch[524]: Ready alice # [ 11.139574] systemd[1]: Finished Permit User Sessions. bob # [ 11.183826] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' bob # [ 11.184326] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' alice # [ 11.152232] systemd[1]: Started Getty on tty1. bob # [ 11.189125] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 bob # [ 11.189491] cfg80211: failed to load regulatory.db alice # [ 11.154408] systemd[1]: Reached target Login Prompts. alice # [ 11.157631] systemd[1]: Reached target Multi-User System. alice # [ 11.189305] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. alice # [ 11.191856] systemd[1]: Startup finished in 718ms (kernel) + 5.484s (initrd) + 4.987s (userspace) = 11.190s. bob # [ 11.241063] systemd-networkd[528]: lo: Link UP bob # [ 11.241977] systemd-networkd[528]: lo: Gained carrier bob # [ 11.251224] systemd[1]: Started Network Management. bob # [ 11.251753] systemd-networkd[528]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network. bob # [ 11.254044] systemd[1]: Reached target Network. bob # [ 11.257439] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... bob # [ 11.263579] systemd-networkd[528]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network bob # [ 11.273139] systemd-networkd[528]: eth1: Configuring with /etc/systemd/network/40-eth1.network. bob # [ 11.275060] systemd[1]: Starting Permit User Sessions... bob # [ 11.275647] systemd-networkd[528]: eth0: Link UP bob # [ 11.277415] systemd-networkd[528]: eth0: Gained carrier bob # [ 11.286846] systemd-networkd[528]: eth1: Link UP bob # [ 11.287295] systemd-networkd[528]: eth1: Gained carrier bob # [ 11.287753] systemd-networkd[528]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network bob # [ 11.301292] systemd-networkd[528]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.2 bob # [ 11.311460] systemd[1]: Starting harmonia binary cache service... bob # Connection to localhost (::1) 5000 port [tcp/commplex-main] succeeded! bob: (finished: waiting for TCP port 5000 on localhost, in 0.28 seconds) bob: waiting for success: curl bob:5000/nix-cache-info bob # [ 11.365508] systemd[1]: Finished Permit User Sessions. bob # [ 11.373337] systemd[1]: Started Getty on tty1. bob # [ 11.377286] systemd[1]: Reached target Login Prompts. bob # [ 11.380113] systemd[1]: Reached target Multi-User System. bob # [ 11.394141] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. bob # [ 11.541556] harmonia-cache[573]: 2026-08-31T12:31:00.379229Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000)) bob # [ 11.547809] harmonia-cache[573]: 2026-08-31T12:31:00.380400Z INFO actix_server::builder: starting 4 workers bob # [ 11.552913] harmonia-cache[573]: 2026-08-31T12:31:00.383586Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s bob # [ 11.555913] harmonia-cache[573]: 2026-08-31T12:31:00.384775Z INFO actix_server::server: Actix runtime found; starting in Actix runtime bob # [ 11.559956] harmonia-cache[573]: 2026-08-31T12:31:00.384796Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:5000 bob # [ 11.564772] systemd[1]: Started harmonia binary cache service. bob # [ 11.565307] systemd[1]: Startup finished in 749ms (kernel) + 5.493s (initrd) + 5.301s (userspace) = 11.544s. alice # [ 11.650113] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 bob # % Total % Received % Xferd Average Speed Time Time Time Current bob # Dload Upload Total Spent Left Speed bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 236 0 0100 51 100 51 0 0 234 0 0100 51 100 51 0 0 233 0 0 bob: (finished: waiting for success: curl bob:5000/nix-cache-info, in 0.38 seconds) alice: waiting for success: curl bob:5000/nix-cache-info alice: waiting for the VM to finish booting alice: Guest shell says: b'Spawning backdoor root shell...\n' alice: connected to guest root shell alice: (connecting took 0.00 seconds) alice: (finished: waiting for the VM to finish booting, in 0.00 seconds) bob # [ 11.854701] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 alice # [ 11.934722] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. alice # [ 11.990010] systemd[1]: Starting Virtual Console Setup... alice # [ 11.990758] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) alice # % Total % Received % Xferd Average Speed Time Time Time Current alice # Dload Upload Total Spent Left Speed alice # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 202 0 0100 51 100 51 0 0 201 0 0100 51 100 51 0 0 199 0 0 alice: (finished: waiting for success: curl bob:5000/nix-cache-info, in 0.37 seconds) bob: must succeed: nix-build --expr ' builtins.derivation { name = "hi"; builder = "/bin/sh"; args = [ "-c" "echo hi > $out" ]; system = "aarch64-linux"; } ' 2>&1 alice # [ 12.097578] systemd-networkd[506]: eth1: Gained IPv6LL bob # [ 12.158822] systemd[1]: Starting Virtual Console Setup... bob # [ 12.190571] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. bob # [ 12.208371] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. bob # [ 12.209034] systemd[1]: Stopped Virtual Console Setup. bob # [ 12.218534] systemd[1]: Starting Virtual Console Setup... bob # [ 12.219310] systemd-logind[545]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) bob # [ 12.301003] systemd-resolved[324]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3. bob # [ 12.384768] systemd-networkd[528]: eth0: Gained IPv6LL alice # [ 12.451285] systemd-vconsole-setup[571]: Configuration of first virtual console was skipped, ignoring remaining ones. alice # [ 12.453307] systemd[1]: Finished Virtual Console Setup. bob # [ 12.689063] systemd-vconsole-setup[602]: Configuration of first virtual console was skipped, ignoring remaining ones. bob # [ 12.691563] systemd[1]: Finished Virtual Console Setup. alice # [ 12.865010] systemd-networkd[506]: eth0: Gained IPv6LL bob # [ 13.249095] systemd-networkd[528]: eth1: Gained IPv6LL bob: (finished: must succeed: nix-build --expr ' builtins.derivation { name = "hi"; builder = "/bin/sh"; args = [ "-c" "echo hi > $out" ]; system = "aarch64-linux"; } ' 2>&1 , in 5.21 seconds) alice: must succeed: nix-build --expr ' builtins.derivation { name = "hi"; builder = "/bin/sh"; args = [ "-c" "echo hi > $out" ]; system = "aarch64-linux"; } ' 2>&1 alice # [ 17.406228] systemd-resolved[317]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3. alice: (finished: must succeed: nix-build --expr ' builtins.derivation { name = "hi"; builder = "/bin/sh"; args = [ "-c" "echo hi > $out" ]; system = "aarch64-linux"; } ' 2>&1 , in 4.80 seconds) (finished: run the VM test script, in 22.75 seconds) test script finished in 22.87s cleanup kill QemuMachine (pid 48) alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 47) bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.26 seconds)