vm-test-run-ncps
checks.aarch64-linux.ncps
· build #780
· raw
1build01: building 98yfqlwgw99s63ggi28829p4gab0apg7-vm-test-run-ncps.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 alice, bob, clare,9 vlan1,10 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_ssh11start all VMs12alice: starting vm13bob: starting vm14clare: starting vm15alice # Disk image does not exist, creating the virtualisation disk image...16alice # Formatting '/build/vm-state-alice/tmp.mIb8Iv20xF', fmt=raw size=107374182417alice # mke2fs 1.47.4 (6-Mar-2025)18alice # Discarding device blocks: 0/262144 done19alice # Creating filesystem with 262144 4k blocks and 65536 inodes20alice # Filesystem UUID: 85c4d184-e71d-4416-a635-a78665477d1921alice # Superblock backups stored on blocks:22alice: QEMU running (pid 48)23alice # 32768, 98304, 163840, 22937624bob: QEMU running (pid 49)25bob # Disk image does not exist, creating the virtualisation disk image...26clare: QEMU running (pid 50)27clare # Disk image does not exist, creating the virtualisation disk image...28alice # 29clare # Formatting '/build/vm-state-clare/tmp.ed8bzjD2jk', fmt=raw size=107374182430bob # Formatting '/build/vm-state-bob/tmp.yZi62EqhRa', fmt=raw size=107374182431alice # Allocating group tables: 0/8 done32(finished: start all VMs, in 0.57 seconds)33clare # mke2fs 1.47.4 (6-Mar-2025)34bob # mke2fs 1.47.4 (6-Mar-2025)35alice # Writing inode tables: 0/8 done36clare # Discarding device blocks: 0/262144 done37bob: waiting for unit ncps38alice # Creating journal (8192 blocks): done39clare # Creating filesystem with 262144 4k blocks and 65536 inodes40bob: waiting for the VM to finish booting41alice # Writing superblocks and filesystem accounting information: 0/8 done42bob # Discarding device blocks: 0/262144 done43alice # 44bob # Creating filesystem with 262144 4k blocks and 65536 inodes45alice # Virtualisation disk image created.46bob # Filesystem UUID: 69bd0452-41c9-4514-a862-d6c3778b8fed47alice # Starting virtiofs daemons...48bob # Superblock backups stored on blocks:49alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)50bob # 32768, 98304, 163840, 22937651alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether52bob # 53alice # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...54bob # Allocating group tables: 0/8 done55alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)56bob # Writing inode tables: 0/8 done57alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether58bob # Creating journal (8192 blocks): done59alice # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...60bob # Writing superblocks and filesystem accounting information: 0/8 done61alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)62bob # 63alice # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether64bob # Virtualisation disk image created.65alice # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...66bob # Starting virtiofs daemons...67alice # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests68bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)69alice # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests70bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether71alice # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests72bob # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...73bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)74clare # Filesystem UUID: 07b9ffc2-93c7-4939-8bcd-5eb6885e5e3475bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether76clare # Superblock backups stored on blocks:77bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)78clare # 32768, 98304, 163840, 22937679bob # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether80clare # 81bob # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...82clare # Allocating group tables: 0/8 done83bob # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...84clare # Writing inode tables: 0/8 done85bob # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests86clare # Creating journal (8192 blocks): done87bob # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests88clare # Writing superblocks and filesystem accounting information: 0/8 done89bob # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests90clare # 91clare # Virtualisation disk image created.92clare # Starting virtiofs daemons...93clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)94clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether95clare # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...96clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)97clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether98clare # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...99clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)100clare # [2026-09-27T17:41:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether101clare # [2026-09-27T17:41:37Z INFO virtiofsd] Waiting for vhost-user socket connection...102clare # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests103clare # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests104clare # [2026-09-27T17:41:37Z INFO virtiofsd] Client connected, servicing requests105alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]106alice # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 UTC 2026107alice # [ 0.000000] KASLR enabled108alice # [ 0.000000] random: crng init done109alice # [ 0.000000] Machine model: linux,dummy-virt110alice # [ 0.000000] efi: UEFI not found.111alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT112alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]113alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]114alice # [ 0.000000] Zone ranges:115alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]116alice # [ 0.000000] DMA32 empty117alice # [ 0.000000] Normal empty118alice # [ 0.000000] Device empty119alice # [ 0.000000] Movable zone start for each node120alice # [ 0.000000] Early memory node ranges121alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]122alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]123alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000124alice # [ 0.000000] psci: probing for conduit method from DT.125alice # [ 0.000000] psci: PSCIv1.3 detected in firmware.126alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs127alice # [ 0.000000] psci: Trusted OS migration not required128alice # [ 0.000000] psci: SMC Calling Convention v1.1129alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)130alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296131alice # [ 0.000000] Detected PIPT I-cache on CPU0132alice # [ 0.000000] CPU features: detected: GICv3 CPU interface133alice # [ 0.000000] CPU features: detected: Spectre-v4134alice # [ 0.000000] CPU features: detected: Spectre-BHB135alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR136alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)137alice # [ 0.000000] CPU features: detected: ARM erratum 1418040138alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion139alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing140alice # [ 0.000000] alternatives: applying boot alternatives141alice # [ 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/5mrv0g4znr0sd45nr4sd8pdaz46s4fbl-nixos-system-alice-test/init regInfo=/nix/.ro-store/3wfslljc2qaaka5hfgp8x5r6s2fkm6ni-closure-info/registration console=ttyAMA0,115200n8 console=tty0142alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/3wfslljc2qaaka5hfgp8x5r6s2fkm6ni-closure-info/registration", will be passed to user space.143alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes144alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)145alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)146alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB147alice # [ 0.000000] software IO TLB: area num 1.148alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)149alice # [ 0.000000] Fallback order for Node 0: 0150alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144151alice # [ 0.000000] Policy zone: DMA152alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off153alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1154alice # [ 0.000000] allocated 2097152 bytes of page_ext155alice # [ 0.000000] ftrace: allocating 74963 entries in 294 pages156alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups157alice # [ 0.000000] rcu: Hierarchical RCU implementation.158alice # [ 0.000000] rcu: RCU event tracing is enabled.159alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.160alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.161alice # [ 0.000000] Rude variant of Tasks RCU enabled.162alice # [ 0.000000] Tracing variant of Tasks RCU enabled.163alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.164alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1165alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.166alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0169alice # [ 0.000000] GICv3: 256 SPIs implemented170alice # [ 0.000000] GICv3: 0 Extended SPIs implemented171alice # [ 0.000000] Root IRQ handler: gic_handle_irq172alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI173alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0174alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000175alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]176alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)177bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]178alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)179bob # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 UTC 2026180alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000181bob # [ 0.000000] KASLR enabled182clare # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]183bob # [ 0.000000] random: crng init done184alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000185bob # [ 0.000000] Machine model: linux,dummy-virt186bob # [ 0.000000] efi: UEFI not found.187alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.188clare # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 UTC 2026189bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT190clare # [ 0.000000] KASLR enabled191alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns192clare # [ 0.000000] random: crng init done193bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]194clare # [ 0.000000] Machine model: linux,dummy-virt195alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040196clare # [ 0.000000] efi: UEFI not found.197bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]198bob # [ 0.000000] Zone ranges:199alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).200clare # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT201bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]202bob # [ 0.000000] DMA32 empty203clare # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]204bob # [ 0.000000] Normal empty205alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns206bob # [ 0.000000] Device empty207clare # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]208clare # [ 0.000000] Zone ranges:209bob # [ 0.000000] Movable zone start for each node210alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns211bob # [ 0.000000] Early memory node ranges212alice # [ 0.000063] arm-pv: using stolen time PV213clare # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]214clare # [ 0.000000] DMA32 empty215bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]216clare # [ 0.000000] Normal empty217clare # [ 0.000000] Device empty218alice # [ 0.000371] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)219bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]220clare # [ 0.000000] Movable zone start for each node221alice # [ 0.000664] Console: colour dummy device 80x25222clare # [ 0.000000] Early memory node ranges223bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000224alice # [ 0.000683] printk: legacy console [tty0] enabled225bob # [ 0.000000] psci: probing for conduit method from DT.226clare # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]227bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.228clare # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]229alice # [ 0.000921] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)230bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs231alice # [ 0.000926] pid_max: default: 32768 minimum: 301232clare # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000233bob # [ 0.000000] psci: Trusted OS migration not required234clare # [ 0.000000] psci: probing for conduit method from DT.235alice # [ 0.001005] LSM: initializing lsm=capability,landlock,yama,bpf,ima236bob # [ 0.000000] psci: SMC Calling Convention v1.1237alice # [ 0.001137] landlock: Up and running.238clare # [ 0.000000] psci: PSCIv1.3 detected in firmware.239alice # [ 0.001140] Yama: becoming mindful.240bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)241alice # [ 0.001519] LSM support for eBPF active242clare # [ 0.000000] psci: Using standard PSCI v0.2 function IDs243clare # [ 0.000000] psci: Trusted OS migration not required244bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296245alice # [ 0.001690] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)246clare # [ 0.000000] psci: SMC Calling Convention v1.1247bob # [ 0.000000] Detected PIPT I-cache on CPU0248bob # [ 0.000000] CPU features: detected: GICv3 CPU interface249alice # [ 0.001709] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)250clare # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)251bob # [ 0.000000] CPU features: detected: Spectre-v4252alice # [ 0.004484] rcu: Hierarchical SRCU implementation.253clare # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296254alice # [ 0.004490] rcu: Max phase no-delay instances is 1000.255bob # [ 0.000000] CPU features: detected: Spectre-BHB256clare # [ 0.000000] Detected PIPT I-cache on CPU0257bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR258alice # [ 0.005408] fsl-mc MSI: its@8080000 domain created259clare # [ 0.000000] CPU features: detected: GICv3 CPU interface260alice # [ 0.005607] EFI services will not be available.261bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)262clare # [ 0.000000] CPU features: detected: Spectre-v4263alice # [ 0.005693] smp: Bringing up secondary CPUs ...264clare # [ 0.000000] CPU features: detected: Spectre-BHB265bob # [ 0.000000] CPU features: detected: ARM erratum 1418040266alice # [ 0.005722] smp: Brought up 1 node, 1 CPU267alice # [ 0.005724] SMP: Total of 1 processors activated.268clare # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR269bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion270alice # [ 0.005726] CPU: All CPU(s) started at EL1271bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing272clare # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)273alice # [ 0.005738] CPU features: detected: 32-bit EL0 Support274bob # [ 0.000000] alternatives: applying boot alternatives275clare # [ 0.000000] CPU features: detected: ARM erratum 1418040276alice # [ 0.005741] CPU features: detected: Data cache clean to the PoU not required for I/D coherence277clare # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion278alice # [ 0.005744] CPU features: detected: Common not Private translations279clare # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing280alice # [ 0.005746] CPU features: detected: CRC32 instructions281clare # [ 0.000000] alternatives: applying boot alternatives282alice # [ 0.005748] CPU features: detected: Data cache clean to Point of Persistence283alice # [ 0.005751] CPU features: detected: Enhanced Virtualization Traps284bob # [ 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/3x6i2g70yfi9bj03k2sr6girqyjnhfzm-nixos-system-bob-test/init regInfo=/nix/.ro-store/wdzzndsbqzfnh63fzrqqbllnakgdxmn3-closure-info/registration console=ttyAMA0,115200n8 console=tty0285alice # [ 0.005762] CPU features: detected: RCpc load-acquire (LDAPR)286alice # [ 0.005764] CPU features: detected: LSE atomic instructions287alice # [ 0.005766] CPU features: detected: Privileged Access Never288bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/wdzzndsbqzfnh63fzrqqbllnakgdxmn3-closure-info/registration", will be passed to user space.289clare # [ 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/3rm7jwhi0dzl73bwshl17pwph88z8lgv-nixos-system-clare-test/init regInfo=/nix/.ro-store/459v1m8p3vmylm66g7rpqd68ysf5fgf5-closure-info/registration console=ttyAMA0,115200n8 console=tty0290alice # [ 0.005768] CPU features: detected: PMUv3291alice # [ 0.005770] CPU features: detected: RAS Extension Support292bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes293alice # [ 0.005775] CPU features: detected: Speculative Store Bypassing Safe (SSBS)294bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)295clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/459v1m8p3vmylm66g7rpqd68ysf5fgf5-closure-info/registration", will be passed to user space.296alice # [ 0.005796] alternatives: applying system-wide alternatives297bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)298clare # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes299alice # [ 0.007180] CPU features: detected: Hardware dirty bit management on CPU0300bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB301bob # [ 0.000000] software IO TLB: area num 1.302clare # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)303alice # [ 0.007351] Memory: 891316K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 115948K reserved, 32768K cma-reserved)304bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)305clare # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)306alice # [ 0.007839] devtmpfs: initialized307bob # [ 0.000000] Fallback order for Node 0: 0308clare # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB309alice # [ 0.009372] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)310bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144311clare # [ 0.000000] software IO TLB: area num 1.312bob # [ 0.000000] Policy zone: DMA313alice # [ 0.009394] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).314clare # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)315bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off316clare # [ 0.000000] Fallback order for Node 0: 0317alice # [ 0.009507] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL318bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1319alice # [ 0.009510] 0 pages in range for non-PLT usage320clare # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144321clare # [ 0.000000] Policy zone: DMA322bob # [ 0.000000] allocated 2097152 bytes of page_ext323alice # [ 0.009511] 508224 pages in range for PLT usage324bob # [ 0.000000] ftrace: allocating 74963 entries in 294 pages325alice # [ 0.009614] pinctrl core: initialized pinctrl subsystem326clare # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off327alice # [ 0.010423] DMI not present or invalid.328bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups329clare # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1330bob # [ 0.000000] rcu: Hierarchical RCU implementation.331alice # [ 0.013652] NET: Registered PF_NETLINK/PF_ROUTE protocol family332clare # [ 0.000000] allocated 2097152 bytes of page_ext333bob # [ 0.000000] rcu: RCU event tracing is enabled.334alice # [ 0.016089] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations335clare # [ 0.000000] ftrace: allocating 74963 entries in 294 pages336bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.337clare # [ 0.000000] ftrace: allocated 294 pages with 4 groups338alice # [ 0.016244] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations339bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.340clare # [ 0.000000] rcu: Hierarchical RCU implementation.341bob # [ 0.000000] Rude variant of Tasks RCU enabled.342alice # [ 0.016400] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations343clare # [ 0.000000] rcu: RCU event tracing is enabled.344bob # [ 0.000000] Tracing variant of Tasks RCU enabled.345alice # [ 0.016416] audit: initializing netlink subsys (disabled)346clare # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.347bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.348alice # [ 0.017008] thermal_sys: Registered thermal governor 'fair_share'349clare # [ 0.000000] Trampoline variant of Tasks RCU enabled.350clare # [ 0.000000] Rude variant of Tasks RCU enabled.351alice # [ 0.017010] thermal_sys: Registered thermal governor 'bang_bang'352bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1353clare # [ 0.000000] Tracing variant of Tasks RCU enabled.354alice # [ 0.017013] thermal_sys: Registered thermal governor 'step_wise'355bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.356clare # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.357alice # [ 0.017015] thermal_sys: Registered thermal governor 'user_space'358bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.359alice # [ 0.017016] thermal_sys: Registered thermal governor 'power_allocator'360clare # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1361alice # [ 0.017052] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1362bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.363clare # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.364alice # [ 0.017067] cpuidle: using governor ladder365bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0366alice # [ 0.017072] cpuidle: using governor menu367bob # [ 0.000000] GICv3: 256 SPIs implemented368clare # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.369alice # [ 0.017197] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.370bob # [ 0.000000] GICv3: 0 Extended SPIs implemented371bob # [ 0.000000] Root IRQ handler: gic_handle_irq372clare # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.373alice # [ 0.017218] ASID allocator initialised with 32768 entries374alice # [ 0.017860] Serial: AMBA PL011 UART driver375bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI376clare # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0377clare # [ 0.000000] GICv3: 256 SPIs implemented378bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0379alice # [ 0.021408] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1380clare # [ 0.000000] GICv3: 0 Extended SPIs implemented381bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000382alice # [ 0.021555] printk: console [ttyAMA0] enabled383clare # [ 0.000000] Root IRQ handler: gic_handle_irq384bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]385clare # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI386clare # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0387bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)388clare # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000389bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)390clare # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]391bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000392clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)393bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000394clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)395bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.396clare # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000397bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns398clare # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000399bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040400clare # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.401bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).402clare # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns403bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns404clare # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040405bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns406clare # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).407bob # [ 0.000044] arm-pv: using stolen time PV408clare # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns409bob # [ 0.000361] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)410bob # [ 0.000603] Console: colour dummy device 80x25411clare # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns412bob # [ 0.000619] printk: legacy console [tty0] enabled413clare # [ 0.000050] arm-pv: using stolen time PV414bob # [ 0.000848] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)415clare # [ 0.000378] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)416bob # [ 0.000853] pid_max: default: 32768 minimum: 301417clare # [ 0.000670] Console: colour dummy device 80x25418clare # [ 0.000691] printk: legacy console [tty0] enabled419bob # [ 0.000927] LSM: initializing lsm=capability,landlock,yama,bpf,ima420bob # [ 0.001050] landlock: Up and running.421bob # [ 0.001052] Yama: becoming mindful.422clare # [ 0.000924] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)423bob # [ 0.001393] LSM support for eBPF active424clare # [ 0.000929] pid_max: default: 32768 minimum: 301425bob # [ 0.001561] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)426clare # [ 0.001015] LSM: initializing lsm=capability,landlock,yama,bpf,ima427clare # [ 0.001141] landlock: Up and running.428bob # [ 0.001584] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)429clare # [ 0.001143] Yama: becoming mindful.430clare # [ 0.001525] LSM support for eBPF active431bob # [ 0.004205] rcu: Hierarchical SRCU implementation.432bob # [ 0.004210] rcu: Max phase no-delay instances is 1000.433clare # [ 0.001698] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)434bob # [ 0.005170] fsl-mc MSI: its@8080000 domain created435alice # [ 0.096031] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages436bob # [ 0.005348] EFI services will not be available.437clare # [ 0.001721] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)438alice # [ 0.096044] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page439bob # [ 0.005431] smp: Bringing up secondary CPUs ...440clare # [ 0.004231] rcu: Hierarchical SRCU implementation.441bob # [ 0.005457] smp: Brought up 1 node, 1 CPU442alice # [ 0.096046] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages443clare # [ 0.004237] rcu: Max phase no-delay instances is 1000.444bob # [ 0.005460] SMP: Total of 1 processors activated.445clare # [ 0.005137] fsl-mc MSI: its@8080000 domain created446alice # [ 0.096051] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page447bob # [ 0.005461] CPU: All CPU(s) started at EL1448clare # [ 0.005320] EFI services will not be available.449alice # [ 0.096053] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages450bob # [ 0.005473] CPU features: detected: 32-bit EL0 Support451clare # [ 0.005399] smp: Bringing up secondary CPUs ...452alice # [ 0.096055] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page453clare # [ 0.005424] smp: Brought up 1 node, 1 CPU454bob # [ 0.005476] CPU features: detected: Data cache clean to the PoU not required for I/D coherence455clare # [ 0.005426] SMP: Total of 1 processors activated.456alice # [ 0.096057] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages457clare # [ 0.005428] CPU: All CPU(s) started at EL1458bob # [ 0.005479] CPU features: detected: Common not Private translations459alice # [ 0.096059] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page460clare # [ 0.005439] CPU features: detected: 32-bit EL0 Support461bob # [ 0.005481] CPU features: detected: CRC32 instructions462alice # [ 0.097017] fbcon: Taking over console463alice # [ 0.097032] ACPI: Interpreter disabled.464bob # [ 0.005483] CPU features: detected: Data cache clean to Point of Persistence465clare # [ 0.005441] CPU features: detected: Data cache clean to the PoU not required for I/D coherence466alice # [ 0.097683] iommu: Default domain type: Translated467bob # [ 0.005485] CPU features: detected: Enhanced Virtualization Traps468clare # [ 0.005444] CPU features: detected: Common not Private translations469alice # [ 0.097687] iommu: DMA domain TLB invalidation policy: strict mode470bob # [ 0.005496] CPU features: detected: RCpc load-acquire (LDAPR)471clare # [ 0.005447] CPU features: detected: CRC32 instructions472alice # [ 0.097980] SCSI subsystem initialized473bob # [ 0.005498] CPU features: detected: LSE atomic instructions474alice # [ 0.098184] usbcore: registered new interface driver usbfs475clare # [ 0.005449] CPU features: detected: Data cache clean to Point of Persistence476bob # [ 0.005500] CPU features: detected: Privileged Access Never477alice # [ 0.098217] usbcore: registered new interface driver hub478clare # [ 0.005451] CPU features: detected: Enhanced Virtualization Traps479bob # [ 0.005502] CPU features: detected: PMUv3480alice # [ 0.098227] usbcore: registered new device driver usb481clare # [ 0.005461] CPU features: detected: RCpc load-acquire (LDAPR)482bob # [ 0.005504] CPU features: detected: RAS Extension Support483alice # [ 0.098442] pps_core: LinuxPPS API ver. 1 registered484clare # [ 0.005463] CPU features: detected: LSE atomic instructions485bob # [ 0.005508] CPU features: detected: Speculative Store Bypassing Safe (SSBS)486clare # [ 0.005465] CPU features: detected: Privileged Access Never487alice # [ 0.098445] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>488bob # [ 0.005529] alternatives: applying system-wide alternatives489clare # [ 0.005467] CPU features: detected: PMUv3490alice # [ 0.098449] PTP clock support registered491alice # [ 0.098480] EDAC MC: Ver: 3.0.0492clare # [ 0.005469] CPU features: detected: RAS Extension Support493clare # [ 0.005474] CPU features: detected: Speculative Store Bypassing Safe (SSBS)494alice # [ 0.107908] scmi_core: SCMI protocol bus registered495bob # [ 0.006986] CPU features: detected: Hardware dirty bit management on CPU0496clare # [ 0.005494] alternatives: applying system-wide alternatives497bob # [ 0.007147] Memory: 891340K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 115940K reserved, 32768K cma-reserved)498bob # [ 0.007558] devtmpfs: initialized499clare # [ 0.006860] CPU features: detected: Hardware dirty bit management on CPU0500bob # [ 0.009029] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)501bob # [ 0.009068] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).502clare # [ 0.007048] Memory: 891284K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 115948K reserved, 32768K cma-reserved)503clare # [ 0.007475] devtmpfs: initialized504bob # [ 0.009193] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL505bob # [ 0.009197] 0 pages in range for non-PLT usage506clare # [ 0.008941] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)507bob # [ 0.009198] 508224 pages in range for PLT usage508alice # [ 0.108627] FPGA manager framework509alice # [ 0.111873] vgaarb: loaded510clare # [ 0.008963] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).511bob # [ 0.009310] pinctrl core: initialized pinctrl subsystem512bob # [ 0.010056] DMI not present or invalid.513clare # [ 0.009090] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL514clare # [ 0.009093] 0 pages in range for non-PLT usage515bob # [ 0.013165] NET: Registered PF_NETLINK/PF_ROUTE protocol family516clare # [ 0.009094] 508224 pages in range for PLT usage517bob # [ 0.015424] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations518clare # [ 0.009203] pinctrl core: initialized pinctrl subsystem519clare # [ 0.009914] DMI not present or invalid.520bob # [ 0.015556] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations521clare # [ 0.013133] NET: Registered PF_NETLINK/PF_ROUTE protocol family522bob # [ 0.015706] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations523clare # [ 0.015341] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations524bob # [ 0.015721] audit: initializing netlink subsys (disabled)525clare # [ 0.015470] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations526bob # [ 0.016166] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1527alice # [ 0.112553] clocksource: Switched to clocksource arch_sys_counter528bob # [ 0.016313] thermal_sys: Registered thermal governor 'fair_share'529clare # [ 0.015643] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations530clare # [ 0.015658] audit: initializing netlink subsys (disabled)531bob # [ 0.016314] thermal_sys: Registered thermal governor 'bang_bang'532bob # [ 0.016317] thermal_sys: Registered thermal governor 'step_wise'533clare # [ 0.016117] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1534bob # [ 0.016319] thermal_sys: Registered thermal governor 'user_space'535clare # [ 0.016246] thermal_sys: Registered thermal governor 'fair_share'536bob # [ 0.016320] thermal_sys: Registered thermal governor 'power_allocator'537clare # [ 0.016248] thermal_sys: Registered thermal governor 'bang_bang'538bob # [ 0.016347] cpuidle: using governor ladder539clare # [ 0.016250] thermal_sys: Registered thermal governor 'step_wise'540bob # [ 0.016353] cpuidle: using governor menu541clare # [ 0.016252] thermal_sys: Registered thermal governor 'user_space'542bob # [ 0.016456] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.543clare # [ 0.016254] thermal_sys: Registered thermal governor 'power_allocator'544bob # [ 0.016476] ASID allocator initialised with 32768 entries545clare # [ 0.016280] cpuidle: using governor ladder546bob # [ 0.017136] Serial: AMBA PL011 UART driver547clare # [ 0.016286] cpuidle: using governor menu548bob # [ 0.020500] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1549clare # [ 0.016400] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.550bob # [ 0.020638] printk: console [ttyAMA0] enabled551clare # [ 0.016419] ASID allocator initialised with 32768 entries552clare # [ 0.017067] Serial: AMBA PL011 UART driver553clare # [ 0.020405] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1554clare # [ 0.020538] printk: console [ttyAMA0] enabled555alice # [ 0.120694] VFS: Disk quotas dquot_6.6.0556alice # [ 0.120721] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)557alice # [ 0.122127] netfs: FS-Cache loaded558alice # [ 0.122234] pnp: PnP ACPI: disabled559alice # [ 0.124036] NET: Registered PF_INET protocol family560alice # [ 0.124214] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)561bob # [ 0.093516] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages562bob # [ 0.093529] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page563bob # [ 0.093531] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages564bob # [ 0.093535] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page565clare # [ 0.093528] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages566bob # [ 0.093537] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages567clare # [ 0.093541] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page568bob # [ 0.093539] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page569clare # [ 0.093543] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages570bob # [ 0.093541] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages571clare # [ 0.093547] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page572bob # [ 0.093543] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page573clare # [ 0.093549] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages574bob # [ 0.094486] fbcon: Taking over console575clare # [ 0.093551] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page576bob # [ 0.094502] ACPI: Interpreter disabled.577bob # [ 0.095124] iommu: Default domain type: Translated578clare # [ 0.093554] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages579bob # [ 0.095128] iommu: DMA domain TLB invalidation policy: strict mode580clare # [ 0.093555] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page581bob # [ 0.095422] SCSI subsystem initialized582clare # [ 0.094516] fbcon: Taking over console583clare # [ 0.094532] ACPI: Interpreter disabled.584bob # [ 0.095640] usbcore: registered new interface driver usbfs585clare # [ 0.095167] iommu: Default domain type: Translated586bob # [ 0.095676] usbcore: registered new interface driver hub587bob # [ 0.095690] usbcore: registered new device driver usb588clare # [ 0.095171] iommu: DMA domain TLB invalidation policy: strict mode589clare # [ 0.095447] SCSI subsystem initialized590bob # [ 0.095892] pps_core: LinuxPPS API ver. 1 registered591clare # [ 0.095699] usbcore: registered new interface driver usbfs592bob # [ 0.095895] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>593clare # [ 0.095729] usbcore: registered new interface driver hub594bob # [ 0.095900] PTP clock support registered595clare # [ 0.095738] usbcore: registered new device driver usb596bob # [ 0.095931] EDAC MC: Ver: 3.0.0597clare # [ 0.095955] pps_core: LinuxPPS API ver. 1 registered598bob # [ 0.105817] scmi_core: SCMI protocol bus registered599clare # [ 0.095957] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>600clare # [ 0.095962] PTP clock support registered601clare # [ 0.095989] EDAC MC: Ver: 3.0.0602clare # [ 0.105856] scmi_core: SCMI protocol bus registered603bob # [ 0.106534] FPGA manager framework604bob # [ 0.109781] vgaarb: loaded605clare # [ 0.106586] FPGA manager framework606clare # [ 0.109792] vgaarb: loaded607bob # [ 0.110463] clocksource: Switched to clocksource arch_sys_counter608clare # [ 0.110500] clocksource: Switched to clocksource arch_sys_counter609bob # [ 0.119315] VFS: Disk quotas dquot_6.6.0610bob # [ 0.119339] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)611bob # [ 0.120649] netfs: FS-Cache loaded612bob # [ 0.120755] pnp: PnP ACPI: disabled613clare # [ 0.119722] VFS: Disk quotas dquot_6.6.0614clare # [ 0.119747] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)615clare # [ 0.121128] netfs: FS-Cache loaded616clare # [ 0.121235] pnp: PnP ACPI: disabled617alice # [ 0.149429] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)618alice # [ 0.149447] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)619bob # [ 0.123984] NET: Registered PF_INET protocol family620alice # [ 0.149457] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)621bob # [ 0.124153] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)622alice # [ 0.149492] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)623alice # [ 0.149558] TCP: Hash tables configured (established 8192 bind 8192)624clare # [ 0.124537] NET: Registered PF_INET protocol family625alice # [ 0.149643] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)626clare # [ 0.124703] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)627alice # [ 0.149699] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)628alice # [ 0.149721] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)629alice # [ 0.149842] NET: Registered PF_UNIX/PF_LOCAL protocol family630alice # [ 0.149873] NET: Registered PF_XDP protocol family631alice # [ 0.149890] PCI: CLS 0 bytes, default 64632alice # [ 0.150177] Trying to unpack rootfs image as initramfs...633alice # [ 0.152712] kvm [1]: HYP mode not available634bob # [ 0.148068] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)635bob # [ 0.148090] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)636bob # [ 0.148102] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)637clare # [ 0.148554] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)638bob # [ 0.148138] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)639clare # [ 0.148576] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)640bob # [ 0.148205] TCP: Hash tables configured (established 8192 bind 8192)641clare # [ 0.148587] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)642bob # [ 0.148333] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)643clare # [ 0.148624] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)644bob # [ 0.148384] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)645clare # [ 0.148690] TCP: Hash tables configured (established 8192 bind 8192)646bob # [ 0.148406] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)647clare # [ 0.148781] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)648bob # [ 0.148529] NET: Registered PF_UNIX/PF_LOCAL protocol family649bob # [ 0.148558] NET: Registered PF_XDP protocol family650clare # [ 0.148808] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)651bob # [ 0.148578] PCI: CLS 0 bytes, default 64652clare # [ 0.148829] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)653bob # [ 0.148761] Trying to unpack rootfs image as initramfs...654clare # [ 0.148943] NET: Registered PF_UNIX/PF_LOCAL protocol family655clare # [ 0.148974] NET: Registered PF_XDP protocol family656clare # [ 0.148994] PCI: CLS 0 bytes, default 64657clare # [ 0.149183] Trying to unpack rootfs image as initramfs...658bob # [ 0.162484] kvm [1]: HYP mode not available659clare # [ 0.162526] kvm [1]: HYP mode not available660alice # [ 0.229778] Initialise system trusted keyrings661alice # [ 0.229893] workingset: timestamp_bits=42 max_order=18 bucket_order=0662alice # [ 0.230200] squashfs: version 4.0 (2009/01/31) Phillip Lougher663alice # [ 0.230233] 9p: Installing v9fs 9p2000 file system support664alice # [ 0.250786] Key type asymmetric registered665alice # [ 0.250806] Asymmetric key parser 'x509' registered666alice # [ 0.250875] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)667alice # [ 0.250982] io scheduler mq-deadline registered668alice # [ 0.250986] io scheduler kyber registered669alice # [ 0.261538] pl061_gpio 9030000.pl061: PL061 GPIO chip registered670alice # [ 0.261871] ledtrig-cpu: registered to indicate activity on CPUs671bob # [ 0.226862] Initialise system trusted keyrings672alice # [ 0.262164] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:673bob # [ 0.226979] workingset: timestamp_bits=42 max_order=18 bucket_order=0674alice # [ 0.262180] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000675bob # [ 0.227285] squashfs: version 4.0 (2009/01/31) Phillip Lougher676bob # [ 0.227358] 9p: Installing v9fs 9p2000 file system support677alice # [ 0.262192] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000678clare # [ 0.226891] Initialise system trusted keyrings679clare # [ 0.226999] workingset: timestamp_bits=42 max_order=18 bucket_order=0680alice # [ 0.262197] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000681clare # [ 0.227331] squashfs: version 4.0 (2009/01/31) Phillip Lougher682alice # [ 0.262232] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits683clare # [ 0.227369] 9p: Installing v9fs 9p2000 file system support684alice # [ 0.262257] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]685alice # [ 0.262328] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00686alice # [ 0.262344] pci_bus 0000:00: root bus resource [bus 00-ff]687alice # [ 0.262348] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]688alice # [ 0.262350] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]689alice # [ 0.262353] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]690alice # [ 0.262431] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint691alice # [ 0.262863] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint692alice # [ 0.262989] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]693alice # [ 0.262998] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]694alice # [ 0.263017] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]695alice # [ 0.263025] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]696alice # [ 0.263340] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint697alice # [ 0.263464] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]698alice # [ 0.263473] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]699alice # [ 0.263492] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]700alice # [ 0.263802] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint701alice # [ 0.263924] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]702alice # [ 0.263933] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]703alice # [ 0.263952] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]704alice # [ 0.264278] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint705alice # [ 0.264403] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]706alice # [ 0.264412] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]707alice # [ 0.264430] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]708alice # [ 0.264439] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]709bob # [ 0.246140] Key type asymmetric registered710bob # [ 0.246158] Asymmetric key parser 'x509' registered711bob # [ 0.246211] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)712clare # [ 0.246174] Key type asymmetric registered713clare # [ 0.246191] Asymmetric key parser 'x509' registered714clare # [ 0.246244] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)715alice # [ 0.288833] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint716alice # [ 0.288963] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]717bob # [ 0.254521] io scheduler mq-deadline registered718bob # [ 0.254529] io scheduler kyber registered719alice # [ 0.288981] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]720bob # [ 0.256794] pl061_gpio 9030000.pl061: PL061 GPIO chip registered721alice # [ 0.289295] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint722bob # [ 0.257130] ledtrig-cpu: registered to indicate activity on CPUs723alice # [ 0.289419] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]724clare # [ 0.254562] io scheduler mq-deadline registered725bob # [ 0.257429] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:726clare # [ 0.254569] io scheduler kyber registered727alice # [ 0.289436] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]728bob # [ 0.257446] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000729alice # [ 0.289713] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint730alice # [ 0.289832] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]731bob # [ 0.257458] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000732alice # [ 0.290007] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint733bob # [ 0.257463] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000734alice # [ 0.290130] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]735bob # [ 0.257502] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits736alice # [ 0.290148] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]737bob # [ 0.257526] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]738alice # [ 0.290456] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint739bob # [ 0.257591] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00740clare # [ 0.259279] pl061_gpio 9030000.pl061: PL061 GPIO chip registered741alice # [ 0.290580] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]742bob # [ 0.257606] pci_bus 0000:00: root bus resource [bus 00-ff]743clare # [ 0.259645] ledtrig-cpu: registered to indicate activity on CPUs744alice # [ 0.290598] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]745bob # [ 0.257609] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]746clare # [ 0.259927] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:747alice # [ 0.290900] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint748bob # [ 0.257611] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]749alice # [ 0.291023] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]750clare # [ 0.259943] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000751bob # [ 0.257614] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]752alice # [ 0.291041] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]753clare # [ 0.259956] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000754bob # [ 0.257696] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint755alice # [ 0.291355] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint756clare # [ 0.259960] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000757alice # [ 0.291551] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]758bob # [ 0.258122] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint759alice # [ 0.291561] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]760bob # [ 0.258251] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]761clare # [ 0.259996] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits762bob # [ 0.258261] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]763alice # [ 0.291579] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]764clare # [ 0.260020] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]765bob # [ 0.258280] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]766alice # [ 0.291890] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint767clare # [ 0.260084] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00768bob # [ 0.258289] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]769alice # [ 0.292022] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]770clare # [ 0.260099] pci_bus 0000:00: root bus resource [bus 00-ff]771alice # [ 0.292031] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]772clare # [ 0.260102] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]773alice # [ 0.292048] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]774clare # [ 0.260105] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]775alice # [ 0.292506] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned776clare # [ 0.260107] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]777alice # [ 0.292513] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned778clare # [ 0.260182] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint779alice # [ 0.292516] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned780clare # [ 0.260610] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint781alice # [ 0.292548] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned782clare # [ 0.260738] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]783clare # [ 0.260747] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]784clare # [ 0.260765] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]785alice # [ 0.307685] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned786clare # [ 0.260773] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]787alice # [ 0.307715] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned788clare # [ 0.261094] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint789alice # [ 0.307747] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned790clare # [ 0.261219] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]791clare # [ 0.261228] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]792alice # [ 0.307776] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned793clare # [ 0.261247] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]794alice # [ 0.307805] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned795clare # [ 0.261559] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint796alice # [ 0.307834] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned797clare # [ 0.261683] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]798alice # [ 0.307863] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned799clare # [ 0.261692] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]800clare # [ 0.261711] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]801alice # [ 0.307892] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned802alice # [ 0.307948] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned803bob # [ 0.274678] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint804clare # [ 0.262029] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint805clare # [ 0.262155] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]806alice # [ 0.307977] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned807bob # [ 0.274808] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]808clare # [ 0.262163] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]809bob # [ 0.274818] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]810alice # [ 0.307990] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned811bob # [ 0.274836] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]812clare # [ 0.262182] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]813alice # [ 0.308124] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned814clare # [ 0.262190] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]815bob # [ 0.275167] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint816alice # [ 0.308137] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned817bob # [ 0.275293] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]818alice # [ 0.308149] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned819bob # [ 0.275302] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]820alice # [ 0.308161] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned821bob # [ 0.275320] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]822alice # [ 0.308173] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned823bob # [ 0.275637] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint824alice # [ 0.308185] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned825bob # [ 0.275764] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]826alice # [ 0.308198] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned827bob # [ 0.275773] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]828alice # [ 0.308209] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned829bob # [ 0.275792] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]830alice # [ 0.308221] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned831bob # [ 0.275801] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]832alice # [ 0.308233] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned833bob # [ 0.276121] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint834alice # [ 0.308246] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned835bob # [ 0.276251] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]836alice # [ 0.308257] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned837bob # [ 0.276269] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]838alice # [ 0.308269] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned839alice # [ 0.308281] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned840bob # [ 0.276594] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint841alice # [ 0.308292] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned842bob # [ 0.276721] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]843alice # [ 0.308304] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned844bob # [ 0.276739] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]845alice # [ 0.308324] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]846bob # [ 0.277014] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint847alice # [ 0.308335] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]848bob # [ 0.277150] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]849alice # [ 0.308337] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]850bob # [ 0.277354] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint851bob # [ 0.277481] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]852bob # [ 0.277499] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]853bob # [ 0.277817] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint854bob # [ 0.277944] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]855bob # [ 0.277962] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]856clare # [ 0.286563] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint857bob # [ 0.278277] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint858clare # [ 0.286697] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]859bob # [ 0.278404] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]860clare # [ 0.286716] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]861bob # [ 0.278421] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]862alice # [ 0.324577] pci 0000:00:07.0: enabling device (0000 -> 0002)863clare # [ 0.287065] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint864clare # [ 0.287193] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]865bob # [ 0.294324] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint866clare # [ 0.287212] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]867clare # [ 0.287492] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint868clare # [ 0.287630] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]869clare # [ 0.287819] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint870clare # [ 0.287946] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]871clare # [ 0.287965] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]872clare # [ 0.288280] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint873clare # [ 0.288408] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]874clare # [ 0.288426] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]875clare # [ 0.288738] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint876clare # [ 0.288866] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]877clare # [ 0.288884] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]878clare # [ 0.289326] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint879clare # [ 0.289493] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]880clare # [ 0.289503] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]881alice # [ 0.334278] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)882clare # [ 0.289521] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]883alice # [ 0.336439] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)884clare # [ 0.289911] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint885clare # [ 0.290037] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]886clare # [ 0.290046] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]887clare # [ 0.290065] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]888bob # [ 0.295167] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]889bob # [ 0.295178] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]890bob # [ 0.295196] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]891bob # [ 0.295526] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint892clare # [ 0.303687] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned893bob # [ 0.295652] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]894clare # [ 0.303694] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned895bob # [ 0.295660] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]896clare # [ 0.303697] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned897bob # [ 0.295679] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]898clare # [ 0.303732] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned899bob # [ 0.296133] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned900bob # [ 0.296140] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned901clare # [ 0.303762] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned902bob # [ 0.296143] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned903clare # [ 0.303792] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned904bob # [ 0.296179] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned905clare # [ 0.303823] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned906bob # [ 0.296209] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned907clare # [ 0.303852] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned908bob # [ 0.296240] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned909clare # [ 0.303882] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned910bob # [ 0.296273] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned911clare # [ 0.303912] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned912bob # [ 0.296305] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned913clare # [ 0.303941] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned914bob # [ 0.296337] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned915clare # [ 0.303969] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned916bob # [ 0.296368] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned917clare # [ 0.304029] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned918bob # [ 0.296399] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned919clare # [ 0.304095] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned920bob # [ 0.296429] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned921clare # [ 0.304107] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned922clare # [ 0.304119] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned923bob # [ 0.296507] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned924clare # [ 0.304130] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned925bob # [ 0.296538] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned926clare # [ 0.304142] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned927bob # [ 0.296550] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned928clare # [ 0.304154] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned929bob # [ 0.296562] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned930clare # [ 0.304166] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned931bob # [ 0.296574] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned932clare # [ 0.304178] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned933bob # [ 0.296586] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned934clare # [ 0.304190] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned935bob # [ 0.296598] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned936clare # [ 0.304202] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned937bob # [ 0.296610] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned938clare # [ 0.304213] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned939bob # [ 0.296623] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned940alice # [ 0.353641] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)941clare # [ 0.304225] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned942bob # [ 0.296635] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned943alice # [ 0.355590] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)944clare # [ 0.304237] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned945bob # [ 0.296647] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned946clare # [ 0.304248] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned947bob # [ 0.296659] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned948clare # [ 0.304260] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned949bob # [ 0.296672] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned950clare # [ 0.304272] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned951bob # [ 0.296684] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned952clare # [ 0.304283] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned953bob # [ 0.296695] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned954clare # [ 0.304295] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned955bob # [ 0.296708] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned956clare # [ 0.304313] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]957bob # [ 0.296719] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned958clare # [ 0.304324] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]959bob # [ 0.296731] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned960alice # [ 0.358519] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)961clare # [ 0.304326] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]962bob # [ 0.296743] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned963clare # [ 0.304854] pci 0000:00:07.0: enabling device (0000 -> 0002)964bob # [ 0.296760] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]965bob # [ 0.296768] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]966bob # [ 0.296771] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]967bob # [ 0.297321] pci 0000:00:07.0: enabling device (0000 -> 0002)968alice # [ 0.361259] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)969alice # [ 0.363054] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)970bob # [ 0.333782] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)971clare # [ 0.335786] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)972clare # [ 0.337620] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)973alice # [ 0.373516] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)974alice # [ 0.375426] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)975bob # [ 0.343618] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)976bob # [ 0.347480] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)977bob # [ 0.349129] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)978clare # [ 0.348164] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)979clare # [ 0.349796] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)980alice # [ 0.385045] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)981alice # [ 0.387863] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)982bob # [ 0.358890] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)983bob # [ 0.361304] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)984clare # [ 0.360326] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)985clare # [ 0.362187] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)986alice # [ 0.397290] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled987alice # [ 0.398255] msm_serial: driver initialized988alice # [ 0.398352] SuperH (H)SCI(F) driver initialized989alice # [ 0.398392] STM32 USART driver initialized990clare # [ 0.364723] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)991clare # [ 0.366353] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)992bob # [ 0.370585] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)993bob # [ 0.372835] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)994bob # [ 0.375514] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)995bob # [ 0.377210] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)996clare # [ 0.375678] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)997clare # [ 0.377388] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)998clare # [ 0.380368] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)999alice # [ 0.422311] loop: module loaded1000alice # [ 0.422438] virtio_blk virtio2: 1/0/0 default/read/poll queues1001alice # [ 0.423030] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1002bob # [ 0.387660] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1003bob # [ 0.391659] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1004bob # [ 0.392642] msm_serial: driver initialized1005bob # [ 0.392722] SuperH (H)SCI(F) driver initialized1006bob # [ 0.392760] STM32 USART driver initialized1007clare # [ 0.391899] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1008clare # [ 0.392822] msm_serial: driver initialized1009clare # [ 0.392892] SuperH (H)SCI(F) driver initialized1010clare # [ 0.392932] STM32 USART driver initialized1011alice # [ 0.426236] megasas: 07.734.00.00-rc11012alice # [ 0.426694] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1013alice # [ 0.442613] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001014alice # [ 0.442637] Intel/Sharp Extended Query Table at 0x00311015alice # [ 0.444294] Using buffer write method1016alice # [ 0.444320] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1017bob # [ 0.416678] loop: module loaded1018bob # [ 0.416811] virtio_blk virtio2: 1/0/0 default/read/poll queues1019bob # [ 0.417474] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1020clare # [ 0.416084] loop: module loaded1021clare # [ 0.416215] virtio_blk virtio2: 1/0/0 default/read/poll queues1022clare # [ 0.416786] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1023alice # [ 0.453442] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001024alice # [ 0.453455] Intel/Sharp Extended Query Table at 0x00311025alice # [ 0.454923] Using buffer write method1026alice # [ 0.454936] Concatenating MTD devices:1027alice # [ 0.454938] (0): "0.flash"1028alice # [ 0.454940] (1): "0.flash"1029alice # [ 0.454941] into device "0.flash"1030clare # [ 0.420214] megasas: 07.734.00.00-rc11031clare # [ 0.420702] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1032bob # [ 0.422848] megasas: 07.734.00.00-rc11033bob # [ 0.423281] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1034clare # [ 0.431587] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001035clare # [ 0.431631] Intel/Sharp Extended Query Table at 0x00311036clare # [ 0.433331] Using buffer write method1037clare # [ 0.433382] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1038bob # [ 0.434493] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001039bob # [ 0.434542] Intel/Sharp Extended Query Table at 0x00311040bob # [ 0.436173] Using buffer write method1041bob # [ 0.436224] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1042clare # [ 0.437217] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001043clare # [ 0.437230] Intel/Sharp Extended Query Table at 0x00311044bob # [ 0.440984] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001045bob # [ 0.441025] Intel/Sharp Extended Query Table at 0x00311046bob # [ 0.443653] Using buffer write method1047bob # [ 0.443663] Concatenating MTD devices:1048bob # [ 0.443664] (0): "0.flash"1049bob # [ 0.443666] (1): "0.flash"1050bob # [ 0.443668] into device "0.flash"1051clare # [ 0.447057] Using buffer write method1052clare # [ 0.447070] Concatenating MTD devices:1053clare # [ 0.447072] (0): "0.flash"1054clare # [ 0.447074] (1): "0.flash"1055clare # [ 0.447075] into device "0.flash"1056alice # [ 0.651691] Freeing initrd memory: 26892K1057alice # [ 0.658440] tun: Universal TUN/TAP device driver, 1.61058alice # [ 0.661167] thunder_xcv, ver 1.01059alice # [ 0.661182] thunder_bgx, ver 1.01060alice # [ 0.661191] nicpf, ver 1.01061alice # [ 0.661494] e1000: Intel(R) PRO/1000 Network Driver1062alice # [ 0.661498] e1000: Copyright (c) 1999-2006 Intel Corporation.1063alice # [ 0.661510] e1000e: Intel(R) PRO/1000 Network Driver1064alice # [ 0.661515] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1065alice # [ 0.661527] igb: Intel(R) Gigabit Ethernet Network Driver1066alice # [ 0.661529] igb: Copyright (c) 2007-2014 Intel Corporation.1067alice # [ 0.661541] igbvf: Intel(R) Gigabit Virtual Function Network Driver1068alice # [ 0.661543] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1069alice # [ 0.661635] sky2: driver version 1.301070alice # [ 0.662470] usbcore: registered new interface driver usb-storage1071alice # [ 0.662609] usbcore: registered new interface driver usbserial_generic1072alice # [ 0.662615] usbserial: USB Serial support registered for generic1073alice # [ 0.662922] hv_vmbus: registering driver hyperv_keyboard1074alice # [ 0.663909] ehci-pci 0000:00:07.0: EHCI Host Controller1075alice # [ 0.663934] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11076alice # [ 0.664222] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001077alice # [ 0.664392] rtc-pl031 9010000.pl031: registered as rtc01078alice # [ 0.664418] rtc-pl031 9010000.pl031: setting system clock to 2026-09-27T17:41:38 UTC (1790530898)1079alice # [ 0.673427] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001080alice # [ 0.673765] hub 1-0:1.0: USB hub found1081alice # [ 0.673788] hub 1-0:1.0: 6 ports detected1082alice # [ 0.674077] i2c_dev: i2c /dev entries driver1083alice # [ 0.675685] sdhci: Secure Digital Host Controller Interface driver1084alice # [ 0.675689] sdhci: Copyright(c) Pierre Ossman1085alice # [ 0.675845] Synopsys Designware Multimedia Card Interface Driver1086alice # [ 0.676055] sdhci-pltfm: SDHCI platform and OF driver helper1087alice # [ 0.680216] hid: raw HID events driver (C) Jiri Kosina1088alice # [ 0.680352] usbcore: registered new interface driver usbhid1089alice # [ 0.680355] usbhid: USB HID core driver1090bob # [ 0.649213] Freeing initrd memory: 26884K1091clare # [ 0.646644] Freeing initrd memory: 26892K1092bob # [ 0.657264] tun: Universal TUN/TAP device driver, 1.61093clare # [ 0.654586] tun: Universal TUN/TAP device driver, 1.61094clare # [ 0.656800] thunder_xcv, ver 1.01095clare # [ 0.656819] thunder_bgx, ver 1.01096clare # [ 0.656828] nicpf, ver 1.01097clare # [ 0.657144] e1000: Intel(R) PRO/1000 Network Driver1098clare # [ 0.657147] e1000: Copyright (c) 1999-2006 Intel Corporation.1099clare # [ 0.657160] e1000e: Intel(R) PRO/1000 Network Driver1100clare # [ 0.657165] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1101bob # [ 0.659879] thunder_xcv, ver 1.01102bob # [ 0.659894] thunder_bgx, ver 1.01103clare # [ 0.657176] igb: Intel(R) Gigabit Ethernet Network Driver1104bob # [ 0.659902] nicpf, ver 1.01105clare # [ 0.657178] igb: Copyright (c) 2007-2014 Intel Corporation.1106bob # [ 0.660238] e1000: Intel(R) PRO/1000 Network Driver1107bob # [ 0.660242] e1000: Copyright (c) 1999-2006 Intel Corporation.1108clare # [ 0.657190] igbvf: Intel(R) Gigabit Virtual Function Network Driver1109bob # [ 0.660254] e1000e: Intel(R) PRO/1000 Network Driver1110clare # [ 0.657192] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1111clare # [ 0.657255] sky2: driver version 1.301112bob # [ 0.660259] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1113bob # [ 0.660270] igb: Intel(R) Gigabit Ethernet Network Driver1114clare # [ 0.658058] usbcore: registered new interface driver usb-storage1115bob # [ 0.660272] igb: Copyright (c) 2007-2014 Intel Corporation.1116clare # [ 0.658097] usbcore: registered new interface driver usbserial_generic1117bob # [ 0.660284] igbvf: Intel(R) Gigabit Virtual Function Network Driver1118clare # [ 0.658102] usbserial: USB Serial support registered for generic1119bob # [ 0.660286] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1120clare # [ 0.658399] hv_vmbus: registering driver hyperv_keyboard1121bob # [ 0.660350] sky2: driver version 1.301122bob # [ 0.661169] usbcore: registered new interface driver usb-storage1123bob # [ 0.661250] usbcore: registered new interface driver usbserial_generic1124bob # [ 0.661256] usbserial: USB Serial support registered for generic1125clare # [ 0.665798] ehci-pci 0000:00:07.0: EHCI Host Controller1126bob # [ 0.661553] hv_vmbus: registering driver hyperv_keyboard1127clare # [ 0.665823] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11128clare # [ 0.666118] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001129alice # [ 0.704257] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1130alice # [ 0.705132] drop_monitor: Initializing network drop monitor service1131alice # [ 0.705302] NET: Registered PF_INET6 protocol family1132clare # [ 0.668119] rtc-pl031 9010000.pl031: registered as rtc01133clare # [ 0.668148] rtc-pl031 9010000.pl031: setting system clock to 2026-09-27T17:41:38 UTC (1790530898)1134clare # [ 0.668312] i2c_dev: i2c /dev entries driver1135bob # [ 0.668868] ehci-pci 0000:00:07.0: EHCI Host Controller1136alice # [ 0.707520] Segment Routing with IPv61137clare # [ 0.669898] sdhci: Secure Digital Host Controller Interface driver1138bob # [ 0.668922] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11139alice # [ 0.707531] In-situ OAM (IOAM) with IPv61140clare # [ 0.669903] sdhci: Copyright(c) Pierre Ossman1141bob # [ 0.669174] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001142alice # [ 0.707590] NET: Registered PF_PACKET protocol family1143clare # [ 0.670051] Synopsys Designware Multimedia Card Interface Driver1144alice # [ 0.707652] 9pnet: Installing 9P2000 support1145bob # [ 0.669374] rtc-pl031 9010000.pl031: registered as rtc01146clare # [ 0.670231] sdhci-pltfm: SDHCI platform and OF driver helper1147alice # [ 0.707688] Key type dns_resolver registered1148bob # [ 0.669400] rtc-pl031 9010000.pl031: setting system clock to 2026-09-27T17:41:38 UTC (1790530898)1149bob # [ 0.669568] i2c_dev: i2c /dev entries driver1150bob # [ 0.671144] sdhci: Secure Digital Host Controller Interface driver1151clare # [ 0.674271] hid: raw HID events driver (C) Jiri Kosina1152bob # [ 0.671149] sdhci: Copyright(c) Pierre Ossman1153clare # [ 0.674400] usbcore: registered new interface driver usbhid1154bob # [ 0.671292] Synopsys Designware Multimedia Card Interface Driver1155clare # [ 0.674403] usbhid: USB HID core driver1156bob # [ 0.671469] sdhci-pltfm: SDHCI platform and OF driver helper1157clare # [ 0.674546] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001158alice # [ 0.712160] registered taskstats version 11159bob # [ 0.672310] hid: raw HID events driver (C) Jiri Kosina1160alice # [ 0.712317] Loading compiled-in X.509 certificates1161bob # [ 0.672442] usbcore: registered new interface driver usbhid1162bob # [ 0.672445] usbhid: USB HID core driver1163clare # [ 0.676465] hub 1-0:1.0: USB hub found1164clare # [ 0.676502] hub 1-0:1.0: 6 ports detected1165clare # [ 0.677370] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1166clare # [ 0.678144] drop_monitor: Initializing network drop monitor service1167clare # [ 0.678298] NET: Registered PF_INET6 protocol family1168bob # [ 0.678781] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001169bob # [ 0.679124] hub 1-0:1.0: USB hub found1170bob # [ 0.679153] hub 1-0:1.0: 6 ports detected1171bob # [ 0.679481] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1172clare # [ 0.681120] Segment Routing with IPv61173clare # [ 0.681141] In-situ OAM (IOAM) with IPv61174bob # [ 0.680282] drop_monitor: Initializing network drop monitor service1175clare # [ 0.681190] NET: Registered PF_PACKET protocol family1176bob # [ 0.680426] NET: Registered PF_INET6 protocol family1177clare # [ 0.681251] 9pnet: Installing 9P2000 support1178bob # [ 0.681004] Segment Routing with IPv61179bob # [ 0.681015] In-situ OAM (IOAM) with IPv61180clare # [ 0.681285] Key type dns_resolver registered1181bob # [ 0.681075] NET: Registered PF_PACKET protocol family1182alice # [ 0.717777] Demotion targets for Node 0: null1183bob # [ 0.681137] 9pnet: Installing 9P2000 support1184alice # [ 0.717846] Key type .fscrypt registered1185bob # [ 0.681176] Key type dns_resolver registered1186alice # [ 0.717849] Key type fscrypt-provisioning registered1187alice # [ 0.717945] ima: No TPM chip found, activating TPM-bypass!1188alice # [ 0.717955] ima: Allocated hash algorithm: sha11189alice # [ 0.717999] ima: No architecture policies found1190clare # [ 0.685749] registered taskstats version 11191alice # [ 0.718425] input: gpio-keys as /devices/platform/gpio-keys/input/input01192clare # [ 0.685891] Loading compiled-in X.509 certificates1193bob # [ 0.688256] registered taskstats version 11194bob # [ 0.688394] Loading compiled-in X.509 certificates1195bob # [ 0.693793] Demotion targets for Node 0: null1196bob # [ 0.693865] Key type .fscrypt registered1197bob # [ 0.693868] Key type fscrypt-provisioning registered1198bob # [ 0.693971] ima: No TPM chip found, activating TPM-bypass!1199bob # [ 0.693982] ima: Allocated hash algorithm: sha11200clare # [ 0.691365] Demotion targets for Node 0: null1201bob # [ 0.694026] ima: No architecture policies found1202clare # [ 0.691438] Key type .fscrypt registered1203clare # [ 0.691441] Key type fscrypt-provisioning registered1204bob # [ 0.694522] input: gpio-keys as /devices/platform/gpio-keys/input/input01205clare # [ 0.691551] ima: No TPM chip found, activating TPM-bypass!1206alice # [ 0.730828] clk: Disabling unused clocks1207clare # [ 0.691562] ima: Allocated hash algorithm: sha11208alice # [ 0.730838] PM: genpd: Disabling unused power domains1209clare # [ 0.691607] ima: No architecture policies found1210clare # [ 0.692076] input: gpio-keys as /devices/platform/gpio-keys/input/input01211alice # [ 0.733883] Freeing unused kernel memory: 4736K1212alice # [ 0.733958] Run /init as init process1213clare # [ 0.704630] clk: Disabling unused clocks1214clare # [ 0.704639] PM: genpd: Disabling unused power domains1215bob # [ 0.706944] clk: Disabling unused clocks1216bob # [ 0.706953] PM: genpd: Disabling unused power domains1217bob # [ 0.709276] Freeing unused kernel memory: 4736K1218bob # [ 0.709363] Run /init as init process1219clare # [ 0.707733] Freeing unused kernel memory: 4736K1220clare # [ 0.707822] Run /init as init process1221alice # [ 0.752085] systemd[1]: Successfully made /usr/ read-only.1222clare # [ 0.728926] systemd[1]: Successfully made /usr/ read-only.1223bob # [ 0.732802] systemd[1]: Successfully made /usr/ read-only.1224alice # [ 0.924634] usb 1-1: new high-speed USB device number 2 using ehci-pci1225clare # [ 0.926577] usb 1-1: new high-speed USB device number 2 using ehci-pci1226bob # [ 0.930559] usb 1-1: new high-speed USB device number 2 using ehci-pci1227alice # [ 1.076918] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11228alice # [ 1.087098] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1229alice # [ 1.087126] systemd[1]: Detected virtualization qemu.1230alice # [ 1.087163] systemd[1]: Detected architecture arm64.1231alice # [ 1.087172] systemd[1]: Running in initrd.1232alice # [ 1.087964] systemd[1]: Initializing machine ID from random generator.1233alice # [ 1.088279] systemd[1]: Hostname set to <alice>.1234bob # [ 1.066700] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1235bob # [ 1.066717] systemd[1]: Detected virtualization qemu.1236bob # [ 1.066744] systemd[1]: Detected architecture arm64.1237bob # [ 1.066747] systemd[1]: Running in initrd.1238clare # [ 1.062864] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1239bob # [ 1.067275] systemd[1]: Initializing machine ID from random generator.1240bob # [ 1.067474] systemd[1]: Hostname set to <bob>.1241clare # [ 1.062894] systemd[1]: Detected virtualization qemu.1242clare # [ 1.062934] systemd[1]: Detected architecture arm64.1243clare # [ 1.062944] systemd[1]: Running in initrd.1244clare # [ 1.063778] systemd[1]: Initializing machine ID from random generator.1245clare # [ 1.064153] systemd[1]: Hostname set to <clare>.1246bob # [ 1.082833] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11247clare # [ 1.086467] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11248alice # [ 1.160689] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01249bob # [ 1.162867] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01250clare # [ 1.178658] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01251alice # [ 1.280605] usb 1-2: new high-speed USB device number 3 using ehci-pci1252bob # [ 1.282493] usb 1-2: new high-speed USB device number 3 using ehci-pci1253alice # [ 1.325085] systemd[1]: bpf-restrict-fs: LSM BPF program attached1254bob # [ 1.293849] systemd[1]: bpf-restrict-fs: LSM BPF program attached1255clare # [ 1.298553] usb 1-2: new high-speed USB device number 3 using ehci-pci1256clare # [ 1.351782] systemd[1]: bpf-restrict-fs: LSM BPF program attached1257alice # [ 1.392150] systemd[1]: Queued start job for default target Initrd Default Target.1258bob # [ 1.366127] systemd[1]: Queued start job for default target Initrd Default Target.1259alice # [ 1.402453] systemd[1]: Created slice Slice /system/modprobe.1260alice # [ 1.402626] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1261alice # [ 1.402658] systemd[1]: Expecting device /dev/disk/by-label/nixos...1262alice # [ 1.402680] systemd[1]: Reached target Path Units.1263alice # [ 1.402695] systemd[1]: Reached target Slice Units.1264alice # [ 1.402708] systemd[1]: Reached target Swaps.1265alice # [ 1.402721] systemd[1]: Reached target Timer Units.1266alice # [ 1.402862] systemd[1]: Listening on D-Bus System Message Bus Socket.1267alice # [ 1.402983] systemd[1]: Listening on Journal Socket (/dev/log).1268alice # [ 1.403071] systemd[1]: Listening on Journal Sockets.1269alice # [ 1.403142] systemd[1]: Listening on udev Control Socket.1270alice # [ 1.403222] systemd[1]: Listening on udev Kernel Socket.1271alice # [ 1.403241] systemd[1]: Reached target Socket Units.1272alice # [ 1.404328] systemd[1]: Starting Create List of Static Device Nodes...1273alice # [ 1.404380] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1274bob # [ 1.376030] systemd[1]: Created slice Slice /system/modprobe.1275bob # [ 1.376191] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1276bob # [ 1.376226] systemd[1]: Expecting device /dev/disk/by-label/nixos...1277bob # [ 1.376248] systemd[1]: Reached target Path Units.1278bob # [ 1.376265] systemd[1]: Reached target Slice Units.1279bob # [ 1.376278] systemd[1]: Reached target Swaps.1280bob # [ 1.376293] systemd[1]: Reached target Timer Units.1281bob # [ 1.376432] systemd[1]: Listening on D-Bus System Message Bus Socket.1282bob # [ 1.376561] systemd[1]: Listening on Journal Socket (/dev/log).1283bob # [ 1.376658] systemd[1]: Listening on Journal Sockets.1284bob # [ 1.376733] systemd[1]: Listening on udev Control Socket.1285bob # [ 1.376819] systemd[1]: Listening on udev Kernel Socket.1286bob # [ 1.376841] systemd[1]: Reached target Socket Units.1287bob # [ 1.377973] systemd[1]: Starting Create List of Static Device Nodes...1288bob # [ 1.378028] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1289alice # [ 1.420664] systemd[1]: Mounting Kernel Configuration File System...1290alice # [ 1.429773] systemd[1]: Starting Journal Service...1291bob # [ 1.395068] systemd[1]: Mounting Kernel Configuration File System...1292alice # [ 1.435239] systemd[1]: Starting Load Kernel Modules...1293alice # [ 1.435310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1294alice # [ 1.439624] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21295bob # [ 1.402626] systemd[1]: Starting Journal Service...1296alice # [ 1.439708] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01297alice # [ 1.443032] systemd[1]: Starting Coldplug All udev Devices...1298bob # [ 1.408383] systemd[1]: Starting Load Kernel Modules...1299bob # [ 1.408447] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1300alice # [ 1.447094] systemd[1]: Finished Create List of Static Device Nodes.1301alice # [ 1.457926] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1302alice # [ 1.458296] systemd[1]: Mounted Kernel Configuration File System.1303bob # [ 1.419204] systemd[1]: Starting Coldplug All udev Devices...1304clare # [ 1.424681] systemd[1]: Queued start job for default target Initrd Default Target.1305clare # [ 1.432144] systemd[1]: Created slice Slice /system/modprobe.1306clare # [ 1.432315] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1307clare # [ 1.432349] systemd[1]: Expecting device /dev/disk/by-label/nixos...1308clare # [ 1.432370] systemd[1]: Reached target Path Units.1309clare # [ 1.432383] systemd[1]: Reached target Slice Units.1310clare # [ 1.432396] systemd[1]: Reached target Swaps.1311clare # [ 1.432409] systemd[1]: Reached target Timer Units.1312clare # [ 1.432546] systemd[1]: Listening on D-Bus System Message Bus Socket.1313clare # [ 1.432670] systemd[1]: Listening on Journal Socket (/dev/log).1314clare # [ 1.432793] systemd[1]: Listening on Journal Sockets.1315clare # [ 1.432869] systemd[1]: Listening on udev Control Socket.1316clare # [ 1.432918] systemd[1]: Listening on udev Kernel Socket.1317clare # [ 1.432933] systemd[1]: Reached target Socket Units.1318bob # [ 1.442581] systemd[1]: Finished Create List of Static Device Nodes.1319clare # [ 1.434028] systemd[1]: Starting Create List of Static Device Nodes...1320clare # [ 1.434084] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1321clare # [ 1.453847] systemd[1]: Mounting Kernel Configuration File System...1322bob # [ 1.456057] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1323bob # [ 1.456772] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21324bob # [ 1.456850] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01325bob # [ 1.458095] systemd-journald[71]: Collecting audit messages is disabled.1326alice # [ 1.495575] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1327clare # [ 1.460073] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21328clare # [ 1.460195] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01329alice # [ 1.503350] systemd-journald[71]: Collecting audit messages is disabled.1330clare # [ 1.466620] systemd[1]: Starting Journal Service...1331clare # [ 1.467489] systemd[1]: Starting Load Kernel Modules...1332clare # [ 1.467691] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1333alice # [ 1.511102] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1334alice # [ 1.512470] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1335alice # [ 1.514828] systemd[1]: Starting Create Static Device Nodes in /dev...1336bob # [ 1.470724] systemd[1]: Mounted Kernel Configuration File System.1337bob # [ 1.471453] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1338clare # [ 1.478699] systemd[1]: Starting Coldplug All udev Devices...1339bob # [ 1.471585] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1340bob # [ 1.479892] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01341bob # [ 1.480094] [drm] features: -virgl +edid -resource_blob -host_visible1342bob # [ 1.480099] [drm] features: -context_init1343bob # [ 1.480638] [drm] number of scanouts: 11344bob # [ 1.480648] [drm] number of cap sets: 01345alice # [ 1.522126] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01346alice # [ 1.522359] [drm] features: -virgl +edid -resource_blob -host_visible1347alice # [ 1.522361] [drm] features: -context_init1348alice # [ 1.522898] [drm] number of scanouts: 11349alice # [ 1.522907] [drm] number of cap sets: 01350clare # [ 1.494580] systemd[1]: Finished Create List of Static Device Nodes.1351clare # [ 1.495300] systemd[1]: Mounted Kernel Configuration File System.1352bob # [ 1.499561] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1353bob # [ 1.500487] systemd[1]: Starting Create Static Device Nodes in /dev...1354clare # [ 1.499807] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1355bob # [ 1.503774] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1356bob # [ 1.503783] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01357alice # [ 1.540853] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1358alice # [ 1.540862] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01359bob # [ 1.522861] Console: switching to colour frame buffer device 160x501360alice # [ 1.561435] Console: switching to colour frame buffer device 160x501361alice # [ 1.567552] systemd[1]: Finished Create Static Device Nodes in /dev.1362alice # [ 1.567709] systemd[1]: Reached target Preparation for Local File Systems.1363alice # [ 1.567729] systemd[1]: Reached target Local File Systems.1364alice # [ 1.570376] systemd[1]: Starting Rule-based Manager for Device Events and Files...1365bob # [ 1.541675] systemd[1]: Started Journal Service.1366clare # [ 1.530673] systemd-journald[71]: Collecting audit messages is disabled.1367clare # [ 1.542714] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1368bob # [ 1.541294] systemd-modules-load[72]: Inserted module 'dm_mod'1369bob # [ 1.547037] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1370bob # [ 1.545381] systemd-modules-load[72]: Module 'virtio_balloon' is built in1371alice # [ 1.585123] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1372clare # [ 1.550566] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1373alice # [ 1.588394] systemd-modules-load[72]: Inserted module 'dm_mod'1374alice # [ 1.589166] systemd-modules-load[72]: Module 'virtio_balloon' is built in1375bob # [ 1.552490] systemd-modules-load[72]: Module 'virtio_console' is built in1376bob # [ 1.553228] systemd[1]: Finished Create Static Device Nodes in /dev.1377clare # [ 1.555721] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1378clare # [ 1.556850] systemd[1]: Starting Create Static Device Nodes in /dev...1379bob # [ 1.556248] systemd[1]: Reached target Preparation for Local File Systems.1380bob # [ 1.557021] systemd[1]: Reached target Local File Systems.1381alice # [ 1.593775] systemd-modules-load[72]: Module 'virtio_console' is built in1382bob # [ 1.557640] systemd[1]: Starting Create System Files and Directories...1383alice # [ 1.597250] systemd[1]: Started Journal Service.1384alice # [ 1.596622] systemd-modules-load[72]: Inserted module 'virtio_gpu'1385alice # [ 1.597276] systemd-modules-load[72]: Module 'virtio_rng' is built in1386bob # [ 1.561080] systemd-modules-load[72]: Inserted module 'virtio_gpu'1387alice # [ 1.597942] systemd[1]: Starting Create System Files and Directories...1388bob # [ 1.561685] systemd-modules-load[72]: Module 'virtio_rng' is built in1389bob # [ 1.563565] systemd[1]: Starting Rule-based Manager for Device Events and Files...1390bob # [ 1.568205] systemd[1]: Finished Load Kernel Modules.1391clare # [ 1.572217] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01392clare # [ 1.572436] [drm] features: -virgl +edid -resource_blob -host_visible1393clare # [ 1.572438] [drm] features: -context_init1394clare # [ 1.572892] [drm] number of scanouts: 11395clare # [ 1.572901] [drm] number of cap sets: 01396alice # [ 1.612075] systemd[1]: Finished Load Kernel Modules.1397clare # [ 1.583100] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1398clare # [ 1.583109] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01399alice # [ 1.625024] systemd[1]: Starting Apply Kernel Variables...1400bob # [ 1.588544] systemd[1]: Starting Apply Kernel Variables...1401bob # [ 1.589975] systemd[1]: Finished Create System Files and Directories.1402clare # [ 1.599931] systemd[1]: Finished Create Static Device Nodes in /dev.1403clare # [ 1.600190] systemd[1]: Reached target Preparation for Local File Systems.1404clare # [ 1.600211] systemd[1]: Reached target Local File Systems.1405clare # [ 1.601302] systemd[1]: Starting Rule-based Manager for Device Events and Files...1406alice # [ 1.639572] systemd[1]: Finished Create System Files and Directories.1407clare # [ 1.605102] Console: switching to colour frame buffer device 160x501408alice # [ 1.645724] systemd-udevd[77]: Using default interface naming scheme 'v261'.1409bob # [ 1.613625] systemd[1]: Finished Apply Kernel Variables.1410clare # [ 1.614753] systemd-modules-load[72]: Inserted module 'dm_mod'1411clare # [ 1.615502] systemd-modules-load[72]: Module 'virtio_balloon' is built in1412alice # [ 1.660863] systemd[1]: Finished Apply Kernel Variables.1413clare # [ 1.626759] systemd[1]: Started Journal Service.1414clare # [ 1.625325] systemd-modules-load[72]: Module 'virtio_console' is built in1415clare # [ 1.628689] systemd[1]: Starting Create System Files and Directories...1416bob # [ 1.632073] systemd-udevd[79]: Using default interface naming scheme 'v261'.1417clare # [ 1.635040] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1418alice # [ 1.672382] systemd[1]: Started Rule-based Manager for Device Events and Files.1419clare # [ 1.643274] systemd-modules-load[72]: Inserted module 'virtio_gpu'1420clare # [ 1.644161] systemd-modules-load[72]: Module 'virtio_rng' is built in1421bob # [ 1.654388] systemd[1]: Started Rule-based Manager for Device Events and Files.1422clare # [ 1.657775] systemd[1]: Finished Load Kernel Modules.1423clare # [ 1.672478] systemd[1]: Starting Apply Kernel Variables...1424clare # [ 1.683173] systemd[1]: Finished Create System Files and Directories.1425clare # [ 1.683988] systemd-udevd[77]: Using default interface naming scheme 'v261'.1426alice # [ 1.724090] systemd[1]: Starting Virtual Console Setup...1427clare # [ 1.691446] systemd[1]: Finished Apply Kernel Variables.1428bob # [ 1.704070] systemd[1]: Starting Virtual Console Setup...1429clare # [ 1.707692] systemd[1]: Started Rule-based Manager for Device Events and Files.1430alice # [ 1.768323] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1431alice # [ 1.770599] systemd[1]: Finished Virtual Console Setup.1432bob # [ 1.748327] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1433bob # [ 1.752135] systemd[1]: Finished Virtual Console Setup.1434clare # [ 1.765988] systemd[1]: Starting Virtual Console Setup...1435clare # [ 1.799111] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1436clare # [ 1.801551] systemd[1]: Finished Virtual Console Setup.1437alice # [ 1.984832] systemd[1]: Finished Coldplug All udev Devices.1438alice # [ 1.985428] systemd[1]: Reached target System Initialization.1439alice # [ 1.985955] systemd[1]: Reached target Basic System.1440bob # [ 1.964932] systemd[1]: Finished Coldplug All udev Devices.1441bob # [ 1.965520] systemd[1]: Reached target System Initialization.1442bob # [ 1.966042] systemd[1]: Reached target Basic System.1443clare # [ 2.011167] systemd[1]: Finished Coldplug All udev Devices.1444clare # [ 2.016330] systemd[1]: Reached target System Initialization.1445clare # [ 2.016901] systemd[1]: Reached target Basic System.1446alice # [ 2.079540] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1447bob # [ 2.053716] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1448bob # [ 2.071361] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1449alice # [ 2.109246] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1450clare # [ 2.103582] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1451alice # [ 2.156556] systemd[1]: Found device /dev/disk/by-label/nixos.1452clare # [ 2.123606] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1453alice # [ 2.168162] systemd[1]: Reached target Initrd Root Device.1454alice # [ 2.171824] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1455bob # [ 2.135575] systemd[1]: Found device /dev/disk/by-label/nixos.1456bob # [ 2.143491] systemd[1]: Reached target Initrd Root Device.1457bob # [ 2.148511] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1458alice # [ 2.203755] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks1459bob # [ 2.184810] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1460alice # [ 2.225359] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1461clare # [ 2.188350] systemd[1]: Found device /dev/disk/by-label/nixos.1462clare # [ 2.191450] systemd[1]: Reached target Initrd Root Device.1463bob # [ 2.193024] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1464clare # [ 2.194991] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1465clare # [ 2.227539] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks1466clare # [ 2.234956] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1467alice # [ 2.440103] systemd[1]: Mounting /sysroot...1468bob # [ 2.414998] systemd[1]: Mounting /sysroot...1469alice # [ 2.469158] EXT4-fs (vda): mounted filesystem 85c4d184-e71d-4416-a635-a78665477d19 r/w with ordered data mode. Quota mode: none.1470alice # [ 2.469624] systemd[1]: Mounted /sysroot.1471alice # [ 2.470845] systemd[1]: Reached target Initrd Root File System.1472alice # [ 2.473899] systemd[1]: Starting Mountpoints Configured in the Real Root...1473bob # [ 2.443022] systemd[1]: Mounted /sysroot.1474bob # [ 2.447220] EXT4-fs (vda): mounted filesystem 69bd0452-41c9-4514-a862-d6c3778b8fed r/w with ordered data mode. Quota mode: none.1475bob # [ 2.446626] systemd[1]: Reached target Initrd Root File System.1476bob # [ 2.454183] systemd[1]: Starting Mountpoints Configured in the Real Root...1477alice # [ 2.494664] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.1478alice # [ 2.500044] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...1479alice # [ 2.502727] systemd[1]: Reloading...1480bob # [ 2.466513] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1481bob # [ 2.470889] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1482bob # [ 2.474193] systemd[1]: Reloading...1483clare # [ 2.488119] systemd[1]: Mounting /sysroot...1484clare # [ 2.511322] systemd[1]: Mounted /sysroot.1485clare # [ 2.515037] EXT4-fs (vda): mounted filesystem 07b9ffc2-93c7-4939-8bcd-5eb6885e5e34 r/w with ordered data mode. Quota mode: none.1486clare # [ 2.514006] systemd[1]: Reached target Initrd Root File System.1487clare # [ 2.519601] systemd[1]: Mounting /sysroot/nix/.ro-store...1488clare # [ 2.533085] systemd[1]: Mounting /sysroot/nix/.rw-store...1489clare # [ 2.542710] systemd[1]: Mounting /sysroot/run...1490clare # [ 2.575383] systemd[1]: Mounting /sysroot/tmp/shared...1491clare # [ 2.580088] systemd[1]: Mounting /sysroot/tmp/xchg...1492clare # [ 2.591749] systemd[1]: Starting Mountpoints Configured in the Real Root...[ 2.595047] fuse: init (API version 7.45)1493clare # 1494clare # [ 2.593676] systemd[1]: Mounted /sysroot/nix/.rw-store.1495clare # [ 2.606312] virtiofs virtio6: discovered new tag: nix-store1496clare # [ 2.611901] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1497clare # [ 2.618167] systemd[1]: Starting rw-sysroot-nix-store.service...1498clare # [ 2.630100] virtiofs virtio7: discovered new tag: shared1499alice # [ 2.663770] systemd[1]: Reloading finished in 161 ms.1500clare # [ 2.632133] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1501clare # [ 2.633878] virtiofs virtio8: discovered new tag: xchg1502clare # [ 2.634353] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1503bob # [ 2.631202] systemd[1]: Reloading finished in 158 ms.1504clare # [ 2.638004] systemd[1]: Mounted /sysroot/run.1505clare # [ 2.639725] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1506bob # [ 2.643260] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1507bob # [ 2.645859] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1508bob # [ 2.650162] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1509alice # [ 2.688130] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...1510bob # [ 2.651713] systemd[1]: Finished Mountpoints Configured in the Real Root.1511clare # [ 2.651249] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.1512bob # [ 2.653096] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1513alice # [ 2.690638] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...1514alice # [ 2.693309] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1515alice # [ 2.694730] systemd[1]: Finished Mountpoints Configured in the Real Root.1516alice # [ 2.696135] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1517clare # [ 2.658195] systemd[1]: Finished rw-sysroot-nix-store.service.1518clare # [ 2.658778] systemd[1]: Mounted /sysroot/nix/.ro-store.1519clare # [ 2.660624] systemd[1]: Mounted /sysroot/tmp/shared.1520clare # [ 2.661150] systemd[1]: Mounted /sysroot/tmp/xchg.1521clare # [ 2.667979] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...1522clare # [ 2.671165] systemd[1]: Reloading...1523clare # [ 2.828911] systemd[1]: Reloading finished in 157 ms.1524bob # [ 2.843341] fuse: init (API version 7.45)1525clare # [ 2.856692] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...1526clare # [ 2.859600] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...1527clare # [ 2.863916] systemd[1]: Starting rw-sysroot-nix-store.service...1528clare # [ 2.868560] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1529clare # [ 2.871840] systemd[1]: Finished Mountpoints Configured in the Real Root.1530clare # [ 2.872779] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1531alice # [ 2.913554] fuse: init (API version 7.45)1532bob # [ 2.878965] virtiofs virtio6: discovered new tag: nix-store1533bob # [ 2.879475] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1534clare # [ 2.881953] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1535clare # [ 2.883025] systemd[1]: Finished rw-sysroot-nix-store.service.1536alice # [ 2.926888] virtiofs virtio6: discovered new tag: nix-store1537alice # [ 2.927380] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1538bob # [ 2.887177] (udev-worker)[90]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1539bob # [ 2.891828] (udev-worker)[90]: mtd0ro: /etc/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 directory1540bob # [ 2.904197] virtiofs virtio7: discovered new tag: shared1541bob # [ 2.904698] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1542alice # [ 2.939336] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1543alice # [ 2.943362] (udev-worker)[98]: mtd0ro: /etc/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 directory1544bob # [ 2.916487] virtiofs virtio8: discovered new tag: xchg1545bob # [ 2.916983] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1546alice # [ 2.955555] virtiofs virtio7: discovered new tag: shared1547alice # [ 2.956088] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1548bob # [ 2.919141] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1549bob # [ 2.920422] systemd[1]: Stopped Virtual Console Setup.1550alice # [ 2.958518] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1551alice # [ 2.959663] systemd[1]: Stopped Virtual Console Setup.[ 2.961595] virtiofs virtio8: discovered new tag: xchg1552alice # [ 2.962050] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1553bob # [ 2.924933] systemd[1]: Stopping Virtual Console Setup...1554bob # [ 2.925466] systemd[1]: Starting Virtual Console Setup...1555alice # 1556alice # [ 2.965359] systemd[1]: Stopping Virtual Console Setup...1557alice # [ 2.966067] systemd[1]: Starting Virtual Console Setup...1558bob # [ 2.936475] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1559bob # [ 2.937424] systemd[1]: Stopped Virtual Console Setup.1560bob # [ 2.938872] systemd[1]: Starting Virtual Console Setup...1561alice # [ 2.988110] systemd-vconsole-setup[136]: Configuration of first virtual console was skipped, ignoring remaining ones.1562alice # [ 2.990351] systemd[1]: Finished Virtual Console Setup.1563bob # [ 2.953103] systemd-vconsole-setup[139]: Configuration of first virtual console was skipped, ignoring remaining ones.1564bob # [ 2.955188] systemd[1]: Finished Virtual Console Setup.1565clare # [ 3.036965] (udev-worker)[91]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1566clare # [ 3.040331] (udev-worker)[91]: mtd0ro: /etc/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 directory1567clare # [ 3.056947] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1568clare # [ 3.058982] systemd[1]: Stopped Virtual Console Setup.1569clare # [ 3.061134] systemd[1]: Stopping Virtual Console Setup...1570clare # [ 3.064423] systemd[1]: Starting Virtual Console Setup...1571clare # [ 3.086676] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.1572clare # [ 3.089065] systemd[1]: Finished Virtual Console Setup.1573alice # [ 3.442686] systemd[1]: Mounting /sysroot/nix/.ro-store...1574alice # [ 3.452259] systemd[1]: Mounting /sysroot/nix/.rw-store...1575bob # [ 3.418362] systemd[1]: Mounting /sysroot/nix/.ro-store...1576alice # [ 3.460265] systemd[1]: Mounting /sysroot/run...1577bob # [ 3.429659] systemd[1]: Mounting /sysroot/nix/.rw-store...1578bob # [ 3.431500] systemd[1]: Mounting /sysroot/run...1579alice # [ 3.469743] systemd[1]: Mounting /sysroot/tmp/shared...1580bob # [ 3.441781] systemd[1]: Mounting /sysroot/tmp/shared...1581alice # [ 3.492440] systemd[1]: Mounting /sysroot/tmp/xchg...1582bob # [ 3.460275] systemd[1]: Mounting /sysroot/tmp/xchg...1583alice # [ 3.514414] systemd[1]: Mounted /sysroot/nix/.rw-store.1584alice # [ 3.523298] systemd[1]: Mounted /sysroot/nix/.ro-store.1585alice # [ 3.524555] systemd[1]: Mounted /sysroot/run.1586clare # [ 3.487883] systemd[1]: Mounting /sysroot/nix/store...1587alice # [ 3.530405] systemd[1]: Mounted /sysroot/tmp/shared.1588bob # [ 3.500773] systemd[1]: Mounted /sysroot/nix/.ro-store.1589bob # [ 3.503088] systemd[1]: Mounted /sysroot/nix/.rw-store.1590alice # [ 3.540276] systemd[1]: Starting rw-sysroot-nix-store.service...1591bob # [ 3.504967] systemd[1]: Mounted /sysroot/run.1592alice # [ 3.542536] systemd[1]: Mounted /sysroot/tmp/xchg.1593bob # [ 3.506898] systemd[1]: Mounted /sysroot/tmp/shared.1594bob # [ 3.510785] systemd[1]: Mounted /sysroot/tmp/xchg.1595bob # [ 3.513353] systemd[1]: Starting rw-sysroot-nix-store.service...1596alice # [ 3.559993] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1597alice # [ 3.561377] systemd[1]: Finished rw-sysroot-nix-store.service.1598bob # [ 3.531653] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1599bob # [ 3.533237] systemd[1]: Finished rw-sysroot-nix-store.service.1600clare # [ 3.541781] systemd[1]: Mounted /sysroot/nix/store.1601clare # [ 3.544570] systemd[1]: Reached target Initrd File Systems.1602clare # [ 3.548212] systemd[1]: Starting Find NixOS closure...1603clare # [ 3.553407] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1604clare # [ 3.586665] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1605clare # [ 3.590283] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1606clare # [ 3.603682] systemd[1]: Finished Find NixOS closure.1607clare # [ 3.606150] systemd[1]: Reached target Initrd Default Target.1608clare # [ 3.607451] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1609clare # [ 3.637723] systemd[1]: Stopped target Initrd Default Target.1610clare # [ 3.639275] systemd[1]: Stopped target Basic System.1611clare # [ 3.643966] systemd[1]: Stopped target Initrd Root Device.1612clare # [ 3.644864] systemd[1]: Stopped target Path Units.1613clare # [ 3.645810] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1614clare # [ 3.646892] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1615clare # [ 3.649293] systemd[1]: Stopped target Slice Units.1616clare # [ 3.651020] systemd[1]: Stopped target Socket Units.1617clare # [ 3.652651] systemd[1]: Stopped target System Initialization.1618clare # [ 3.656213] systemd[1]: Stopped target Swaps.1619clare # [ 3.660515] systemd[1]: Stopped target Timer Units.1620clare # [ 3.662440] systemd[1]: dbus.socket: Deactivated successfully.1621clare # [ 3.663860] systemd[1]: Closed D-Bus System Message Bus Socket.1622clare # [ 3.666074] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1623clare # [ 3.669916] systemd[1]: Stopped Find NixOS closure.1624clare # [ 3.671915] systemd[1]: Starting rw-sysroot-nix-store.service...1625clare # [ 3.674692] systemd[1]: systemd-sysctl.service: Deactivated successfully.1626clare # [ 3.675584] systemd[1]: Stopped Apply Kernel Variables.1627clare # [ 3.678115] systemd[1]: systemd-modules-load.service: Deactivated successfully.1628clare # [ 3.678952] systemd[1]: Stopped Load Kernel Modules.1629clare # [ 3.679551] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1630clare # [ 3.687529] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1631clare # [ 3.688470] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1632clare # [ 3.689354] systemd[1]: Stopped Create System Files and Directories.1633clare # [ 3.690015] systemd[1]: Stopped target Local File Systems.1634clare # [ 3.690562] systemd[1]: Stopped target Preparation for Local File Systems.1635clare # [ 3.691214] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1636clare # [ 3.691890] systemd[1]: Stopped Coldplug All udev Devices.1637clare # [ 3.696826] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1638clare # [ 3.700115] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1639clare # [ 3.700825] systemd[1]: Stopped Virtual Console Setup.1640clare # [ 3.701378] systemd[1]: initrd-cleanup.service: Deactivated successfully.1641clare # [ 3.702392] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1642clare # [ 3.703261] systemd[1]: systemd-udevd.service: Deactivated successfully.1643clare # [ 3.703945] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1644clare # [ 3.704811] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1645clare # [ 3.705515] systemd[1]: Closed udev Control Socket.1646clare # [ 3.705984] systemd[1]: Starting Cleanup udev Database...1647clare # [ 3.706495] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1648clare # [ 3.707197] systemd[1]: Stopped Create Static Device Nodes in /dev.1649clare # [ 3.707768] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1650clare # [ 3.716139] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1651clare # [ 3.716813] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1652clare # [ 3.717630] systemd[1]: Stopped Create List of Static Device Nodes.1653clare # [ 3.718239] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1654clare # [ 3.718894] systemd[1]: Finished rw-sysroot-nix-store.service.1655clare # [ 3.731271] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1656clare # [ 3.732083] systemd[1]: Finished Cleanup udev Database.1657clare # [ 3.733196] systemd[1]: Reached target Switch Root.1658clare # [ 3.733693] systemd[1]: Starting NixOS Activation...1659clare # [ 3.802297] initrd-nixos-activation-start[174]: booting system configuration /nix/store/3rm7jwhi0dzl73bwshl17pwph88z8lgv-nixos-system-clare-test1660clare # [ 3.828593] initrd-nixos-activation-start[174]: running activation script...1661clare # [ 4.038637] initrd-nixos-activation-start[198]: setting up /etc...1662clare # [ 4.126078] initrd-nixos-activation-start[198]: setting up age secrets...1663clare # [ 4.184572] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1664clare # [ 4.186263] systemd[1]: Finished NixOS Activation.1665clare # [ 4.187012] systemd[1]: Starting Switch Root...1666clare # [ 4.203874] systemd[1]: Switching root.1667clare # [ 4.370932] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1668alice # [ 4.441638] systemd[1]: Mounting /sysroot/nix/store...1669bob # [ 4.415737] systemd[1]: Mounting /sysroot/nix/store...1670alice # [ 4.491857] systemd[1]: Mounted /sysroot/nix/store.1671alice # [ 4.495032] systemd[1]: Reached target Initrd File Systems.1672alice # [ 4.498278] systemd[1]: Starting Find NixOS closure...1673bob # [ 4.465727] systemd[1]: Mounted /sysroot/nix/store.1674bob # [ 4.468069] systemd[1]: Reached target Initrd File Systems.1675alice # [ 4.508418] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1676bob # [ 4.472120] systemd[1]: Starting Find NixOS closure...1677bob # [ 4.484279] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1678alice # [ 4.541050] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1679alice # [ 4.546495] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1680alice # [ 4.559799] systemd[1]: Finished Find NixOS closure.1681alice # [ 4.560827] systemd[1]: Reached target Initrd Default Target.1682bob # [ 4.524408] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1683alice # [ 4.564223] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1684bob # [ 4.529999] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1685bob # [ 4.542045] systemd[1]: Finished Find NixOS closure.1686bob # [ 4.544221] systemd[1]: Reached target Initrd Default Target.1687bob # [ 4.548275] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1688alice # [ 4.591808] systemd[1]: initrd-cleanup.service: Deactivated successfully.1689alice # [ 4.595764] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1690alice # [ 4.596817] systemd[1]: Stopped target Initrd Default Target.1691alice # [ 4.597644] systemd[1]: Stopped target Basic System.1692alice # [ 4.600163] systemd[1]: Stopped target Initrd Root Device.1693alice # [ 4.600940] systemd[1]: Stopped target Path Units.1694alice # [ 4.602133] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1695alice # [ 4.608081] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1696alice # [ 4.609059] systemd[1]: Stopped target Slice Units.1697alice # [ 4.609676] systemd[1]: Stopped target Socket Units.1698alice # [ 4.610295] systemd[1]: Stopped target System Initialization.1699alice # [ 4.611012] systemd[1]: Stopped target Swaps.1700alice # [ 4.611766] systemd[1]: Stopped target Timer Units.1701alice # [ 4.614454] systemd[1]: dbus.socket: Deactivated successfully.1702bob # [ 4.577267] systemd[1]: initrd-cleanup.service: Deactivated successfully.1703alice # [ 4.615712] systemd[1]: Closed D-Bus System Message Bus Socket.1704bob # [ 4.579205] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1705bob # [ 4.583032] systemd[1]: Stopped target Initrd Default Target.1706bob # [ 4.583853] systemd[1]: Stopped target Basic System.1707alice # [ 4.620821] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1708bob # [ 4.585039] systemd[1]: Stopped target Initrd Root Device.1709alice # [ 4.624688] systemd[1]: Stopped Find NixOS closure.1710bob # [ 4.587816] systemd[1]: Stopped target Path Units.1711bob # [ 4.588727] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1712alice # [ 4.625976] systemd[1]: Starting rw-sysroot-nix-store.service...1713alice # [ 4.628270] systemd[1]: systemd-sysctl.service: Deactivated successfully.1714bob # [ 4.591191] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1715alice # [ 4.629715] systemd[1]: Stopped Apply Kernel Variables.1716alice # [ 4.630316] systemd[1]: systemd-modules-load.service: Deactivated successfully.1717alice # [ 4.631068] systemd[1]: Stopped Load Kernel Modules.1718alice # [ 4.631728] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1719alice # [ 4.632829] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1720alice # [ 4.633645] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1721bob # [ 4.597139] systemd[1]: Stopped target Slice Units.1722alice # [ 4.634394] systemd[1]: Stopped Create System Files and Directories.1723bob # [ 4.597790] systemd[1]: Stopped target Socket Units.1724alice # [ 4.635029] systemd[1]: Stopped target Local File Systems.1725bob # [ 4.598420] systemd[1]: Stopped target System Initialization.1726alice # [ 4.635758] systemd[1]: Stopped target Preparation for Local File Systems.1727bob # [ 4.599468] systemd[1]: Stopped target Swaps.1728bob # [ 4.604112] systemd[1]: Stopped target Timer Units.1729bob # [ 4.605671] systemd[1]: dbus.socket: Deactivated successfully.1730alice # [ 4.643011] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1731alice # [ 4.643827] systemd[1]: Stopped Coldplug All udev Devices.1732alice # [ 4.644583] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1733bob # [ 4.607929] systemd[1]: Closed D-Bus System Message Bus Socket.1734alice # [ 4.645315] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1735alice # [ 4.646036] systemd[1]: Stopped Virtual Console Setup.1736bob # [ 4.608842] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1737bob # [ 4.609765] systemd[1]: Stopped Find NixOS closure.1738alice # [ 4.646589] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1739alice # [ 4.647300] systemd[1]: Finished rw-sysroot-nix-store.service.1740bob # [ 4.610390] systemd[1]: Starting rw-sysroot-nix-store.service...1741alice # [ 4.648285] systemd[1]: systemd-udevd.service: Deactivated successfully.1742bob # [ 4.611669] systemd[1]: systemd-sysctl.service: Deactivated successfully.1743alice # [ 4.649007] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1744alice # [ 4.649693] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1745alice # [ 4.650358] systemd[1]: Closed udev Control Socket.1746alice # [ 4.650834] systemd[1]: Starting Cleanup udev Database...1747alice # [ 4.651352] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1748bob # [ 4.617443] systemd[1]: Stopped Apply Kernel Variables.1749alice # [ 4.656223] systemd[1]: Stopped Create Static Device Nodes in /dev.1750alice # [ 4.660104] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1751alice # [ 4.661047] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1752bob # [ 4.624260] systemd[1]: systemd-modules-load.service: Deactivated successfully.1753bob # [ 4.625060] systemd[1]: Stopped Load Kernel Modules.1754alice # [ 4.661850] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1755alice # [ 4.662530] systemd[1]: Stopped Create List of Static Device Nodes.1756bob # [ 4.625573] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1757bob # [ 4.626321] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1758bob # [ 4.627164] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1759bob # [ 4.627858] systemd[1]: Stopped Create System Files and Directories.1760bob # [ 4.630844] systemd[1]: Stopped target Local File Systems.1761bob # [ 4.631430] systemd[1]: Stopped target Preparation for Local File Systems.1762bob # [ 4.636578] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1763alice # [ 4.673906] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1764bob # [ 4.637276] systemd[1]: Stopped Coldplug All udev Devices.1765alice # [ 4.674669] systemd[1]: Finished Cleanup udev Database.1766alice # [ 4.675228] systemd[1]: Reached target Switch Root.1767bob # [ 4.640195] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1768bob # [ 4.640972] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1769bob # [ 4.641685] systemd[1]: Stopped Virtual Console Setup.1770alice # [ 4.679481] systemd[1]: Starting NixOS Activation...1771bob # [ 4.644212] systemd[1]: systemd-udevd.service: Deactivated successfully.1772bob # [ 4.644836] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1773bob # [ 4.645473] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1774bob # [ 4.648247] systemd[1]: Closed udev Control Socket.1775bob # [ 4.648736] systemd[1]: Starting Cleanup udev Database...1776bob # [ 4.649227] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1777bob # [ 4.649906] systemd[1]: Stopped Create Static Device Nodes in /dev.1778bob # [ 4.652386] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1779bob # [ 4.653171] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1780bob # [ 4.656611] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1781bob # [ 4.657262] systemd[1]: Stopped Create List of Static Device Nodes.1782bob # [ 4.657820] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1783bob # [ 4.658443] systemd[1]: Finished rw-sysroot-nix-store.service.1784bob # [ 4.664049] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1785bob # [ 4.664765] systemd[1]: Finished Cleanup udev Database.1786bob # [ 4.665251] systemd[1]: Reached target Switch Root.1787bob # [ 4.665718] systemd[1]: Starting NixOS Activation...1788alice # [ 4.752612] initrd-nixos-activation-start[173]: booting system configuration /nix/store/5mrv0g4znr0sd45nr4sd8pdaz46s4fbl-nixos-system-alice-test1789bob # [ 4.734616] initrd-nixos-activation-start[174]: booting system configuration /nix/store/3x6i2g70yfi9bj03k2sr6girqyjnhfzm-nixos-system-bob-test1790alice # [ 4.778960] initrd-nixos-activation-start[173]: running activation script...1791bob # [ 4.761609] initrd-nixos-activation-start[174]: running activation script...1792clare # [ 4.907984] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1793clare # [ 4.908078] systemd[1]: Detected virtualization qemu.1794clare # [ 4.908137] systemd[1]: Detected architecture arm64.1795clare # [ 4.908250] systemd[1]: Detected first boot.1796clare # [ 4.910453] systemd[1]: Initializing machine ID from random generator.1797alice # [ 4.985685] initrd-nixos-activation-start[196]: setting up /etc...1798bob # [ 4.968790] initrd-nixos-activation-start[197]: setting up /etc...1799alice # [ 5.072903] initrd-nixos-activation-start[196]: setting up age secrets...1800bob # [ 5.061530] initrd-nixos-activation-start[197]: setting up age secrets...1801alice # [ 5.132511] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1802alice # [ 5.134039] systemd[1]: Finished NixOS Activation.1803alice # [ 5.134742] systemd[1]: Starting Switch Root...1804alice # [ 5.151952] systemd[1]: Switching root.1805bob # [ 5.138979] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1806bob # [ 5.140829] systemd[1]: Finished NixOS Activation.1807bob # [ 5.141586] systemd[1]: Starting Switch Root...1808bob # [ 5.160204] systemd[1]: Switching root.1809clare # [ 5.239405] systemd[1]: bpf-restrict-fs: LSM BPF program attached1810alice # [ 5.317216] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1811bob # [ 5.327599] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1812clare # [ 5.365727] systemd[1]: Applying preset policy.1813clare # [ 5.517552] systemd[1]: Populated /etc with preset unit settings.1814clare # [ 5.725379] systemd[1]: initrd-switch-root.service: Deactivated successfully.1815clare # [ 5.725653] systemd[1]: Stopped initrd-switch-root.service.1816clare # [ 5.728613] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1817clare # [ 5.729557] systemd[1]: Created slice Slice /system/getty.1818clare # [ 5.730474] systemd[1]: Created slice User and Session Slice.1819clare # [ 5.733351] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1820clare # [ 5.733920] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1821clare # [ 5.734489] systemd[1]: Expecting device /dev/hvc0...1822clare # [ 5.737291] systemd[1]: Expecting device /dev/ttyAMA0...1823clare # [ 5.737778] systemd[1]: Reached target Local Encrypted Volumes.1824clare # [ 5.738357] systemd[1]: Stopped target initrd-fs.target.1825clare # [ 5.740814] systemd[1]: Stopped target initrd-root-fs.target.1826clare # [ 5.741276] systemd[1]: Stopped target initrd-switch-root.target.1827clare # [ 5.741827] systemd[1]: Reached target Virtual Machines and Containers.1828clare # [ 5.742356] systemd[1]: Reached target Path Units.1829clare # [ 5.745262] systemd[1]: Reached target Remote File Systems.1830clare # [ 5.745732] systemd[1]: Reached target Slice Units.1831clare # [ 5.746283] systemd[1]: Reached target Swaps.1832clare # [ 5.749838] systemd[1]: Listening on Query the User Interactively for a Password.1833clare # [ 5.752832] systemd[1]: Listening on Process Core Dump Socket.1834clare # [ 5.754313] systemd[1]: Listening on Credential Encryption/Decryption.1835clare # [ 5.757001] systemd[1]: Listening on Factory Reset Management.1836clare # [ 5.757545] systemd[1]: Listening on Hostname Service Socket.1837clare # [ 5.760848] systemd[1]: Starting Journal Log Access Socket...1838clare # [ 5.762087] systemd[1]: Listening on Journal Audit Socket.1839clare # [ 5.765602] systemd[1]: Listening on Console Output Muting Service Socket.1840clare # [ 5.766241] systemd[1]: Listening on Network Management Metrics Varlink Socket.1841clare # [ 5.768853] systemd[1]: Listening on Network Management Varlink Socket.1842clare # [ 5.770299] systemd[1]: Listening on Network Management Netlink Socket.1843clare # [ 5.771994] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1844clare # [ 5.772495] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1845clare # [ 5.772970] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1846clare # [ 5.778529] systemd[1]: Listening on Disk Repartitioning Service Socket.1847clare # [ 5.779067] systemd[1]: Listening on Resolve Monitor Varlink Socket.1848clare # [ 5.779618] systemd[1]: Listening on Resolve Service Varlink Socket.1849clare # [ 5.780159] systemd[1]: Listening on udev Control Socket.1850clare # [ 5.780714] systemd[1]: Listening on udev Varlink Socket.1851clare # [ 5.782444] systemd[1]: Mounting Huge Pages File System...1852alice # [ 5.816519] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1853alice # [ 5.823482] systemd[1]: Detected virtualization qemu.1854alice # [ 5.824130] systemd[1]: Detected architecture arm64.1855clare # [ 5.787327] systemd[1]: Mounting POSIX Message Queue File System...1856alice # [ 5.827384] systemd[1]: Detected first boot.1857alice # [ 5.830496] systemd[1]: Initializing machine ID from random generator.1858clare # [ 5.794671] systemd[1]: Mounting Kernel Debug File System...1859clare # [ 5.803134] systemd[1]: Mounting Kernel Trace File System...1860clare # [ 5.812442] systemd[1]: Starting Create List of Static Device Nodes...1861clare # [ 5.815262] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1862clare # [ 5.824542] systemd[1]: Mounting Kernel Configuration File System...1863clare # [ 5.824968] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1864clare # [ 5.830603] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1865clare # [ 5.831052] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1866clare # [ 5.839421] systemd[1]: Mounting FUSE Control File System...1867clare # [ 5.842494] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671868bob # [ 5.862689] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1869bob # [ 5.862785] systemd[1]: Detected virtualization qemu.1870clare # [ 5.871874] systemd[1]: Starting Journal Service...1871bob # [ 5.862843] systemd[1]: Detected architecture arm64.1872bob # [ 5.862957] systemd[1]: Detected first boot.1873bob # [ 5.865659] systemd[1]: Initializing machine ID from random generator.1874clare # [ 5.886667] systemd[1]: Starting Load Kernel Modules...1875clare # [ 5.901304] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1876clare # [ 5.910750] systemd[1]: Starting Remount Root and Kernel File Systems...1877clare # [ 5.911123] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1878clare # [ 5.924353] systemd[1]: Starting Coldplug All udev Devices...1879clare # [ 5.928807] systemd[1]: Listening on Journal Log Access Socket.1880clare # [ 5.929248] systemd[1]: Mounted Huge Pages File System.1881clare # [ 5.929611] systemd[1]: Mounted POSIX Message Queue File System.1882clare # [ 5.929958] systemd[1]: Mounted Kernel Debug File System.1883clare # [ 5.930300] systemd[1]: Mounted Kernel Trace File System.1884clare # [ 5.944527] systemd[1]: Finished Create List of Static Device Nodes.1885clare # [ 5.945167] systemd[1]: Finished Load Kernel Modules.1886clare # [ 5.959291] systemd[1]: Starting Firewall...1887clare # [ 5.968133] systemd[1]: Starting Apply Kernel Variables...1888clare # [ 5.982390] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1889clare # [ 5.992079] systemd-journald[283]: Collecting audit messages is enabled.1890clare # [ 6.001210] systemd[1]: Mounted Kernel Configuration File System.1891clare # [ 6.008872] systemd[1]: Started Journal Service.1892clare # [ 6.010633] EXT4-fs (vda): re-mounted 07b9ffc2-93c7-4939-8bcd-5eb6885e5e34.1893clare # [ 6.007456] systemd[1]: Queued start job for default target Multi-User System.1894clare # [ 6.008565] systemd[1]: systemd-journald.service: Deactivated successfully.1895clare # [ 6.009384] systemd-modules-load[284]: Module 'atkbd' is built in1896clare # [ 6.010034] systemd-modules-load[284]: Module 'loop' is built in1897clare # [ 6.010661] systemd[1]: Mounted FUSE Control File System.1898clare # [ 6.022966] systemd[1]: Finished Remount Root and Kernel File Systems.1899clare # [ 6.030350] systemd-oomd[285]: No swap; memory pressure usage will be degraded1900clare # [ 6.047740] systemd[1]: Listening on Disk Image Download Service Socket.1901clare # [ 6.052251] systemd[1]: Starting Flush Journal to Persistent Storage...1902clare # [ 6.052878] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1903clare # [ 6.063328] systemd[1]: Starting Load/Save OS Random Seed...1904clare # [ 6.063892] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1905clare # [ 6.065247] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1906alice # [ 6.137373] systemd[1]: bpf-restrict-fs: LSM BPF program attached1907clare # [ 6.109036] systemd[1]: Finished Apply Kernel Variables.1908clare # [ 6.116748] systemd-journald[283]: Received client request to flush runtime journal.1909bob # [ 6.155316] systemd[1]: bpf-restrict-fs: LSM BPF program attached1910clare # [ 6.166570] systemd[1]: Starting Network Name Resolution...1911clare # [ 6.176288] systemd[1]: Finished Load/Save OS Random Seed.1912clare # [ 6.176875] systemd[1]: Reached target First Boot Complete.1913clare # [ 6.177885] systemd[1]: Finished Flush Journal to Persistent Storage.1914alice # [ 6.253926] systemd[1]: Applying preset policy.1915bob # [ 6.261018] systemd[1]: Applying preset policy.1916clare # [ 6.292804] systemd-resolved[308]: Positive Trust Anchors:1917clare # [ 6.293394] systemd-resolved[308]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1918clare # [ 6.294275] systemd-resolved[308]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161919clare # [ 6.295142] systemd-resolved[308]: 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 test1920clare # [ 6.345647] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1921clare # [ 6.349253] systemd[1]: Starting Create Static Device Nodes in /dev...1922alice # [ 6.412399] systemd[1]: Populated /etc with preset unit settings.1923bob # [ 6.423218] systemd[1]: Populated /etc with preset unit settings.1924clare # [ 6.484415] systemd-resolved[308]: Using system hostname 'clare'.1925clare # [ 6.487188] systemd[1]: Started Network Name Resolution.1926clare # [ 6.508469] systemd[1]: Finished Coldplug All udev Devices.1927clare # [ 6.519985] systemd[1]: Finished Create Static Device Nodes in /dev.1928clare # [ 6.521800] systemd[1]: Reached target Preparation for Local File Systems.1929clare # [ 6.523177] systemd[1]: Starting Rule-based Manager for Device Events and Files...1930clare # [ 6.573181] systemd-udevd[328]: Using default interface naming scheme 'v261'.1931alice # [ 6.623631] systemd[1]: initrd-switch-root.service: Deactivated successfully.1932alice # [ 6.624286] systemd[1]: Stopped initrd-switch-root.service.1933alice # [ 6.627575] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1934alice # [ 6.630044] systemd[1]: Created slice Slice /system/getty.1935alice # [ 6.631049] systemd[1]: Created slice User and Session Slice.1936alice # [ 6.631612] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1937alice # [ 6.632212] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1938alice # [ 6.635367] systemd[1]: Expecting device /dev/hvc0...1939alice # [ 6.635840] systemd[1]: Expecting device /dev/ttyAMA0...1940alice # [ 6.636413] systemd[1]: Reached target Local Encrypted Volumes.1941alice # [ 6.638767] systemd[1]: Stopped target initrd-fs.target.1942alice # [ 6.639234] systemd[1]: Stopped target initrd-root-fs.target.1943alice # [ 6.639775] systemd[1]: Stopped target initrd-switch-root.target.1944alice # [ 6.640340] systemd[1]: Reached target Virtual Machines and Containers.1945alice # [ 6.643231] systemd[1]: Reached target Path Units.1946alice # [ 6.643686] systemd[1]: Reached target Remote File Systems.1947alice # [ 6.644234] systemd[1]: Reached target Slice Units.1948alice # [ 6.646478] systemd[1]: Reached target Swaps.1949alice # [ 6.648292] systemd[1]: Listening on Query the User Interactively for a Password.1950alice # [ 6.651704] systemd[1]: Listening on Process Core Dump Socket.1951alice # [ 6.653831] systemd[1]: Listening on Credential Encryption/Decryption.1952alice # [ 6.655442] systemd[1]: Listening on Factory Reset Management.1953alice # [ 6.655989] systemd[1]: Listening on Hostname Service Socket.1954alice # [ 6.660097] systemd[1]: Starting Journal Log Access Socket...1955alice # [ 6.661665] systemd[1]: Listening on Journal Audit Socket.1956clare # [ 6.622598] systemd[1]: Started Rule-based Manager for Device Events and Files.1957alice # [ 6.663779] systemd[1]: Listening on Console Output Muting Service Socket.1958alice # [ 6.664436] systemd[1]: Listening on Network Management Metrics Varlink Socket.1959alice # [ 6.667154] systemd[1]: Listening on Network Management Varlink Socket.1960alice # [ 6.667785] systemd[1]: Listening on Network Management Netlink Socket.1961bob # [ 6.633643] systemd[1]: initrd-switch-root.service: Deactivated successfully.1962alice # [ 6.668491] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1963bob # [ 6.633907] systemd[1]: Stopped initrd-switch-root.service.1964alice # [ 6.671341] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1965alice # [ 6.671900] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1966bob # [ 6.636998] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1967bob # [ 6.638203] systemd[1]: Created slice Slice /system/getty.1968bob # [ 6.641007] systemd[1]: Created slice User and Session Slice.1969bob # [ 6.641582] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1970bob # [ 6.642184] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1971alice # [ 6.677898] systemd[1]: Listening on Disk Repartitioning Service Socket.1972alice # [ 6.678417] systemd[1]: Listening on Resolve Monitor Varlink Socket.1973bob # [ 6.644930] systemd[1]: Expecting device /dev/hvc0...1974bob # [ 6.645416] systemd[1]: Expecting device /dev/ttyAMA0...1975bob # [ 6.645987] systemd[1]: Reached target Local Encrypted Volumes.1976alice # [ 6.678957] systemd[1]: Listening on Resolve Service Varlink Socket.1977alice # [ 6.679620] systemd[1]: Listening on udev Control Socket.1978alice # [ 6.680191] systemd[1]: Listening on udev Varlink Socket.1979bob # [ 6.648409] systemd[1]: Stopped target initrd-fs.target.1980bob # [ 6.648886] systemd[1]: Stopped target initrd-root-fs.target.1981bob # [ 6.649470] systemd[1]: Stopped target initrd-switch-root.target.1982bob # [ 6.650049] systemd[1]: Reached target Virtual Machines and Containers.1983alice # [ 6.685008] systemd[1]: Mounting Huge Pages File System...1984alice # [ 6.686580] systemd[1]: Mounting POSIX Message Queue File System...1985bob # [ 6.652997] systemd[1]: Reached target Path Units.1986bob # [ 6.653468] systemd[1]: Reached target Remote File Systems.1987bob # [ 6.654021] systemd[1]: Reached target Slice Units.1988bob # [ 6.656288] systemd[1]: Reached target Swaps.1989bob # [ 6.658182] systemd[1]: Listening on Query the User Interactively for a Password.1990bob # [ 6.661226] systemd[1]: Listening on Process Core Dump Socket.1991alice # [ 6.696638] systemd[1]: Mounting Kernel Debug File System...1992alice # [ 6.698323] systemd[1]: Mounting Kernel Trace File System...1993bob # [ 6.663263] systemd[1]: Listening on Credential Encryption/Decryption.1994bob # [ 6.664882] systemd[1]: Listening on Factory Reset Management.1995bob # [ 6.665437] systemd[1]: Listening on Hostname Service Socket.1996bob # [ 6.669295] systemd[1]: Starting Journal Log Access Socket...1997bob # [ 6.670380] systemd[1]: Listening on Journal Audit Socket.1998bob # [ 6.674081] systemd[1]: Listening on Console Output Muting Service Socket.1999alice # [ 6.709448] systemd[1]: Starting Create List of Static Device Nodes...2000bob # [ 6.676013] systemd[1]: Listening on Network Management Metrics Varlink Socket.2001bob # [ 6.677427] systemd[1]: Listening on Network Management Varlink Socket.2002bob # [ 6.678000] systemd[1]: Listening on Network Management Netlink Socket.2003alice # [ 6.713188] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2004bob # [ 6.680707] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2005bob # [ 6.681188] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2006bob # [ 6.681702] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2007alice # [ 6.719154] systemd[1]: Mounting Kernel Configuration File System...2008alice # [ 6.721804] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2009bob # [ 6.687345] systemd[1]: Listening on Disk Repartitioning Service Socket.2010bob # [ 6.687871] systemd[1]: Listening on Resolve Monitor Varlink Socket.2011bob # [ 6.688404] systemd[1]: Listening on Resolve Service Varlink Socket.2012bob # [ 6.688942] systemd[1]: Listening on udev Control Socket.2013bob # [ 6.689501] systemd[1]: Listening on udev Varlink Socket.2014bob # [ 6.693739] systemd[1]: Mounting Huge Pages File System...2015alice # [ 6.728995] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2016bob # [ 6.696090] systemd[1]: Mounting POSIX Message Queue File System...2017alice # [ 6.729357] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2018alice # [ 6.740399] systemd[1]: Mounting FUSE Control File System...2019alice # [ 6.743794] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672020bob # [ 6.706732] systemd[1]: Mounting Kernel Debug File System...2021bob # [ 6.712555] systemd[1]: Mounting Kernel Trace File System...2022bob # [ 6.721704] systemd[1]: Starting Create List of Static Device Nodes...2023bob # [ 6.722117] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2024clare # [ 6.723591] systemd[1]: Mounting /run/wrappers...2025bob # [ 6.731927] systemd[1]: Mounting Kernel Configuration File System...2026bob # [ 6.735187] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2027alice # [ 6.774466] systemd[1]: Starting Journal Service...2028bob # [ 6.740079] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2029bob # [ 6.741446] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2030alice # [ 6.788060] systemd[1]: Starting Load Kernel Modules...2031clare # [ 6.756954] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2032alice # [ 6.798689] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2033bob # [ 6.768972] systemd[1]: Mounting FUSE Control File System...2034bob # [ 6.769359] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672035alice # [ 6.812798] systemd[1]: Starting Remount Root and Kernel File Systems...2036clare # [ 6.774129] systemd[1]: Mounted /run/wrappers.2037alice # [ 6.814063] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2038clare # [ 6.774625] systemd[1]: Reached target Local File Systems.2039clare # [ 6.778895] systemd[1]: Listening on Boot Loader Control Service Socket.2040clare # [ 6.783163] systemd[1]: Starting register-nix-paths.service...2041alice # [ 6.827717] systemd[1]: Starting Coldplug All udev Devices...2042clare # [ 6.786346] systemd[1]: Starting Create SUID/SGID Wrappers...2043bob # [ 6.793218] systemd[1]: Starting Journal Service...2044clare # [ 6.786925] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2045clare # [ 6.792250] systemd[1]: Starting Save Transient machine-id to Disk...2046alice # [ 6.833954] systemd[1]: Listening on Journal Log Access Socket.2047alice # [ 6.834400] systemd[1]: Mounted Huge Pages File System.2048alice # [ 6.834770] systemd[1]: Mounted POSIX Message Queue File System.2049bob # [ 6.801717] systemd[1]: Starting Load Kernel Modules...2050alice # [ 6.835101] systemd[1]: Mounted Kernel Debug File System.2051alice # [ 6.835424] systemd[1]: Mounted Kernel Trace File System.2052clare # [ 6.800495] systemd[1]: Starting Create System Files and Directories...2053alice # [ 6.843568] systemd[1]: Finished Create List of Static Device Nodes.2054bob # [ 6.812028] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2055clare # [ 6.809071] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2056alice # [ 6.855846] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2057alice # [ 6.859621] systemd[1]: Finished Load Kernel Modules.2058bob # [ 6.823207] systemd[1]: Starting Remount Root and Kernel File Systems...2059bob # [ 6.823576] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2060alice # [ 6.862310] systemd-journald[281]: Collecting audit messages is enabled.2061alice # [ 6.868500] systemd[1]: Starting Firewall...2062alice # [ 6.869080] systemd[1]: Queued start job for default target Multi-User System.2063alice # [ 6.872834] systemd[1]: systemd-journald.service: Deactivated successfully.2064bob # [ 6.841616] systemd[1]: Starting Coldplug All udev Devices...2065alice # [ 6.873610] systemd-modules-load[282]: Module 'atkbd' is built in2066alice # [ 6.874257] systemd-modules-load[282]: Module 'loop' is built in2067alice # [ 6.881477] systemd[1]: Starting Apply Kernel Variables...2068alice # [ 6.881958] systemd[1]: Started Journal Service.2069bob # [ 6.847919] systemd[1]: Listening on Journal Log Access Socket.2070bob # [ 6.848372] systemd[1]: Mounted Huge Pages File System.2071bob # [ 6.848735] systemd[1]: Mounted POSIX Message Queue File System.2072bob # [ 6.849104] systemd[1]: Mounted Kernel Debug File System.2073bob # [ 6.849444] systemd[1]: Mounted Kernel Trace File System.2074bob # [ 6.867746] systemd[1]: Finished Create List of Static Device Nodes.2075bob # [ 6.868313] systemd[1]: Mounted Kernel Configuration File System.2076bob # [ 6.873148] systemd-journald[290]: Collecting audit messages is enabled.2077bob # [ 6.880976] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2078bob # [ 6.886691] systemd[1]: Finished Load Kernel Modules.2079bob # [ 6.887183] systemd[1]: Started Journal Service.2080bob # [ 6.885397] systemd[1]: Queued start job for default target Multi-User System.2081bob # [ 6.886264] systemd[1]: systemd-journald.service: Deactivated successfully.2082bob # [ 6.887066] systemd-modules-load[291]: Module 'atkbd' is built in2083bob # [ 6.887726] systemd-modules-load[291]: Module 'loop' is built in2084alice # [ 6.930826] EXT4-fs (vda): re-mounted 85c4d184-e71d-4416-a635-a78665477d19.2085clare # [ 6.897373] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2086alice # [ 6.937014] systemd[1]: Mounted Kernel Configuration File System.2087bob # [ 6.902343] systemd[1]: Starting Firewall...2088alice # [ 6.941086] systemd[1]: Mounted FUSE Control File System.2089alice # [ 6.944080] systemd[1]: Finished Remount Root and Kernel File Systems.2090clare # [ 6.906047] systemd[1]: Finished Save Transient machine-id to Disk.2091alice # [ 6.944705] systemd[1]: Listening on Disk Image Download Service Socket.2092bob # [ 6.912077] systemd[1]: Starting Apply Kernel Variables...2093alice # [ 6.956259] systemd[1]: Starting Flush Journal to Persistent Storage...2094alice # [ 6.956897] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2095alice # [ 6.966699] systemd[1]: Starting Load/Save OS Random Seed...2096alice # [ 6.967253] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2097bob # [ 6.934536] EXT4-fs (vda): re-mounted 69bd0452-41c9-4514-a862-d6c3778b8fed.2098alice # [ 6.973483] systemd-oomd[283]: No swap; memory pressure usage will be degraded2099bob # [ 6.945124] systemd[1]: Mounted FUSE Control File System.2100alice # [ 6.991553] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2101bob # [ 6.956406] systemd[1]: Finished Remount Root and Kernel File Systems.2102bob # [ 6.962531] systemd[1]: Listening on Disk Image Download Service Socket.2103clare # [ 6.963031] systemd[1]: Finished Create System Files and Directories.2104bob # [ 6.968379] systemd-oomd[292]: No swap; memory pressure usage will be degraded2105bob # [ 6.971145] systemd[1]: Starting Flush Journal to Persistent Storage...2106bob # [ 6.971753] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2107clare # [ 6.971361] systemd[1]: Starting Rebuild Journal Catalog...2108clare # [ 6.976400] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2109bob # [ 6.984332] systemd[1]: Starting Load/Save OS Random Seed...2110bob # [ 6.984882] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2111bob # [ 6.985617] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2112alice # [ 7.033719] systemd-journald[281]: Received client request to flush runtime journal.2113alice # [ 7.076381] systemd[1]: Finished Load/Save OS Random Seed.2114alice # [ 7.076966] systemd[1]: Reached target First Boot Complete.2115alice # [ 7.077500] systemd[1]: Finished Apply Kernel Variables.2116bob # [ 7.044395] systemd[1]: Finished Load/Save OS Random Seed.2117bob # [ 7.044976] systemd[1]: Reached target First Boot Complete.2118alice # [ 7.082131] systemd[1]: Starting Network Name Resolution...2119alice # [ 7.088158] systemd[1]: Finished Flush Journal to Persistent Storage.2120bob # [ 7.059298] systemd-journald[290]: Received client request to flush runtime journal.2121clare # [ 7.062723] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2122clare # [ 7.073137] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2123alice # [ 7.121438] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2124alice # [ 7.122955] systemd[1]: Starting Create Static Device Nodes in /dev...2125bob # [ 7.098325] systemd[1]: Finished Apply Kernel Variables.2126bob # [ 7.098923] systemd[1]: Starting Network Name Resolution...2127bob # [ 7.105410] systemd[1]: Finished Flush Journal to Persistent Storage.2128clare # [ 7.110522] systemd[1]: Finished Rebuild Journal Catalog.2129clare # [ 7.116149] systemd[1]: Starting Update is Completed...2130bob # [ 7.124805] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2131bob # [ 7.128143] systemd[1]: Starting Create Static Device Nodes in /dev...2132clare # [ 7.146431] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2133clare # [ 7.174239] systemd[1]: Finished Update is Completed.2134alice # [ 7.224757] systemd-resolved[309]: Positive Trust Anchors:2135alice # [ 7.225339] systemd-resolved[309]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2136alice # [ 7.226226] systemd-resolved[309]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162137alice # [ 7.227080] systemd-resolved[309]: 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 test2138bob # [ 7.232814] systemd-resolved[317]: Positive Trust Anchors:2139bob # [ 7.233415] systemd-resolved[317]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2140bob # [ 7.234265] systemd-resolved[317]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162141bob # [ 7.235141] 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 test2142alice # [ 7.397660] systemd[1]: Finished Create Static Device Nodes in /dev.2143alice # [ 7.398282] systemd[1]: Reached target Preparation for Local File Systems.2144alice # [ 7.400206] systemd[1]: Starting Rule-based Manager for Device Events and Files...2145clare # [ 7.373919] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line.2146alice # [ 7.416448] systemd-resolved[309]: Using system hostname 'alice'.2147clare # [ 7.381002] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line.2148alice # [ 7.420837] systemd[1]: Started Network Name Resolution.2149bob # [ 7.397641] systemd[1]: Finished Create Static Device Nodes in /dev.2150bob # [ 7.398289] systemd[1]: Reached target Preparation for Local File Systems.2151bob # [ 7.399841] systemd[1]: Starting Rule-based Manager for Device Events and Files...2152bob # [ 7.406440] systemd-resolved[317]: Using system hostname 'bob'.2153bob # [ 7.409349] systemd[1]: Started Network Name Resolution.2154alice # [ 7.453848] systemd[1]: Finished Coldplug All udev Devices.2155alice # [ 7.484487] systemd-udevd[320]: Using default interface naming scheme 'v261'.2156bob # [ 7.454598] systemd[1]: Finished Coldplug All udev Devices.2157bob # [ 7.488189] systemd-udevd[332]: Using default interface naming scheme 'v261'.2158alice # [ 7.536124] systemd[1]: Started Rule-based Manager for Device Events and Files.2159bob # [ 7.536217] systemd[1]: Started Rule-based Manager for Device Events and Files.2160alice # [ 7.622010] systemd[1]: Mounting /run/wrappers...2161alice # [ 7.659198] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2162clare # [ 7.625423] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2163clare # [ 7.627314] systemd[1]: Finished Create SUID/SGID Wrappers.2164bob # [ 7.630787] systemd[1]: Mounting /run/wrappers...2165alice # [ 7.669311] systemd[1]: Mounted /run/wrappers.2166alice # [ 7.669811] systemd[1]: Reached target Local File Systems.2167clare # [ 7.633829] systemd[1]: Finished register-nix-paths.service.2168alice # [ 7.673998] systemd[1]: Listening on Boot Loader Control Service Socket.2169clare # [ 7.636726] systemd[1]: Reached target System Initialization.2170clare # [ 7.639140] systemd[1]: Started Discard unused filesystem blocks once a week.2171alice # [ 7.677477] systemd[1]: Starting register-nix-paths.service...2172clare # [ 7.639817] systemd[1]: Started Daily Cleanup of Temporary Directories.2173clare # [ 7.642375] systemd[1]: Reached target Timer Units.2174alice # [ 7.681120] systemd[1]: Starting Create SUID/SGID Wrappers...2175clare # [ 7.642852] systemd[1]: Listening on D-Bus System Message Bus Socket.2176alice # [ 7.683010] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2177alice # [ 7.686501] systemd[1]: Starting Save Transient machine-id to Disk...2178clare # [ 7.650238] systemd[1]: Listening on harmonia binary cache socket.2179clare # [ 7.650848] systemd[1]: Listening on Nix Daemon Socket.2180clare # [ 7.651328] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2181clare # [ 7.658878] mousedev: PS/2 mouse device common for all mice2182clare # [ 7.656728] systemd[1]: Reached target Socket Units.2183clare # [ 7.657264] systemd[1]: Reached target Basic System.2184clare # [ 7.657733] systemd[1]: Started backdoor.service.2185clare # [ 7.658175] systemd[1]: Starting Import lastlog data into lastlog2 database...2186alice # [ 7.698740] systemd[1]: Starting Create System Files and Directories...2187alice # [ 7.699398] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2188bob # [ 7.666459] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2189clare # [ 7.666610] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2190bob # [ 7.676879] systemd[1]: Mounted /run/wrappers.2191bob # [ 7.677376] systemd[1]: Reached target Local File Systems.2192clare # [ 7.677959] systemd[1]: Starting Post-Boot Actions...2193bob # [ 7.682394] systemd[1]: Listening on Boot Loader Control Service Socket.2194bob # [ 7.686570] systemd[1]: Starting register-nix-paths.service...2195bob # [ 7.689711] systemd[1]: Starting Create SUID/SGID Wrappers...2196bob # [ 7.690270] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2197bob # [ 7.695185] systemd[1]: Starting Save Transient machine-id to Disk...2198clare # [ 7.705125] systemd[1]: Started Reset console on configuration changes.2199bob # [ 7.711195] systemd[1]: Starting Create System Files and Directories...2200bob # [ 7.711870] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2201clare # [ 7.735952] systemd[1]: Starting D-Bus System Message Bus...2202alice # [ 7.810691] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2203alice # [ 7.816546] systemd[1]: Finished Save Transient machine-id to Disk.2204clare # connecting to host...2205clare # [ 7.801371] systemd[1]: Finished Post-Boot Actions.2206bob # [ 7.805438] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2207bob # [ 7.812441] systemd[1]: Finished Save Transient machine-id to Disk.2208clare # [ 7.815229] systemd[1]: Started Name Service Cache Daemon (nsncd).2209clare # [ 7.815870] systemd[1]: Reached target Host and Network Name Lookups.2210clare # [ 7.820930] nsncd[480]: Sep 27 17:41:45.655 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2211clare # [ 7.822161] systemd[1]: Reached target User and Group Name Lookups.2212alice # [ 7.862725] systemd[1]: Finished Create System Files and Directories.2213clare # [ 7.834269] systemd[1]: Starting User Login Management...2214alice # [ 7.873669] systemd[1]: Starting Rebuild Journal Catalog...2215alice # [ 7.880790] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2216bob # [ 7.861500] systemd[1]: Finished Create System Files and Directories.2217clare # [ 7.868254] systemd[1]: Finished Import lastlog data into lastlog2 database.2218bob # [ 7.870616] systemd[1]: Starting Rebuild Journal Catalog...2219bob # [ 7.879121] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2220clare # [ 7.934094] dbus-broker-launch[488]: Looking up NSS user entry for 'systemd-timesync'...2221alice # [ 7.976087] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2222clare # [ 7.942496] dbus-broker-launch[488]: NSS returned no entry for 'systemd-timesync'2223clare # [ 7.943169] dbus-broker-launch[488]: Invalid user-name in /nix/store/6g1ahficw481g361kpzn9p34kp6lxn53-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2224alice # [ 7.994435] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2225clare # [ 7.956349] systemd-logind[502]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2226bob # [ 7.961719] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2227clare # [ 7.959523] systemd-logind[502]: Watching system buttons on /dev/input/event0 (gpio-keys)2228clare # [ 7.961214] systemd-logind[502]: New seat seat0.2229clare # [ 7.964844] systemd[1]: Started User Login Management.2230clare # [ 7.968158] systemd[1]: Starting linger-users.service...2231alice # [ 8.009623] systemd[1]: Finished Rebuild Journal Catalog.2232alice # [ 8.017838] systemd[1]: Starting Update is Completed...2233alice # [ 8.019303] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2234clare # [ 7.985561] systemd[1]: Started D-Bus System Message Bus.2235bob # [ 8.001118] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2236bob # [ 8.012503] systemd[1]: Finished Rebuild Journal Catalog.2237bob # [ 8.019436] systemd[1]: Starting Update is Completed...2238clare # [ 8.020999] dbus-broker-launch[488]: Ready2239alice # [ 8.072369] systemd[1]: Finished Update is Completed.2240clare # [ 8.037893] systemd[1]: linger-users.service: Deactivated successfully.2241clare # [ 8.039784] systemd[1]: Finished linger-users.service.2242bob # [ 8.057067] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2243clare # [ 8.083289] systemd[1]: Finished Firewall.2244bob # [ 8.086181] systemd[1]: Finished Update is Completed.2245clare # [ 8.085028] systemd[1]: Reached target Preparation for Network.2246clare # [ 8.088936] systemd[1]: Listening on Network Management Resolve Hook Socket.2247clare # [ 8.091989] systemd[1]: Starting Network Management...2248alice # [ 8.282730] (udev-worker)[347]: Network interface NamePolicy= disabled on kernel command line.2249alice # [ 8.291688] (udev-worker)[341]: Network interface NamePolicy= disabled on kernel command line.2250clare # [ 8.265373] cfg80211: Loading compiled-in X.509 certificates for regulatory database2251bob # [ 8.297050] (udev-worker)[351]: Network interface NamePolicy= disabled on kernel command line.2252clare # [ 8.306413] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2253bob # [ 8.303479] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line.2254clare # [ 8.307495] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2255clare # [ 8.309159] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22256clare # [ 8.309528] cfg80211: failed to load regulatory.db2257clare # [ 8.334704] systemd-networkd[541]: lo: Link UP2258clare # [ 8.336436] systemd-networkd[541]: lo: Gained carrier2259clare # [ 8.343616] systemd[1]: Started Network Management.2260clare # [ 8.350409] systemd[1]: Reached target Network.2261clare # [ 8.350886] systemd-networkd[541]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2262clare # [ 8.351717] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2263clare # [ 8.359589] systemd-networkd[541]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2264clare # [ 8.363281] systemd-networkd[541]: eth0: Link UP2265clare # [ 8.363723] systemd-networkd[541]: eth1: Link UP2266clare # [ 8.366556] systemd-networkd[541]: eth0: Gained carrier2267clare # [ 8.367038] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2268clare # [ 8.367676] systemd-networkd[541]: eth1: Gained carrier2269clare # [ 8.373710] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2270clare # [ 8.375046] systemd[1]: Starting Permit User Sessions...2271clare # [ 8.381695] systemd-networkd[541]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22272clare # [ 8.437703] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2273clare # [ 8.440202] systemd[1]: Finished Permit User Sessions.2274clare # [ 8.444357] systemd[1]: Started Getty on tty1.2275clare # [ 8.446013] systemd[1]: Reached target Login Prompts.2276clare # [ 8.448244] systemd[1]: Reached target Multi-User System.2277clare # [ 8.448815] systemd[1]: Startup finished in 707ms (kernel) + 3.764s (initrd) + 3.975s (userspace) = 8.447s.2278alice # [ 8.493134] mousedev: PS/2 mouse device common for all mice2279alice # [ 8.504782] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2280alice # [ 8.505479] systemd[1]: Finished Create SUID/SGID Wrappers.2281alice # [ 8.526965] systemd[1]: Finished register-nix-paths.service.2282alice # [ 8.528745] systemd[1]: Reached target System Initialization.2283alice # [ 8.532146] systemd[1]: Started Discard unused filesystem blocks once a week.2284alice # [ 8.532829] systemd[1]: Started Daily Cleanup of Temporary Directories.2285alice # [ 8.533436] systemd[1]: Reached target Timer Units.2286alice # [ 8.533922] systemd[1]: Listening on D-Bus System Message Bus Socket.2287alice # [ 8.534511] systemd[1]: Listening on Nix Daemon Socket.2288alice # [ 8.534996] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2289alice # [ 8.535748] systemd[1]: Reached target Socket Units.2290alice # [ 8.548757] systemd[1]: Reached target Basic System.2291alice # [ 8.549253] systemd[1]: Started backdoor.service.2292alice # [ 8.549699] systemd[1]: Starting Import lastlog data into lastlog2 database...2293alice # [ 8.550327] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2294bob # [ 8.516655] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2295bob # [ 8.520161] systemd[1]: Finished Create SUID/SGID Wrappers.2296alice # [ 8.559786] systemd[1]: Starting Post-Boot Actions...2297bob # [ 8.528019] mousedev: PS/2 mouse device common for all mice2298alice # [ 8.583771] systemd[1]: Started Reset console on configuration changes.2299alice # [ 8.609419] systemd[1]: Starting D-Bus System Message Bus...2300bob # [ 8.582023] systemd[1]: Finished register-nix-paths.service.2301bob # [ 8.583874] systemd[1]: Reached target System Initialization.2302bob # [ 8.586821] systemd[1]: Started Discard unused filesystem blocks once a week.2303bob # [ 8.587473] systemd[1]: Started Daily Cleanup of Temporary Directories.2304bob # [ 8.591770] systemd[1]: Reached target Timer Units.2305bob # [ 8.593280] systemd[1]: Listening on D-Bus System Message Bus Socket.2306bob # [ 8.593890] systemd[1]: Listening on Nix Daemon Socket.2307bob # [ 8.594382] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2308bob # [ 8.595164] systemd[1]: Reached target Socket Units.2309bob # [ 8.595654] systemd[1]: Reached target Basic System.2310bob # [ 8.604614] systemd[1]: Started backdoor.service.2311bob # [ 8.605094] systemd[1]: Starting Import lastlog data into lastlog2 database...2312bob # [ 8.609603] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2313bob # [ 8.614100] systemd[1]: Starting Post-Boot Actions...2314alice # connecting to host...2315bob # [ 8.635732] systemd[1]: Started Reset console on configuration changes.2316alice # [ 8.676879] systemd[1]: Finished Post-Boot Actions.2317clare # [ 8.643764] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32318bob # [ 8.667343] systemd[1]: Starting D-Bus System Message Bus...2319alice # [ 8.708513] systemd[1]: Started Name Service Cache Daemon (nsncd).2320alice # [ 8.709319] nsncd[468]: Sep 27 17:41:46.548 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2321alice # [ 8.710594] systemd[1]: Reached target Host and Network Name Lookups.2322alice # [ 8.711165] systemd[1]: Reached target User and Group Name Lookups.2323alice # [ 8.722370] systemd[1]: Starting User Login Management...2324alice # [ 8.737201] systemd[1]: Finished Import lastlog data into lastlog2 database.2325bob # connecting to host...2326bob # [ 8.742634] systemd[1]: Finished Post-Boot Actions.2327bob # [ 8.768194] systemd[1]: Started Name Service Cache Daemon (nsncd).2328bob # [ 8.768818] systemd[1]: Reached target Host and Network Name Lookups.2329bob # [ 8.769399] systemd[1]: Reached target User and Group Name Lookups.2330alice # [ 8.813789] dbus-broker-launch[473]: Looking up NSS user entry for 'systemd-timesync'...2331bob # [ 8.777937] nsncd[480]: Sep 27 17:41:46.609 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2332bob # [ 8.784793] systemd[1]: Starting User Login Management...2333bob: Guest shell says: b'Spawning backdoor root shell...\n'2334alice # [ 8.822241] dbus-broker-launch[473]: NSS returned no entry for 'systemd-timesync'2335alice # [ 8.822881] dbus-broker-launch[473]: Invalid user-name in /nix/store/di4gbnzycnxil7gz63i2i532jvnffip4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2336alice # [ 8.835492] systemd-logind[499]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2337alice # [ 8.837825] systemd-logind[499]: Watching system buttons on /dev/input/event0 (gpio-keys)2338alice # [ 8.839367] systemd-logind[499]: New seat seat0.2339alice # [ 8.843263] systemd[1]: Started User Login Management.2340alice # [ 8.846894] systemd[1]: Starting linger-users.service...2341bob # [ 8.816174] systemd[1]: Finished Import lastlog data into lastlog2 database.2342alice # [ 8.865584] systemd[1]: Started D-Bus System Message Bus.2343bob # [ 8.837444] dbus-broker-launch[487]: Looking up NSS user entry for 'systemd-timesync'...2344bob # [ 8.853459] dbus-broker-launch[487]: NSS returned no entry for 'systemd-timesync'2345bob # [ 8.854081] dbus-broker-launch[487]: Invalid user-name in /nix/store/rhq6y0h3jpqv8wrzxv2gm05w8rslxbwf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2346alice # [ 8.899602] dbus-broker-launch[473]: Ready2347alice # [ 8.913245] systemd[1]: linger-users.service: Deactivated successfully.2348alice # [ 8.915704] systemd[1]: Finished linger-users.service.2349bob # [ 8.899004] systemd[1]: Started D-Bus System Message Bus.2350bob # [ 8.904219] systemd-logind[513]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2351bob # [ 8.906591] systemd-logind[513]: Watching system buttons on /dev/input/event0 (gpio-keys)2352bob # [ 8.907974] systemd-logind[513]: New seat seat0.2353clare # [ 8.916556] systemd[1]: Starting Virtual Console Setup...2354bob # [ 8.912310] systemd[1]: Started User Login Management.2355bob: connected to guest root shell2356bob # [ 8.916180] systemd[1]: Starting linger-users.service...2357bob: (connecting took 9.19 seconds)2358bob: (finished: waiting for the VM to finish booting, in 9.19 seconds)2359bob # [ 8.951603] dbus-broker-launch[487]: Ready2360clare # [ 8.952189] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2361clare # [ 8.962150] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2362clare # [ 8.965372] systemd[1]: Stopped Virtual Console Setup.2363clare # [ 8.969317] systemd[1]: Starting Virtual Console Setup...2364clare # [ 8.974065] systemd-logind[502]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2365alice # [ 9.016962] systemd[1]: Finished Firewall.2366alice # [ 9.019574] systemd[1]: Reached target Preparation for Network.2367alice # [ 9.021483] systemd[1]: Listening on Network Management Resolve Hook Socket.2368alice # [ 9.024834] systemd[1]: Starting Network Management...2369bob # [ 8.988403] systemd[1]: linger-users.service: Deactivated successfully.2370bob # [ 8.990610] systemd[1]: Finished linger-users.service.2371clare # [ 9.070110] systemd-vconsole-setup[561]: Configuration of first virtual console was skipped, ignoring remaining ones.2372clare # [ 9.073036] systemd[1]: Finished Virtual Console Setup.2373bob # [ 9.096768] systemd[1]: Finished Firewall.2374bob # [ 9.098375] systemd[1]: Reached target Preparation for Network.2375bob # [ 9.100584] systemd[1]: Listening on Network Management Resolve Hook Socket.2376bob # [ 9.105383] systemd[1]: Starting Network Management...2377alice # [ 9.191974] cfg80211: Loading compiled-in X.509 certificates for regulatory database2378alice # [ 9.235683] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2379alice # [ 9.236213] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2380alice # [ 9.239440] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22381alice # [ 9.239809] cfg80211: failed to load regulatory.db2382alice # [ 9.265200] systemd-networkd[536]: lo: Link UP2383alice # [ 9.268096] systemd-networkd[536]: lo: Gained carrier2384alice # [ 9.271542] systemd[1]: Started Network Management.2385alice # [ 9.273896] systemd-networkd[536]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2386alice # [ 9.277216] systemd[1]: Reached target Network.2387alice # [ 9.283131] systemd-networkd[536]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2388alice # [ 9.286778] systemd-networkd[536]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2389alice # [ 9.287513] systemd-networkd[536]: eth0: Link UP2390alice # [ 9.287909] systemd-networkd[536]: eth0: Gained carrier2391alice # [ 9.296426] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2392alice # [ 9.297074] systemd-networkd[536]: eth1: Link UP2393alice # [ 9.297476] systemd-networkd[536]: eth1: Gained carrier2394alice # [ 9.297935] systemd-networkd[536]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2395alice # [ 9.299233] systemd[1]: Starting Permit User Sessions...2396bob # [ 9.273940] cfg80211: Loading compiled-in X.509 certificates for regulatory database2397alice # [ 9.306590] systemd-networkd[536]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22398bob # [ 9.320596] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2399bob # [ 9.321124] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2400alice # [ 9.357169] systemd[1]: Finished Permit User Sessions.2401bob # [ 9.323856] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22402bob # [ 9.324229] cfg80211: failed to load regulatory.db2403alice # [ 9.359293] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2404alice # [ 9.364966] systemd[1]: Started Getty on tty1.2405alice # [ 9.366721] systemd[1]: Reached target Login Prompts.2406alice # [ 9.368384] systemd[1]: Reached target Multi-User System.2407alice # [ 9.376382] systemd[1]: Startup finished in 734ms (kernel) + 4.651s (initrd) + 3.989s (userspace) = 9.376s.2408bob # [ 9.346998] systemd-networkd[558]: lo: Link UP2409bob # [ 9.350607] systemd-networkd[558]: lo: Gained carrier2410bob # [ 9.355115] systemd[1]: Started Network Management.2411bob # [ 9.359255] systemd[1]: Reached target Network.2412bob # [ 9.359724] systemd[1]: Reached target Network is Online.2413bob # [ 9.366104] systemd-networkd[558]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2414bob # [ 9.367448] systemd-networkd[558]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2415bob # [ 9.374017] systemd-networkd[558]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2416bob # [ 9.374899] systemd-networkd[558]: eth1: Link UP2417bob # [ 9.375329] systemd-networkd[558]: eth1: Gained carrier2418bob # [ 9.375777] systemd-networkd[558]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2419bob # [ 9.389148] systemd[1]: Starting ncps binary cache proxy service...2420bob # [ 9.389736] systemd-networkd[558]: eth0: Link UP2421bob # [ 9.390143] systemd-networkd[558]: eth0: Gained carrier2422bob # [ 9.390605] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2423bob # [ 9.393969] systemd-networkd[558]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22424bob # [ 9.394857] systemd[1]: Starting Permit User Sessions...2425bob # [ 9.478094] systemd[1]: Finished Permit User Sessions.2426alice # [ 9.523380] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32427bob # [ 9.486023] systemd[1]: Started Getty on tty1.2428bob # [ 9.489314] systemd[1]: Reached target Login Prompts.2429bob # [ 9.492856] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2430bob # [ 9.516740] ncps-pre-start[565]: /nix/store/0m8la0b5a7q97yz1mc9c2x9xb5mc67vz-ncps-0.9.4/bin/dbmate-ncps up2431clare # [ 9.569657] systemd-networkd[541]: eth0: Gained IPv6LL2432bob # [ 9.704733] ncps-pre-start[580]: Creating: /var/lib/ncps/db/db.sqlite2433bob # [ 9.722409] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32434bob # [ 9.727783] ncps-pre-start[580]: Applying: 20241210054814_create-narinfos-table.sql2435bob # [ 9.735293] ncps-pre-start[580]: Applied: 20241210054814_create-narinfos-table.sql in 7.48148ms2436bob # [ 9.736286] ncps-pre-start[580]: Applying: 20241210054829_create-nars-table.sql2437bob # [ 9.744314] ncps-pre-start[580]: Applied: 20241210054829_create-nars-table.sql in 8.90976ms2438bob # [ 9.745036] ncps-pre-start[580]: Applying: 20241213014846_add-query-to-nars-table.sql2439bob # [ 9.751808] ncps-pre-start[580]: Applied: 20241213014846_add-query-to-nars-table.sql in 7.57024ms2440bob # [ 9.752941] ncps-pre-start[580]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2441bob # [ 9.765488] ncps-pre-start[580]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 13.6636ms2442alice # [ 9.803590] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2443bob # [ 9.767231] ncps-pre-start[580]: Applying: 20260101000000_add-config-table.sql2444alice # [ 9.805691] systemd[1]: Starting Virtual Console Setup...2445bob # [ 9.776203] ncps-pre-start[580]: Applied: 20260101000000_add-config-table.sql in 10.6994ms2446bob # [ 9.777119] ncps-pre-start[580]: Applying: 20260105025735_remove-redundant-indexes.sql2447bob # [ 9.782286] ncps-pre-start[580]: Applied: 20260105025735_remove-redundant-indexes.sql in 6.07504ms2448bob # [ 9.784374] ncps-pre-start[580]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2449alice # [ 9.827413] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2450alice # [ 9.830504] systemd[1]: Stopped Virtual Console Setup.2451bob # [ 9.795926] ncps-pre-start[580]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 13.62516ms2452bob # [ 9.797042] ncps-pre-start[580]: Applying: 20260117195000_add_narinfo_de_normalized.sql2453alice # [ 9.834413] systemd[1]: Starting Virtual Console Setup...2454alice # [ 9.841317] systemd-logind[499]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2455bob # [ 9.806432] ncps-pre-start[580]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 10.45412ms2456bob # [ 9.807433] ncps-pre-start[580]: Applying: 20260127223000_allow_multiple_nar_representations.sql2457bob # [ 9.816216] ncps-pre-start[580]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 9.81264ms2458bob # [ 9.817256] ncps-pre-start[580]: Applying: 20260131021850_add_chunks.sql2459bob # [ 9.828196] ncps-pre-start[580]: Applied: 20260131021850_add_chunks.sql in 11.96104ms2460bob # [ 9.830724] ncps-pre-start[580]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2461bob # [ 9.840202] ncps-pre-start[580]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 11.99112ms2462bob # [ 9.844072] ncps-pre-start[580]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2463bob # [ 9.852196] ncps-pre-start[580]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 11.98144ms2464bob # [ 9.854063] ncps-pre-start[580]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2465bob # [ 9.864516] ncps-pre-start[580]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 11.97956ms2466alice # [ 9.929974] systemd-vconsole-setup[555]: Configuration of first virtual console was skipped, ignoring remaining ones.2467alice # [ 9.933025] systemd[1]: Finished Virtual Console Setup.2468bob # [ 10.009852] systemd[1]: Started ncps binary cache proxy service.2469bob # [ 10.010463] systemd[1]: Reached target Multi-User System.2470bob # [ 10.014147] systemd[1]: Startup finished in 709ms (kernel) + 4.682s (initrd) + 4.618s (userspace) = 10.011s.2471bob: (finished: waiting for unit ncps, in 10.44 seconds)2472bob: must succeed: systemctl status ncps2473bob # [ 10.172171] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2474bob # [ 10.185515] systemd[1]: Starting Virtual Console Setup...2475clare # [ 10.210597] systemd-networkd[541]: eth1: Gained IPv6LL2476bob # [ 10.214258] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2477bob # [ 10.218051] systemd[1]: Stopped Virtual Console Setup.2478bob # [ 10.225282] systemd[1]: Starting Virtual Console Setup...2479bob # [ 10.233651] systemd-logind[513]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2480bob: (finished: must succeed: systemctl status ncps, in 0.08 seconds)2481clare: waiting for unit harmonia.socket2482clare: waiting for the VM to finish booting2483clare: Guest shell says: b'Spawning backdoor root shell...\n'2484clare: connected to guest root shell2485clare: (connecting took 0.00 seconds)2486clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2487clare: (finished: waiting for unit harmonia.socket, in 0.05 seconds)2488alice: waiting for success: curl bob:8502/nix-cache-info2489alice: waiting for the VM to finish booting2490alice: Guest shell says: b'Spawning backdoor root shell...\n'2491alice: connected to guest root shell2492alice: (connecting took 0.00 seconds)2493alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2494bob # [ 10.361087] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","log_level":"info","time":"2026-09-27T17:41:48Z","message":"logger created"}2495bob # [ 10.362757] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","xz-binary-path":"/nix/store/hrvsv5knsgy3kjqykgh75d0yfxm92j8g-xz-5.8.3-bin/bin/xz","time":"2026-09-27T17:41:48Z","message":"Using xz binary for xz decompression"}2496bob # [ 10.380908] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-09-27T17:41:48Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2497bob # [ 10.383309] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","time":"2026-09-27T17:41:48Z","message":"using local locks (single-instance mode)"}2498bob # [ 10.389716] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-27T17:41:48Z","message":"setting up tracer provider to discard traces"}2499bob # [ 10.393114] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-27T17:41:48Z","message":"setting up meter provider to discard metrics"}2500bob # [ 10.396073] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-27T17:41:48Z","message":"setting up logger provider to discard logs"}2501bob # [ 10.404034] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-09-27T17:41:48Z","message":"Reporting anonymous metrics to the project maintainers"}2502bob # [ 10.405579] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-09-27T17:41:48Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2503bob # [ 10.407339] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-09-27T17:41:48Z","message":"using local storage"}2504clare # [ 10.433203] systemd[1]: Starting harmonia binary cache service...2505bob # [ 10.456226] systemd-vconsole-setup[605]: Configuration of first virtual console was skipped, ignoring remaining ones.2506bob # [ 10.458770] systemd[1]: Finished Virtual Console Setup.2507alice # [ 10.594793] systemd-networkd[536]: eth1: Gained IPv6LL2508clare # [ 10.573261] harmonia-cache[568]: 2026-09-27T17:41:48.410842Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2509clare # [ 10.578060] harmonia-cache[568]: 2026-09-27T17:41:48.415082Z INFO actix_server::builder: starting 4 workers2510clare # [ 10.584450] harmonia-cache[568]: 2026-09-27T17:41:48.415891Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2511clare # [ 10.588434] harmonia-cache[568]: 2026-09-27T17:41:48.415962Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2512clare # [ 10.592674] harmonia-cache[568]: 2026-09-27T17:41:48.416000Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002513clare # [ 10.598586] systemd[1]: Started harmonia binary cache service.2514bob # [ 10.611876] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-09-27T17:41:48Z","message":"upstream became healthy and is now available for requests"}2515bob # [ 10.616441] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-09-27T17:41:48Z","message":"Server started"}2516bob # [ 10.945731] systemd-networkd[558]: eth1: Gained IPv6LL2517alice # [ 11.233390] systemd-networkd[536]: eth0: Gained IPv6LL2518bob # [ 11.298024] systemd-networkd[558]: eth0: Gained IPv6LL2519bob # [ 11.417265] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: 2026/09/27 17:41:49 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2520alice # curl: (28) Failed to connect to bob:8502 after 133953 ms: Could not connect to server2521alice # % Total % Received % Xferd Average Speed Time Time Time Current2522alice # Dload Upload Total Spent Left Speed2523bob # [ 145.400377] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:33814","trace_id":"6e6308e146fcd6a1055183ce4b431f5f","span_id":"3ab1cf42a7a48f57","status":200,"elapsed":0.088,"bytes":50,"time":"2026-09-27T17:44:03Z","message":"handled request"}2524alice # 0 0 0 0 0 0 0 0 0100 50 100 50 0 0 2141 0 0100 50 100 50 0 0 1816 0 0100 50 100 50 0 0 1580 0 02525alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 135.12 seconds)2526bob: waiting for success: curl clare:5000/nix-cache-info2527bob # % Total % Received % Xferd Average Speed Time Time Time Current2528bob # Dload Upload Total Spent Left Speed2529bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 4587 0 0100 51 100 51 0 0 3762 0 0100 51 100 51 0 0 3236 0 02530bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.06 seconds)2531clare: waiting for unit harmonia2532clare: (finished: waiting for unit harmonia, in 0.05 seconds)2533clare: must succeed: systemctl status harmonia2534clare: (finished: must succeed: systemctl status harmonia, in 0.02 seconds)2535clare: must succeed: nix-build --expr '2536 builtins.derivation {2537 name = "hi";2538 builder = "/bin/sh";2539 args = [ "-c" "echo hi > $out" ];2540 system = "aarch64-linux";2541 }2542' 2>&125432544clare # [ 145.622592] systemd-resolved[308]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2545clare # [ 145.625444] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2546clare # [ 145.627232] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2547clare # [ 145.900409] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2548clare # [ 145.904115] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2549clare # [ 145.908284] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2550clare # [ 145.912142] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2551clare # [ 146.553150] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2552clare # [ 146.556927] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2553clare # [ 146.561384] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2554clare # [ 146.565310] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2555clare # [ 147.586743] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2556clare # [ 147.591122] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2557clare # [ 147.596274] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2558clare # [ 147.600146] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2559clare # [ 150.012132] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2560clare # [ 150.015983] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2561clare # [ 150.020415] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2562clare # [ 150.024865] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2563clare: (finished: must succeed: nix-build --expr '2564 builtins.derivation {2565 name = "hi";2566 builder = "/bin/sh";2567 args = [ "-c" "echo hi > $out" ];2568 system = "aarch64-linux";2569 }2570' 2>&12571, in 4.61 seconds)2572alice: must succeed: nix-build --expr '2573 builtins.derivation {2574 name = "hi";2575 builder = "/bin/sh";2576 args = [ "-c" "echo hi > $out" ];2577 system = "aarch64-linux";2578 }2579' 2>&125802581bob # [ 150.283493] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:33828","trace_id":"aaee1509da7de6dda05ac85c09957c9a","span_id":"5d44fe0fb51daf27","status":200,"elapsed":0.02984,"bytes":50,"time":"2026-09-27T17:44:08Z","message":"handled request"}2582alice # [ 150.326348] systemd-resolved[309]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2583alice # [ 150.331379] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2584alice # [ 150.335063] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2585alice # [ 150.694038] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2586alice # [ 150.698849] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2587alice # [ 150.702851] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2588alice # [ 150.706598] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2589alice # [ 151.392560] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2590alice # [ 151.396511] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2591alice # [ 151.401424] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2592alice # [ 151.405083] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2593alice # [ 152.495277] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2594alice # [ 152.498995] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2595alice # [ 152.503791] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2596alice # [ 152.507347] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2597alice # [ 154.873791] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2598alice # [ 154.877320] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2599alice # [ 154.882304] systemd-resolved[309]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2600alice # [ 154.886065] systemd-resolved[309]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2601bob # [ 154.855953] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_url":"http://clare.clan:5000/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","upstream_url":"http://clare.clan:5000","time":"2026-09-27T17:44:12Z","message":"download the narinfo from upstream"}2602bob # [ 154.886322] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-27T17:44:12Z","message":"downloading the nar from upstream"}2603bob # [ 154.898212] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"http://clare.clan:5000/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","upstream_url":"http://clare.clan:5000","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-27T17:44:12Z","message":"download the nar from upstream"}2604bob # [ 154.936340] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-27T17:44:12Z","message":"storing narinfo and nar_file record in the database"}2605bob # [ 154.954654] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":63.71852,"time":"2026-09-27T17:44:12Z","message":"download of nar complete"}2606bob # [ 154.965984] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":97.37984,"time":"2026-09-27T17:44:12Z","message":"download of narinfo complete"}2607bob # [ 154.973789] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:33828","trace_id":"8bd0b16026d0a936be0e0e92aece0851","span_id":"0929a2ce524bc202","status":200,"elapsed":100.16236,"bytes":532,"time":"2026-09-27T17:44:12Z","message":"handled request"}2608bob # [ 154.978226] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:33828","trace_id":"73730adcbf99f7b174e20f004643376b","span_id":"aa3bc0b8bbc639dd","status":200,"elapsed":0.93312,"bytes":95,"time":"2026-09-27T17:44:12Z","message":"handled request"}2609alice: (finished: must succeed: nix-build --expr '2610 builtins.derivation {2611 name = "hi";2612 builder = "/bin/sh";2613 args = [ "-c" "echo hi > $out" ];2614 system = "aarch64-linux";2615 }2616' 2>&12617, in 4.88 seconds)2618(finished: run the VM test script, in 155.88 seconds)2619test script finished in 156.03s2620cleanup2621kill QemuMachine (pid 48)2622alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2623alice # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2624alice # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2625alice # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2626kill QemuMachine (pid 49)2627bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2628bob # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2629bob # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2630bob # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2631kill QemuMachine (pid 50)2632clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2633clare # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2634clare # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2635clare # [2026-09-27T17:44:13Z INFO virtiofsd] Client disconnected, shutting down2636(finished: cleanup, in 0.35 seconds)