vm-test-run-ncps
checks.aarch64-linux.ncps
· build #992
· raw
1build01: building z2814cnifzzc0ccvfx7kmj5mhgws2p67-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 vm15clare # Disk image does not exist, creating the virtualisation disk image...16clare: QEMU running (pid 50)17clare # Formatting '/build/vm-state-clare/tmp.IoGwmw3ha1', fmt=raw size=107374182418bob: QEMU running (pid 49)19bob # Disk image does not exist, creating the virtualisation disk image...20clare # mke2fs 1.47.4 (6-Mar-2025)21alice # Disk image does not exist, creating the virtualisation disk image...22alice: QEMU running (pid 47)23clare # Discarding device blocks: 0/262144 done24bob # Formatting '/build/vm-state-bob/tmp.aFW2GT2i10', fmt=raw size=107374182425clare # Creating filesystem with 262144 4k blocks and 65536 inodes26bob # mke2fs 1.47.4 (6-Mar-2025)27(finished: start all VMs, in 0.49 seconds)28alice # Formatting '/build/vm-state-alice/tmp.NMHFb5uKoE', fmt=raw size=107374182429clare # Filesystem UUID: 4d5b4875-2f59-41b0-b3d1-06233bd2744a30bob: waiting for unit ncps31alice # mke2fs 1.47.4 (6-Mar-2025)32bob # Discarding device blocks: 0/262144 done33clare # Superblock backups stored on blocks:34bob: waiting for the VM to finish booting35alice # Discarding device blocks: 0/262144 done36bob # Creating filesystem with 262144 4k blocks and 65536 inodes37alice # Creating filesystem with 262144 4k blocks and 65536 inodes38bob # Filesystem UUID: 41bf9fc3-1adf-4113-a234-8b17649c2d9739alice # Filesystem UUID: 2cc06c57-337d-4d8c-a551-a83915c7cb7b40bob # Superblock backups stored on blocks:41alice # Superblock backups stored on blocks:42bob # 32768, 98304, 163840, 22937643clare # 32768, 98304, 163840, 22937644bob # 45clare # 46bob # Allocating group tables: 0/8 done47clare # Allocating group tables: 0/8 done48bob # Writing inode tables: 0/8 done49clare # Writing inode tables: 0/8 done50bob # Creating journal (8192 blocks): done51clare # Creating journal (8192 blocks): done52bob # Writing superblocks and filesystem accounting information: 0/8 done53clare # Writing superblocks and filesystem accounting information: 0/8 done54bob # 55clare # 56bob # Virtualisation disk image created.57alice # 32768, 98304, 163840, 22937658bob # Starting virtiofs daemons...59alice # 60bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)61alice # Allocating group tables: 0/8 done62bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether63alice # Writing inode tables: 0/8 done64bob # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...65alice # Creating journal (8192 blocks): done66bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)67alice # Writing superblocks and filesystem accounting information: 0/8 done68bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether69alice # 70bob # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...71alice # Virtualisation disk image created.72bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)73alice # Starting virtiofs daemons...74bob # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether75alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)76bob # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...77alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether78bob # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests79clare # Virtualisation disk image created.80bob # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests81alice # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...82bob # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests83clare # Starting virtiofs daemons...84alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)85clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)86alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether87clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether88alice # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...89clare # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...90alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)91clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)92alice # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether93clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether94alice # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...95clare # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...96alice # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests97clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)98alice # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests99clare # [2026-10-14T20:03:37Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether100alice # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests101clare # [2026-10-14T20:03:37Z INFO virtiofsd] Waiting for vhost-user socket connection...102clare # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests103clare # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests104clare # [2026-10-14T20:03:37Z INFO virtiofsd] Client connected, servicing requests105clare # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]106clare # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 2026107clare # [ 0.000000] KASLR enabled108clare # [ 0.000000] random: crng init done109clare # [ 0.000000] Machine model: linux,dummy-virt110clare # [ 0.000000] efi: UEFI not found.111clare # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT112clare # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]113clare # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]114clare # [ 0.000000] Zone ranges:115clare # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]116clare # [ 0.000000] DMA32 empty117clare # [ 0.000000] Normal empty118clare # [ 0.000000] Device empty119clare # [ 0.000000] Movable zone start for each node120clare # [ 0.000000] Early memory node ranges121clare # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]122clare # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]123clare # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000124clare # [ 0.000000] psci: probing for conduit method from DT.125clare # [ 0.000000] psci: PSCIv1.3 detected in firmware.126clare # [ 0.000000] psci: Using standard PSCI v0.2 function IDs127clare # [ 0.000000] psci: Trusted OS migration not required128clare # [ 0.000000] psci: SMC Calling Convention v1.1129clare # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)130clare # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296131clare # [ 0.000000] Detected PIPT I-cache on CPU0132clare # [ 0.000000] CPU features: detected: GICv3 CPU interface133clare # [ 0.000000] CPU features: detected: Spectre-v4134clare # [ 0.000000] CPU features: detected: Spectre-BHB135clare # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR136clare # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)137clare # [ 0.000000] CPU features: detected: ARM erratum 1418040138clare # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion139clare # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing140clare # [ 0.000000] alternatives: applying boot alternatives141clare # [ 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/wv719ask1gnl2x4bid3r2qbvmadrzhvn-nixos-system-clare-test/init regInfo=/nix/.ro-store/1qz7kfznidcj4hv5vgvv29pzfi887awx-closure-info/registration console=ttyAMA0,115200n8 console=tty0142clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/1qz7kfznidcj4hv5vgvv29pzfi887awx-closure-info/registration", will be passed to user space.143clare # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes144clare # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)145clare # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)146clare # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB147clare # [ 0.000000] software IO TLB: area num 1.148clare # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)149clare # [ 0.000000] Fallback order for Node 0: 0150clare # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144151clare # [ 0.000000] Policy zone: DMA152clare # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off153clare # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1154clare # [ 0.000000] allocated 2097152 bytes of page_ext155clare # [ 0.000000] ftrace: allocating 75039 entries in 294 pages156clare # [ 0.000000] ftrace: allocated 294 pages with 4 groups157clare # [ 0.000000] rcu: Hierarchical RCU implementation.158clare # [ 0.000000] rcu: RCU event tracing is enabled.159clare # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.160clare # [ 0.000000] Trampoline variant of Tasks RCU enabled.161clare # [ 0.000000] Rude variant of Tasks RCU enabled.162clare # [ 0.000000] Tracing variant of Tasks RCU enabled.163clare # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.164clare # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1165clare # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.166clare # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167clare # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168clare # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0169clare # [ 0.000000] GICv3: 256 SPIs implemented170clare # [ 0.000000] GICv3: 0 Extended SPIs implemented171clare # [ 0.000000] Root IRQ handler: gic_handle_irq172clare # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI173clare # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0174clare # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000175clare # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]176clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)177clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)178clare # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000179clare # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000180clare # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.181clare # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns182clare # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040183clare # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).184clare # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns185clare # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns186clare # [ 0.000056] arm-pv: using stolen time PV187clare # [ 0.000383] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)188clare # [ 0.000701] Console: colour dummy device 80x25189alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]190clare # [ 0.000713] printk: legacy console [tty0] enabled191clare # [ 0.000955] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)192alice # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 2026193clare # [ 0.000961] pid_max: default: 32768 minimum: 301194alice # [ 0.000000] KASLR enabled195alice # [ 0.000000] random: crng init done196clare # [ 0.001049] LSM: initializing lsm=capability,landlock,yama,bpf,ima197alice # [ 0.000000] Machine model: linux,dummy-virt198clare # [ 0.001190] landlock: Up and running.199alice # [ 0.000000] efi: UEFI not found.200clare # [ 0.001193] Yama: becoming mindful.201clare # [ 0.001580] LSM support for eBPF active202alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT203clare # [ 0.001761] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)204alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]205clare # [ 0.001782] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)206alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]207alice # [ 0.000000] Zone ranges:208clare # [ 0.004684] rcu: Hierarchical SRCU implementation.209alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]210clare # [ 0.004689] rcu: Max phase no-delay instances is 1000.211bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]212alice # [ 0.000000] DMA32 empty213clare # [ 0.005672] fsl-mc MSI: its@8080000 domain created214alice # [ 0.000000] Normal empty215alice # [ 0.000000] Device empty216clare # [ 0.005876] EFI services will not be available.217clare # [ 0.005973] smp: Bringing up secondary CPUs ...218alice # [ 0.000000] Movable zone start for each node219bob # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 2026220clare # [ 0.006008] smp: Brought up 1 node, 1 CPU221bob # [ 0.000000] KASLR enabled222alice # [ 0.000000] Early memory node ranges223bob # [ 0.000000] random: crng init done224clare # [ 0.006012] SMP: Total of 1 processors activated.225bob # [ 0.000000] Machine model: linux,dummy-virt226clare # [ 0.006014] CPU: All CPU(s) started at EL1227alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]228bob # [ 0.000000] efi: UEFI not found.229clare # [ 0.006026] CPU features: detected: 32-bit EL0 Support230alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]231bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT232alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000233clare # [ 0.006029] CPU features: detected: Data cache clean to the PoU not required for I/D coherence234bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]235alice # [ 0.000000] psci: probing for conduit method from DT.236clare # [ 0.006033] CPU features: detected: Common not Private translations237alice # [ 0.000000] psci: PSCIv1.3 detected in firmware.238bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]239bob # [ 0.000000] Zone ranges:240clare # [ 0.006035] CPU features: detected: CRC32 instructions241alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs242clare # [ 0.006036] CPU features: detected: Data cache clean to Point of Persistence243bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]244alice # [ 0.000000] psci: Trusted OS migration not required245bob # [ 0.000000] DMA32 empty246alice # [ 0.000000] psci: SMC Calling Convention v1.1247clare # [ 0.006039] CPU features: detected: Enhanced Virtualization Traps248bob # [ 0.000000] Normal empty249bob # [ 0.000000] Device empty250clare # [ 0.006050] CPU features: detected: RCpc load-acquire (LDAPR)251bob # [ 0.000000] Movable zone start for each node252alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)253clare # [ 0.006052] CPU features: detected: LSE atomic instructions254bob # [ 0.000000] Early memory node ranges255clare # [ 0.006054] CPU features: detected: Privileged Access Never256alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296257clare # [ 0.006056] CPU features: detected: PMUv3258bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]259alice # [ 0.000000] Detected PIPT I-cache on CPU0260clare # [ 0.006057] CPU features: detected: RAS Extension Support261alice # [ 0.000000] CPU features: detected: GICv3 CPU interface262bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]263alice # [ 0.000000] CPU features: detected: Spectre-v4264clare # [ 0.006061] CPU features: detected: Speculative Store Bypassing Safe (SSBS)265bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000266alice # [ 0.000000] CPU features: detected: Spectre-BHB267clare # [ 0.006084] alternatives: applying system-wide alternatives268bob # [ 0.000000] psci: probing for conduit method from DT.269alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR270bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.271clare # [ 0.007493] CPU features: detected: Hardware dirty bit management on CPU0272bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs273alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)274alice # [ 0.000000] CPU features: detected: ARM erratum 1418040275bob # [ 0.000000] psci: Trusted OS migration not required276clare # [ 0.007712] Memory: 891140K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116132K reserved, 32768K cma-reserved)277bob # [ 0.000000] psci: SMC Calling Convention v1.1278clare # [ 0.008234] devtmpfs: initialized279alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion280clare # [ 0.009755] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)281alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing282bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)283alice # [ 0.000000] alternatives: applying boot alternatives284clare # [ 0.009779] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).285bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296286bob # [ 0.000000] Detected PIPT I-cache on CPU0287clare # [ 0.009908] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL288clare # [ 0.009913] 0 pages in range for non-PLT usage289bob # [ 0.000000] CPU features: detected: GICv3 CPU interface290clare # [ 0.009915] 508192 pages in range for PLT usage291bob # [ 0.000000] CPU features: detected: Spectre-v4292clare # [ 0.010022] pinctrl core: initialized pinctrl subsystem293bob # [ 0.000000] CPU features: detected: Spectre-BHB294clare # [ 0.010833] DMI not present or invalid.295bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR296alice # [ 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/4j3663pi8glzya4gqg9yiznbj392dxjl-nixos-system-alice-test/init regInfo=/nix/.ro-store/mwq85s3vd6i52i7x6mm6cn2c8m8psxhp-closure-info/registration console=ttyAMA0,115200n8 console=tty0297clare # [ 0.014348] NET: Registered PF_NETLINK/PF_ROUTE protocol family298bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)299clare # [ 0.016919] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations300bob # [ 0.000000] CPU features: detected: ARM erratum 1418040301alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/mwq85s3vd6i52i7x6mm6cn2c8m8psxhp-closure-info/registration", will be passed to user space.302clare # [ 0.017052] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations303bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion304clare # [ 0.017199] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations305alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes306bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing307clare # [ 0.017217] audit: initializing netlink subsys (disabled)308alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)309bob # [ 0.000000] alternatives: applying boot alternatives310clare # [ 0.018071] thermal_sys: Registered thermal governor 'fair_share'311alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)312clare # [ 0.018074] thermal_sys: Registered thermal governor 'bang_bang'313clare # [ 0.018077] thermal_sys: Registered thermal governor 'step_wise'314alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB315alice # [ 0.000000] software IO TLB: area num 1.316clare # [ 0.018079] thermal_sys: Registered thermal governor 'user_space'317clare # [ 0.018081] thermal_sys: Registered thermal governor 'power_allocator'318alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)319alice # [ 0.000000] Fallback order for Node 0: 0320clare # [ 0.018131] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1321bob # [ 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/ahyrv4679vvm0q5sipcp0pp1mdkg2s9n-nixos-system-bob-test/init regInfo=/nix/.ro-store/rhm3fimvdamckjbwz60c7r7dliid5ky6-closure-info/registration console=ttyAMA0,115200n8 console=tty0322alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144323clare # [ 0.018140] cpuidle: using governor ladder324alice # [ 0.000000] Policy zone: DMA325clare # [ 0.018145] cpuidle: using governor menu326alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off327clare # [ 0.018262] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.328bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/rhm3fimvdamckjbwz60c7r7dliid5ky6-closure-info/registration", will be passed to user space.329clare # [ 0.018284] ASID allocator initialised with 32768 entries330alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1331clare # [ 0.018931] Serial: AMBA PL011 UART driver332alice # [ 0.000000] allocated 2097152 bytes of page_ext333bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes334alice # [ 0.000000] ftrace: allocating 75039 entries in 294 pages335clare # [ 0.022481] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1336bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)337alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups338clare # [ 0.022629] printk: console [ttyAMA0] enabled339alice # [ 0.000000] rcu: Hierarchical RCU implementation.340bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)341alice # [ 0.000000] rcu: RCU event tracing is enabled.342bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB343alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.344bob # [ 0.000000] software IO TLB: area num 1.345alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.346alice # [ 0.000000] Rude variant of Tasks RCU enabled.347bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)348alice # [ 0.000000] Tracing variant of Tasks RCU enabled.349bob # [ 0.000000] Fallback order for Node 0: 0350bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144351alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.352bob # [ 0.000000] Policy zone: DMA353alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1354bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off355alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.356bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1357bob # [ 0.000000] allocated 2097152 bytes of page_ext358alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.359bob # [ 0.000000] ftrace: allocating 75039 entries in 294 pages360alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.361bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups362alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0363bob # [ 0.000000] rcu: Hierarchical RCU implementation.364alice # [ 0.000000] GICv3: 256 SPIs implemented365bob # [ 0.000000] rcu: RCU event tracing is enabled.366alice # [ 0.000000] GICv3: 0 Extended SPIs implemented367bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.368alice # [ 0.000000] Root IRQ handler: gic_handle_irq369bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.370alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI371bob # [ 0.000000] Rude variant of Tasks RCU enabled.372alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0373bob # [ 0.000000] Tracing variant of Tasks RCU enabled.374alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000375alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]376bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.377alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)378bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1379alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)380bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.381alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000382bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.383alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000384alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.385bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.386bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0387alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns388bob # [ 0.000000] GICv3: 256 SPIs implemented389clare # [ 0.096719] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages390bob # [ 0.000000] GICv3: 0 Extended SPIs implemented391alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040392clare # [ 0.096733] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page393bob # [ 0.000000] Root IRQ handler: gic_handle_irq394alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).395clare # [ 0.096736] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages396bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI397clare # [ 0.096741] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page398bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0399alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns400clare # [ 0.096743] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages401bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000402alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns403bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]404clare # [ 0.096744] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page405alice # [ 0.000053] arm-pv: using stolen time PV406clare # [ 0.096747] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages407bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)408clare # [ 0.096748] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page409alice # [ 0.000344] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)410clare # [ 0.097771] fbcon: Taking over console411alice # [ 0.000591] Console: colour dummy device 80x25412clare # [ 0.097782] ACPI: Interpreter disabled.413bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)414alice # [ 0.000602] printk: legacy console [tty0] enabled415clare # [ 0.098459] iommu: Default domain type: Translated416bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000417clare # [ 0.098463] iommu: DMA domain TLB invalidation policy: strict mode418alice # [ 0.000816] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)419clare # [ 0.098757] SCSI subsystem initialized420bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000421alice # [ 0.000821] pid_max: default: 32768 minimum: 301422clare # [ 0.098979] usbcore: registered new interface driver usbfs423bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.424alice # [ 0.000895] LSM: initializing lsm=capability,landlock,yama,bpf,ima425clare # [ 0.099019] usbcore: registered new interface driver hub426alice # [ 0.001020] landlock: Up and running.427clare # [ 0.099029] usbcore: registered new device driver usb428alice # [ 0.001022] Yama: becoming mindful.429bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns430alice # [ 0.001368] LSM support for eBPF active431clare # [ 0.099238] pps_core: LinuxPPS API ver. 1 registered432bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040433alice # [ 0.001541] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)434clare # [ 0.099241] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>435bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).436clare # [ 0.099246] PTP clock support registered437clare # [ 0.099280] EDAC MC: Ver: 3.0.0438alice # [ 0.001562] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)439alice # [ 0.004322] rcu: Hierarchical SRCU implementation.440bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns441clare # [ 0.108545] scmi_core: SCMI protocol bus registered442alice # [ 0.004329] rcu: Max phase no-delay instances is 1000.443alice # [ 0.005331] fsl-mc MSI: its@8080000 domain created444bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns445alice # [ 0.005551] EFI services will not be available.446bob # [ 0.000055] arm-pv: using stolen time PV447alice # [ 0.005644] smp: Bringing up secondary CPUs ...448alice # [ 0.005674] smp: Brought up 1 node, 1 CPU449bob # [ 0.000384] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)450alice # [ 0.005678] SMP: Total of 1 processors activated.451bob # [ 0.000688] Console: colour dummy device 80x25452alice # [ 0.005680] CPU: All CPU(s) started at EL1453bob # [ 0.000703] printk: legacy console [tty0] enabled454alice # [ 0.005691] CPU features: detected: 32-bit EL0 Support455alice # [ 0.005694] CPU features: detected: Data cache clean to the PoU not required for I/D coherence456bob # [ 0.000914] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)457clare # [ 0.109271] FPGA manager framework458alice # [ 0.005697] CPU features: detected: Common not Private translations459bob # [ 0.000920] pid_max: default: 32768 minimum: 301460clare # [ 0.112466] vgaarb: loaded461alice # [ 0.005699] CPU features: detected: CRC32 instructions462bob # [ 0.000994] LSM: initializing lsm=capability,landlock,yama,bpf,ima463bob # [ 0.001135] landlock: Up and running.464alice # [ 0.005701] CPU features: detected: Data cache clean to Point of Persistence465bob # [ 0.001137] Yama: becoming mindful.466bob # [ 0.001579] LSM support for eBPF active467alice # [ 0.005704] CPU features: detected: Enhanced Virtualization Traps468alice # [ 0.005716] CPU features: detected: RCpc load-acquire (LDAPR)469bob # [ 0.001759] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)470alice # [ 0.005719] CPU features: detected: LSE atomic instructions471bob # [ 0.001782] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)472alice # [ 0.005720] CPU features: detected: Privileged Access Never473alice # [ 0.005722] CPU features: detected: PMUv3474bob # [ 0.004512] rcu: Hierarchical SRCU implementation.475alice # [ 0.005724] CPU features: detected: RAS Extension Support476bob # [ 0.004519] rcu: Max phase no-delay instances is 1000.477clare # [ 0.113159] clocksource: Switched to clocksource arch_sys_counter478alice # [ 0.005728] CPU features: detected: Speculative Store Bypassing Safe (SSBS)479bob # [ 0.005484] fsl-mc MSI: its@8080000 domain created480bob # [ 0.005676] EFI services will not be available.481alice # [ 0.005748] alternatives: applying system-wide alternatives482bob # [ 0.005769] smp: Bringing up secondary CPUs ...483alice # [ 0.007158] CPU features: detected: Hardware dirty bit management on CPU0484bob # [ 0.005802] smp: Brought up 1 node, 1 CPU485bob # [ 0.005806] SMP: Total of 1 processors activated.486bob # [ 0.005808] CPU: All CPU(s) started at EL1487alice # [ 0.007408] Memory: 891136K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116128K reserved, 32768K cma-reserved)488alice # [ 0.007911] devtmpfs: initialized489bob # [ 0.005819] CPU features: detected: 32-bit EL0 Support490alice # [ 0.009496] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)491bob # [ 0.005822] CPU features: detected: Data cache clean to the PoU not required for I/D coherence492alice # [ 0.009519] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).493bob # [ 0.005825] CPU features: detected: Common not Private translations494alice # [ 0.009640] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL495bob # [ 0.005827] CPU features: detected: CRC32 instructions496alice # [ 0.009645] 0 pages in range for non-PLT usage497alice # [ 0.009646] 508192 pages in range for PLT usage498bob # [ 0.005829] CPU features: detected: Data cache clean to Point of Persistence499alice # [ 0.009742] pinctrl core: initialized pinctrl subsystem500bob # [ 0.005831] CPU features: detected: Enhanced Virtualization Traps501alice # [ 0.010534] DMI not present or invalid.502bob # [ 0.005841] CPU features: detected: RCpc load-acquire (LDAPR)503alice # [ 0.013918] NET: Registered PF_NETLINK/PF_ROUTE protocol family504bob # [ 0.005843] CPU features: detected: LSE atomic instructions505alice # [ 0.016655] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations506bob # [ 0.005845] CPU features: detected: Privileged Access Never507alice # [ 0.016802] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations508bob # [ 0.005847] CPU features: detected: PMUv3509bob # [ 0.005849] CPU features: detected: RAS Extension Support510alice # [ 0.016953] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations511bob # [ 0.005852] CPU features: detected: Speculative Store Bypassing Safe (SSBS)512alice # [ 0.016970] audit: initializing netlink subsys (disabled)513clare # [ 0.122245] VFS: Disk quotas dquot_6.6.0514bob # [ 0.005873] alternatives: applying system-wide alternatives515alice # [ 0.017572] thermal_sys: Registered thermal governor 'fair_share'516clare # [ 0.122271] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)517alice # [ 0.017575] thermal_sys: Registered thermal governor 'bang_bang'518bob # [ 0.007290] CPU features: detected: Hardware dirty bit management on CPU0519clare # [ 0.123711] netfs: FS-Cache loaded520clare # [ 0.123802] pnp: PnP ACPI: disabled521alice # [ 0.017578] thermal_sys: Registered thermal governor 'step_wise'522alice # [ 0.017580] thermal_sys: Registered thermal governor 'user_space'523bob # [ 0.007529] Memory: 891136K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116112K reserved, 32768K cma-reserved)524bob # [ 0.007971] devtmpfs: initialized525alice # [ 0.017582] thermal_sys: Registered thermal governor 'power_allocator'526bob # [ 0.009538] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)527alice # [ 0.017629] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1528alice # [ 0.017637] cpuidle: using governor ladder529alice # [ 0.017642] cpuidle: using governor menu530bob # [ 0.009562] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).531bob # [ 0.009689] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL532alice # [ 0.017772] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.533bob # [ 0.009694] 0 pages in range for non-PLT usage534clare # [ 0.127040] NET: Registered PF_INET protocol family535alice # [ 0.017795] ASID allocator initialised with 32768 entries536bob # [ 0.009695] 508192 pages in range for PLT usage537alice # [ 0.018471] Serial: AMBA PL011 UART driver538clare # [ 0.127215] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)539bob # [ 0.009797] pinctrl core: initialized pinctrl subsystem540bob # [ 0.010594] DMI not present or invalid.541alice # [ 0.022166] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1542alice # [ 0.022348] printk: console [ttyAMA0] enabled543bob # [ 0.014150] NET: Registered PF_NETLINK/PF_ROUTE protocol family544bob # [ 0.016613] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations545bob # [ 0.016743] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations546bob # [ 0.016891] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations547bob # [ 0.016907] audit: initializing netlink subsys (disabled)548bob # [ 0.017535] thermal_sys: Registered thermal governor 'fair_share'549bob # [ 0.017538] thermal_sys: Registered thermal governor 'bang_bang'550bob # [ 0.017541] thermal_sys: Registered thermal governor 'step_wise'551bob # [ 0.017543] thermal_sys: Registered thermal governor 'user_space'552bob # [ 0.017545] thermal_sys: Registered thermal governor 'power_allocator'553bob # [ 0.017587] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1554bob # [ 0.017596] cpuidle: using governor ladder555bob # [ 0.017601] cpuidle: using governor menu556bob # [ 0.017715] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.557bob # [ 0.017736] ASID allocator initialised with 32768 entries558bob # [ 0.018396] Serial: AMBA PL011 UART driver559bob # [ 0.021766] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1560bob # [ 0.021945] printk: console [ttyAMA0] enabled561alice # [ 0.096497] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages562alice # [ 0.096511] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page563alice # [ 0.096514] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages564alice # [ 0.096518] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page565alice # [ 0.096520] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages566alice # [ 0.096522] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page567alice # [ 0.096524] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages568alice # [ 0.096526] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page569alice # [ 0.097557] fbcon: Taking over console570alice # [ 0.097566] ACPI: Interpreter disabled.571alice # [ 0.098265] iommu: Default domain type: Translated572alice # [ 0.098269] iommu: DMA domain TLB invalidation policy: strict mode573alice # [ 0.098580] SCSI subsystem initialized574alice # [ 0.100338] usbcore: registered new interface driver usbfs575alice # [ 0.100369] usbcore: registered new interface driver hub576alice # [ 0.100379] usbcore: registered new device driver usb577alice # [ 0.100587] pps_core: LinuxPPS API ver. 1 registered578alice # [ 0.100590] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>579alice # [ 0.100595] PTP clock support registered580alice # [ 0.100628] EDAC MC: Ver: 3.0.0581bob # [ 0.101007] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages582bob # [ 0.101020] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page583bob # [ 0.101023] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages584bob # [ 0.101027] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page585bob # [ 0.101029] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages586bob # [ 0.101031] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page587bob # [ 0.101033] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages588alice # [ 0.109608] scmi_core: SCMI protocol bus registered589bob # [ 0.101035] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page590alice # [ 0.109948] FPGA manager framework591bob # [ 0.102029] fbcon: Taking over console592bob # [ 0.102039] ACPI: Interpreter disabled.593bob # [ 0.102704] iommu: Default domain type: Translated594bob # [ 0.102709] iommu: DMA domain TLB invalidation policy: strict mode595bob # [ 0.103000] SCSI subsystem initialized596bob # [ 0.103220] usbcore: registered new interface driver usbfs597bob # [ 0.103250] usbcore: registered new interface driver hub598bob # [ 0.103259] usbcore: registered new device driver usb599bob # [ 0.103463] pps_core: LinuxPPS API ver. 1 registered600alice # [ 0.113630] vgaarb: loaded601bob # [ 0.103466] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>602alice # [ 0.113891] clocksource: Switched to clocksource arch_sys_counter603bob # [ 0.103470] PTP clock support registered604bob # [ 0.103503] EDAC MC: Ver: 3.0.0605bob # [ 0.113294] scmi_core: SCMI protocol bus registered606clare # [ 0.152404] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)607clare # [ 0.152424] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)608clare # [ 0.152436] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)609bob # [ 0.114087] FPGA manager framework610clare # [ 0.152471] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)611bob # [ 0.117222] vgaarb: loaded612clare # [ 0.152537] TCP: Hash tables configured (established 8192 bind 8192)613clare # [ 0.152629] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)614clare # [ 0.152655] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)615clare # [ 0.152709] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)616clare # [ 0.152829] NET: Registered PF_UNIX/PF_LOCAL protocol family617clare # [ 0.152888] NET: Registered PF_XDP protocol family618clare # [ 0.152907] PCI: CLS 0 bytes, default 64619clare # [ 0.153114] Trying to unpack rootfs image as initramfs...620alice # [ 0.125330] VFS: Disk quotas dquot_6.6.0621bob # [ 0.117901] clocksource: Switched to clocksource arch_sys_counter622alice # [ 0.125356] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)623clare # [ 0.167241] kvm [1]: HYP mode not available624alice # [ 0.127821] netfs: FS-Cache loaded625alice # [ 0.127932] pnp: PnP ACPI: disabled626alice # [ 0.129769] NET: Registered PF_INET protocol family627alice # [ 0.130939] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)628bob # [ 0.127587] VFS: Disk quotas dquot_6.6.0629bob # [ 0.127612] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)630bob # [ 0.129083] netfs: FS-Cache loaded631bob # [ 0.129193] pnp: PnP ACPI: disabled632bob # [ 0.132443] NET: Registered PF_INET protocol family633bob # [ 0.132628] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)634alice # [ 0.155942] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)635alice # [ 0.155965] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)636alice # [ 0.155977] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)637alice # [ 0.156014] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)638alice # [ 0.156080] TCP: Hash tables configured (established 8192 bind 8192)639alice # [ 0.156212] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)640alice # [ 0.156267] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)641alice # [ 0.156317] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)642alice # [ 0.156427] NET: Registered PF_UNIX/PF_LOCAL protocol family643alice # [ 0.156490] NET: Registered PF_XDP protocol family644alice # [ 0.156511] PCI: CLS 0 bytes, default 64645alice # [ 0.156840] Trying to unpack rootfs image as initramfs...646alice # [ 0.164429] kvm [1]: HYP mode not available647bob # [ 0.158109] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)648bob # [ 0.158131] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)649bob # [ 0.158143] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)650bob # [ 0.158181] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)651bob # [ 0.158247] TCP: Hash tables configured (established 8192 bind 8192)652bob # [ 0.158388] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)653bob # [ 0.158445] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)654bob # [ 0.158496] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)655bob # [ 0.158602] NET: Registered PF_UNIX/PF_LOCAL protocol family656bob # [ 0.158629] NET: Registered PF_XDP protocol family657bob # [ 0.158650] PCI: CLS 0 bytes, default 64658bob # [ 0.158868] Trying to unpack rootfs image as initramfs...659bob # [ 0.167967] kvm [1]: HYP mode not available660clare # [ 0.229568] Initialise system trusted keyrings661clare # [ 0.229696] workingset: timestamp_bits=42 max_order=18 bucket_order=0662clare # [ 0.230030] squashfs: version 4.0 (2009/01/31) Phillip Lougher663clare # [ 0.230065] 9p: Installing v9fs 9p2000 file system support664clare # [ 0.248866] Key type asymmetric registered665clare # [ 0.248884] Asymmetric key parser 'x509' registered666clare # [ 0.248949] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)667clare # [ 0.257225] io scheduler mq-deadline registered668clare # [ 0.257237] io scheduler kyber registered669clare # [ 0.259705] pl061_gpio 9030000.pl061: PL061 GPIO chip registered670clare # [ 0.260033] ledtrig-cpu: registered to indicate activity on CPUs671clare # [ 0.260378] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:672clare # [ 0.260396] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000673clare # [ 0.260409] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000674clare # [ 0.260413] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000675clare # [ 0.260437] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits676clare # [ 0.260457] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]677clare # [ 0.260535] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00678clare # [ 0.260556] pci_bus 0000:00: root bus resource [bus 00-ff]679clare # [ 0.260559] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]680clare # [ 0.260562] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]681clare # [ 0.260564] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]682clare # [ 0.260673] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint683clare # [ 0.261112] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint684clare # [ 0.277308] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]685clare # [ 0.277323] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]686clare # [ 0.277341] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]687clare # [ 0.277350] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]688alice # [ 0.239098] Initialise system trusted keyrings689clare # [ 0.277702] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint690alice # [ 0.239225] workingset: timestamp_bits=42 max_order=18 bucket_order=0691clare # [ 0.277829] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]692alice # [ 0.239610] squashfs: version 4.0 (2009/01/31) Phillip Lougher693clare # [ 0.277838] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]694alice # [ 0.239665] 9p: Installing v9fs 9p2000 file system support695clare # [ 0.277856] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]696clare # [ 0.278163] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint697clare # [ 0.278285] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]698clare # [ 0.278294] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]699clare # [ 0.278312] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]700clare # [ 0.278609] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint701clare # [ 0.278732] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]702clare # [ 0.278741] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]703clare # [ 0.278760] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]704clare # [ 0.278768] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]705clare # [ 0.279078] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint706clare # [ 0.279201] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]707clare # [ 0.279219] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]708clare # [ 0.279543] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint709clare # [ 0.279668] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]710clare # [ 0.279685] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]711clare # [ 0.279946] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint712clare # [ 0.280063] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]713clare # [ 0.280280] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint714clare # [ 0.280415] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]715clare # [ 0.280433] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]716clare # [ 0.280739] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint717bob # [ 0.238280] Initialise system trusted keyrings718clare # [ 0.280865] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]719bob # [ 0.238423] workingset: timestamp_bits=42 max_order=18 bucket_order=0720clare # [ 0.280883] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]721bob # [ 0.238756] squashfs: version 4.0 (2009/01/31) Phillip Lougher722bob # [ 0.238800] 9p: Installing v9fs 9p2000 file system support723clare # [ 0.296862] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint724clare # [ 0.296989] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]725clare # [ 0.297008] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]726clare # [ 0.298935] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint727clare # [ 0.299096] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]728clare # [ 0.299105] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]729clare # [ 0.299123] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]730alice # [ 0.260335] Key type asymmetric registered731alice # [ 0.260349] Asymmetric key parser 'x509' registered732clare # [ 0.299494] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint733clare # [ 0.299614] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]734alice # [ 0.260401] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)735clare # [ 0.299622] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]736alice # [ 0.260529] io scheduler mq-deadline registered737alice # [ 0.260532] io scheduler kyber registered738clare # [ 0.299640] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]739clare # [ 0.300053] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned740clare # [ 0.300060] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned741clare # [ 0.300063] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned742clare # [ 0.300095] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned743clare # [ 0.300125] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned744bob # [ 0.259312] Key type asymmetric registered745bob # [ 0.259324] Asymmetric key parser 'x509' registered746clare # [ 0.300154] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned747bob # [ 0.259394] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)748clare # [ 0.300184] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned749clare # [ 0.300213] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned750clare # [ 0.300242] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned751clare # [ 0.300271] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned752clare # [ 0.300300] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned753bob # [ 0.263211] io scheduler mq-deadline registered754clare # [ 0.300342] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned755bob # [ 0.263217] io scheduler kyber registered756clare # [ 0.300397] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned757clare # [ 0.300425] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned758clare # [ 0.300461] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned759clare # [ 0.300473] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned760clare # [ 0.300485] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned761alice # [ 0.271128] pl061_gpio 9030000.pl061: PL061 GPIO chip registered762clare # [ 0.300497] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned763alice # [ 0.271495] ledtrig-cpu: registered to indicate activity on CPUs764clare # [ 0.300508] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned765clare # [ 0.300520] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned766alice # [ 0.271833] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:767clare # [ 0.300533] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned768alice # [ 0.271851] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000769clare # [ 0.300545] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned770alice # [ 0.271864] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000771clare # [ 0.300557] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned772alice # [ 0.271868] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000773clare # [ 0.300568] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned774clare # [ 0.300580] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned775alice # [ 0.271892] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits776clare # [ 0.300592] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned777alice # [ 0.271911] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]778clare # [ 0.300604] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned779clare # [ 0.300616] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned780alice # [ 0.272013] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00781clare # [ 0.300628] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned782alice # [ 0.272035] pci_bus 0000:00: root bus resource [bus 00-ff]783clare # [ 0.300639] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned784alice # [ 0.272038] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]785clare # [ 0.300651] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned786alice # [ 0.272041] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]787clare # [ 0.300666] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]788alice # [ 0.272043] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]789clare # [ 0.300670] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]790alice # [ 0.272118] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint791clare # [ 0.300678] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]792bob # [ 0.274017] pl061_gpio 9030000.pl061: PL061 GPIO chip registered793bob # [ 0.274388] ledtrig-cpu: registered to indicate activity on CPUs794bob # [ 0.274692] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:795bob # [ 0.274708] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000796bob # [ 0.274721] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000797bob # [ 0.274725] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000798bob # [ 0.274753] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits799bob # [ 0.274773] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]800bob # [ 0.274839] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00801bob # [ 0.274861] pci_bus 0000:00: root bus resource [bus 00-ff]802bob # [ 0.274864] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]803bob # [ 0.274867] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]804bob # [ 0.274869] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]805bob # [ 0.274988] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint806alice # [ 0.272581] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint807alice # [ 0.272706] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]808bob # [ 0.275423] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint809alice # [ 0.272715] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]810bob # [ 0.275546] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]811alice # [ 0.272734] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]812bob # [ 0.275555] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]813clare # [ 0.329282] pci 0000:00:07.0: enabling device (0000 -> 0002)814alice # [ 0.272743] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]815bob # [ 0.275573] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]816bob # [ 0.275581] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]817alice # [ 0.273072] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint818alice # [ 0.273195] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]819bob # [ 0.275893] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint820bob # [ 0.276015] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]821alice # [ 0.273203] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]822bob # [ 0.276024] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]823alice # [ 0.273222] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]824bob # [ 0.276043] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]825alice # [ 0.273529] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint826bob # [ 0.276351] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint827alice # [ 0.273664] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]828bob # [ 0.276473] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]829alice # [ 0.273673] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]830bob # [ 0.276482] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]831alice # [ 0.273690] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]832bob # [ 0.276499] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]833bob # [ 0.276802] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint834bob # [ 0.276924] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]835bob # [ 0.276933] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]836bob # [ 0.276951] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]837bob # [ 0.276959] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]838bob # [ 0.277265] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint839bob # [ 0.277384] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]840bob # [ 0.277402] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]841bob # [ 0.277719] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint842bob # [ 0.277839] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]843bob # [ 0.277856] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]844alice # [ 0.296973] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint845clare # [ 0.336284] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)846alice # [ 0.297108] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]847alice # [ 0.297118] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]848alice # [ 0.297137] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]849alice # [ 0.297145] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]850alice # [ 0.297490] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint851bob # [ 0.298198] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint852alice # [ 0.297618] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]853bob # [ 0.298320] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]854alice # [ 0.297635] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]855bob # [ 0.298560] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint856clare # [ 0.346214] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)857alice # [ 0.298026] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint858bob # [ 0.298679] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]859clare # [ 0.348182] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)860alice # [ 0.298151] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]861bob # [ 0.298696] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]862alice # [ 0.298169] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]863bob # [ 0.298997] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint864alice # [ 0.298492] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint865bob # [ 0.299122] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]866alice # [ 0.298613] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]867bob # [ 0.299140] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]868alice # [ 0.298802] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint869bob # [ 0.299435] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint870alice # [ 0.298929] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]871bob # [ 0.299556] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]872alice # [ 0.298946] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]873bob # [ 0.299574] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]874clare # [ 0.350922] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)875bob # [ 0.299877] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint876alice # [ 0.299267] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint877clare # [ 0.352669] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)878bob # [ 0.300032] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]879alice # [ 0.299405] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]880bob # [ 0.300171] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]881alice # [ 0.299423] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]882bob # [ 0.300190] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]883alice # [ 0.299728] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint884bob # [ 0.300494] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint885alice # [ 0.299863] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]886bob # [ 0.300615] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]887alice # [ 0.299881] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]888bob # [ 0.300623] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]889alice # [ 0.300196] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint890bob # [ 0.300641] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]891alice # [ 0.300356] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]892bob # [ 0.301057] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned893alice # [ 0.300365] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]894bob # [ 0.301064] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned895alice # [ 0.300468] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]896bob # [ 0.301067] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned897alice # [ 0.300785] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint898bob # [ 0.301100] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned899alice # [ 0.300922] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]900bob # [ 0.301130] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned901alice # [ 0.300931] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]902bob # [ 0.301161] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned903alice # [ 0.300948] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]904alice # [ 0.301384] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned905bob # [ 0.301191] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned906alice # [ 0.301390] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned907bob # [ 0.301221] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned908alice # [ 0.301393] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned909bob # [ 0.301250] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned910alice # [ 0.301430] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned911bob # [ 0.301280] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned912bob # [ 0.301309] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned913alice # [ 0.301459] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned914alice # [ 0.301489] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned915bob # [ 0.301337] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned916alice # [ 0.301519] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned917bob # [ 0.301410] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned918bob # [ 0.301445] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned919alice # [ 0.301548] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned920clare # [ 0.362388] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)921bob # [ 0.301458] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned922alice # [ 0.301578] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned923clare # [ 0.364001] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)924bob # [ 0.301470] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned925alice # [ 0.301607] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned926bob # [ 0.301482] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned927bob # [ 0.301494] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned928alice # [ 0.301636] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned929bob # [ 0.301506] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned930alice # [ 0.301664] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned931bob # [ 0.301518] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned932alice # [ 0.301736] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned933bob # [ 0.301530] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned934alice # [ 0.301771] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned935bob # [ 0.301542] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned936clare # [ 0.366773] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)937alice # [ 0.301783] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned938bob # [ 0.301554] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned939clare # [ 0.368431] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)940alice # [ 0.301795] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned941bob # [ 0.301566] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned942alice # [ 0.301807] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned943bob # [ 0.301578] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned944bob # [ 0.301590] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned945alice # [ 0.301819] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned946bob # [ 0.301602] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned947alice # [ 0.301831] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned948bob # [ 0.301614] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned949alice # [ 0.301843] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned950bob # [ 0.301626] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned951alice # [ 0.301856] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned952bob # [ 0.301638] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned953alice # [ 0.301868] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned954bob # [ 0.301649] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned955alice # [ 0.301880] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned956bob # [ 0.301666] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]957bob # [ 0.301670] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]958alice # [ 0.301902] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned959bob # [ 0.301678] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]960alice # [ 0.301916] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned961alice # [ 0.301928] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned962alice # [ 0.301940] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned963alice # [ 0.301952] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned964alice # [ 0.301964] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned965alice # [ 0.301985] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned966alice # [ 0.301999] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned967alice # [ 0.302015] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]968alice # [ 0.302019] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]969alice # [ 0.302029] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]970alice # [ 0.302577] pci 0000:00:07.0: enabling device (0000 -> 0002)971clare # [ 0.378038] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)972clare # [ 0.380272] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)973bob # [ 0.334282] pci 0000:00:07.0: enabling device (0000 -> 0002)974alice # [ 0.344428] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)975clare # [ 0.389934] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled976clare # [ 0.390974] msm_serial: driver initialized977clare # [ 0.391058] SuperH (H)SCI(F) driver initialized978clare # [ 0.391098] STM32 USART driver initialized979bob # [ 0.348925] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)980alice # [ 0.354082] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)981alice # [ 0.356447] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)982bob # [ 0.351054] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)983bob # [ 0.352445] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)984bob # [ 0.353776] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)985alice # [ 0.366401] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)986bob # [ 0.362967] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)987alice # [ 0.369615] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)988bob # [ 0.364867] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)989bob # [ 0.367392] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)990bob # [ 0.368847] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)991clare # [ 0.414856] loop: module loaded992clare # [ 0.414991] virtio_blk virtio2: 1/0/0 default/read/poll queues993clare # [ 0.415559] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)994alice # [ 0.379401] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)995alice # [ 0.381301] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)996alice # [ 0.384176] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)997alice # [ 0.385784] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)998bob # [ 0.378047] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)999bob # [ 0.379765] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1000bob # [ 0.382972] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1001clare # [ 0.418905] megasas: 07.734.00.00-rc11002clare # [ 0.419358] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1003clare # [ 0.435681] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001004clare # [ 0.435717] Intel/Sharp Extended Query Table at 0x00311005alice # [ 0.395162] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1006alice # [ 0.397344] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1007bob # [ 0.394697] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1008bob # [ 0.395878] msm_serial: driver initialized1009bob # [ 0.395948] SuperH (H)SCI(F) driver initialized1010bob # [ 0.395986] STM32 USART driver initialized1011clare # [ 0.445193] Using buffer write method1012clare # [ 0.445233] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1013clare # [ 0.447869] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001014clare # [ 0.447884] Intel/Sharp Extended Query Table at 0x00311015clare # [ 0.451538] Using buffer write method1016clare # [ 0.451550] Concatenating MTD devices:1017clare # [ 0.451552] (0): "0.flash"1018clare # [ 0.451554] (1): "0.flash"1019clare # [ 0.451555] into device "0.flash"1020alice # [ 0.410684] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1021alice # [ 0.411718] msm_serial: driver initialized1022alice # [ 0.411797] SuperH (H)SCI(F) driver initialized1023alice # [ 0.411839] STM32 USART driver initialized1024bob # [ 0.420307] loop: module loaded1025bob # [ 0.420449] virtio_blk virtio2: 1/0/0 default/read/poll queues1026bob # [ 0.421041] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1027bob # [ 0.426313] megasas: 07.734.00.00-rc11028bob # [ 0.426830] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1029bob # [ 0.429000] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001030bob # [ 0.429028] Intel/Sharp Extended Query Table at 0x00311031alice # [ 0.435952] loop: module loaded1032alice # [ 0.436101] virtio_blk virtio2: 1/0/0 default/read/poll queues1033alice # [ 0.436721] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1034bob # [ 0.432920] Using buffer write method1035bob # [ 0.432974] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1036alice # [ 0.442339] megasas: 07.734.00.00-rc11037alice # [ 0.442808] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1038alice # [ 0.445096] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001039alice # [ 0.445130] Intel/Sharp Extended Query Table at 0x00311040alice # [ 0.449001] Using buffer write method1041alice # [ 0.449036] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1042bob # [ 0.442562] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001043bob # [ 0.442576] Intel/Sharp Extended Query Table at 0x00311044bob # [ 0.444367] Using buffer write method1045bob # [ 0.444379] Concatenating MTD devices:1046bob # [ 0.444380] (0): "0.flash"1047bob # [ 0.444382] (1): "0.flash"1048bob # [ 0.444384] into device "0.flash"1049alice # [ 0.459014] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001050alice # [ 0.459030] Intel/Sharp Extended Query Table at 0x00311051alice # [ 0.461010] Using buffer write method1052alice # [ 0.461020] Concatenating MTD devices:1053alice # [ 0.461022] (0): "0.flash"1054alice # [ 0.461024] (1): "0.flash"1055alice # [ 0.461026] into device "0.flash"1056clare # [ 0.671351] Freeing initrd memory: 26948K1057clare # [ 0.678259] tun: Universal TUN/TAP device driver, 1.61058clare # [ 0.680516] thunder_xcv, ver 1.01059clare # [ 0.680532] thunder_bgx, ver 1.01060clare # [ 0.680541] nicpf, ver 1.01061clare # [ 0.680868] e1000: Intel(R) PRO/1000 Network Driver1062clare # [ 0.680873] e1000: Copyright (c) 1999-2006 Intel Corporation.1063clare # [ 0.680887] e1000e: Intel(R) PRO/1000 Network Driver1064clare # [ 0.680892] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1065clare # [ 0.680904] igb: Intel(R) Gigabit Ethernet Network Driver1066clare # [ 0.680906] igb: Copyright (c) 2007-2014 Intel Corporation.1067clare # [ 0.680916] igbvf: Intel(R) Gigabit Virtual Function Network Driver1068clare # [ 0.680921] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1069clare # [ 0.680987] sky2: driver version 1.301070clare # [ 0.687002] usbcore: registered new interface driver usb-storage1071clare # [ 0.687133] usbcore: registered new interface driver usbserial_generic1072clare # [ 0.687140] usbserial: USB Serial support registered for generic1073clare # [ 0.687454] hv_vmbus: registering driver hyperv_keyboard1074clare # [ 0.688527] ehci-pci 0000:00:07.0: EHCI Host Controller1075clare # [ 0.688553] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11076clare # [ 0.688769] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001077clare # [ 0.688939] rtc-pl031 9010000.pl031: registered as rtc01078clare # [ 0.688964] rtc-pl031 9010000.pl031: setting system clock to 2026-10-14T20:03:39 UTC (1792008219)1079clare # [ 0.693646] i2c_dev: i2c /dev entries driver1080clare # [ 0.695324] sdhci: Secure Digital Host Controller Interface driver1081clare # [ 0.695330] sdhci: Copyright(c) Pierre Ossman1082clare # [ 0.695485] Synopsys Designware Multimedia Card Interface Driver1083clare # [ 0.695669] sdhci-pltfm: SDHCI platform and OF driver helper1084clare # [ 0.696570] hid: raw HID events driver (C) Jiri Kosina1085clare # [ 0.696707] usbcore: registered new interface driver usbhid1086clare # [ 0.696710] usbhid: USB HID core driver1087clare # [ 0.697214] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001088clare # [ 0.697613] hub 1-0:1.0: USB hub found1089clare # [ 0.697632] hub 1-0:1.0: 6 ports detected1090bob # [ 0.668610] Freeing initrd memory: 26928K1091alice # [ 0.679767] Freeing initrd memory: 26944K1092bob # [ 0.675649] tun: Universal TUN/TAP device driver, 1.61093bob # [ 0.678401] thunder_xcv, ver 1.01094bob # [ 0.678419] thunder_bgx, ver 1.01095bob # [ 0.678428] nicpf, ver 1.01096bob # [ 0.678784] e1000: Intel(R) PRO/1000 Network Driver1097bob # [ 0.678788] e1000: Copyright (c) 1999-2006 Intel Corporation.1098bob # [ 0.678800] e1000e: Intel(R) PRO/1000 Network Driver1099bob # [ 0.678806] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1100bob # [ 0.678818] igb: Intel(R) Gigabit Ethernet Network Driver1101bob # [ 0.678820] igb: Copyright (c) 2007-2014 Intel Corporation.1102bob # [ 0.678832] igbvf: Intel(R) Gigabit Virtual Function Network Driver1103alice # [ 0.688906] tun: Universal TUN/TAP device driver, 1.61104bob # [ 0.678837] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1105bob # [ 0.678900] sky2: driver version 1.301106bob # [ 0.679717] usbcore: registered new interface driver usb-storage1107bob # [ 0.679757] usbcore: registered new interface driver usbserial_generic1108bob # [ 0.679764] usbserial: USB Serial support registered for generic1109bob # [ 0.680087] hv_vmbus: registering driver hyperv_keyboard1110bob # [ 0.681165] ehci-pci 0000:00:07.0: EHCI Host Controller1111bob # [ 0.681215] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11112alice # [ 0.691640] thunder_xcv, ver 1.01113bob # [ 0.681423] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001114alice # [ 0.691656] thunder_bgx, ver 1.01115alice # [ 0.691665] nicpf, ver 1.01116bob # [ 0.681612] rtc-pl031 9010000.pl031: registered as rtc01117alice # [ 0.692006] e1000: Intel(R) PRO/1000 Network Driver1118bob # [ 0.681637] rtc-pl031 9010000.pl031: setting system clock to 2026-10-14T20:03:39 UTC (1792008219)1119alice # [ 0.692010] e1000: Copyright (c) 1999-2006 Intel Corporation.1120bob # [ 0.681802] i2c_dev: i2c /dev entries driver1121alice # [ 0.692022] e1000e: Intel(R) PRO/1000 Network Driver1122alice # [ 0.692028] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1123alice # [ 0.692040] igb: Intel(R) Gigabit Ethernet Network Driver1124alice # [ 0.692042] igb: Copyright (c) 2007-2014 Intel Corporation.1125clare # [ 0.736490] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1126alice # [ 0.692051] igbvf: Intel(R) Gigabit Virtual Function Network Driver1127clare # [ 0.737451] drop_monitor: Initializing network drop monitor service1128clare # [ 0.737569] NET: Registered PF_INET6 protocol family1129alice # [ 0.692056] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1130alice # [ 0.692120] sky2: driver version 1.301131alice # [ 0.692984] usbcore: registered new interface driver usb-storage1132bob # [ 0.690945] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001133bob # [ 0.691292] hub 1-0:1.0: USB hub found1134alice # [ 0.693142] usbcore: registered new interface driver usbserial_generic1135bob # [ 0.691309] hub 1-0:1.0: 6 ports detected1136alice # [ 0.693148] usbserial: USB Serial support registered for generic1137bob # [ 0.693125] sdhci: Secure Digital Host Controller Interface driver1138clare # [ 0.739933] Segment Routing with IPv61139bob # [ 0.693130] sdhci: Copyright(c) Pierre Ossman1140clare # [ 0.739951] In-situ OAM (IOAM) with IPv61141alice # [ 0.693473] hv_vmbus: registering driver hyperv_keyboard1142clare # [ 0.740008] NET: Registered PF_PACKET protocol family1143bob # [ 0.693278] Synopsys Designware Multimedia Card Interface Driver1144clare # [ 0.740071] 9pnet: Installing 9P2000 support1145bob # [ 0.693454] sdhci-pltfm: SDHCI platform and OF driver helper1146clare # [ 0.740101] Key type dns_resolver registered1147alice # [ 0.701320] ehci-pci 0000:00:07.0: EHCI Host Controller1148alice # [ 0.701379] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11149bob # [ 0.697191] hid: raw HID events driver (C) Jiri Kosina1150alice # [ 0.701621] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001151bob # [ 0.697332] usbcore: registered new interface driver usbhid1152alice # [ 0.701823] rtc-pl031 9010000.pl031: registered as rtc01153bob # [ 0.697335] usbhid: USB HID core driver1154alice # [ 0.701853] rtc-pl031 9010000.pl031: setting system clock to 2026-10-14T20:03:39 UTC (1792008219)1155alice # [ 0.704693] i2c_dev: i2c /dev entries driver1156bob # [ 0.699187] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1157bob # [ 0.700005] drop_monitor: Initializing network drop monitor service1158bob # [ 0.700152] NET: Registered PF_INET6 protocol family1159clare # [ 0.744664] registered taskstats version 11160bob # [ 0.700779] Segment Routing with IPv61161bob # [ 0.700796] In-situ OAM (IOAM) with IPv61162clare # [ 0.744802] Loading compiled-in X.509 certificates1163bob # [ 0.700862] NET: Registered PF_PACKET protocol family1164bob # [ 0.700924] 9pnet: Installing 9P2000 support1165bob # [ 0.700956] Key type dns_resolver registered1166alice # [ 0.706755] sdhci: Secure Digital Host Controller Interface driver1167alice # [ 0.706761] sdhci: Copyright(c) Pierre Ossman1168alice # [ 0.706913] Synopsys Designware Multimedia Card Interface Driver1169alice # [ 0.707094] sdhci-pltfm: SDHCI platform and OF driver helper1170clare # [ 0.750034] Demotion targets for Node 0: null1171alice # [ 0.708039] hid: raw HID events driver (C) Jiri Kosina1172clare # [ 0.750139] Key type .fscrypt registered1173alice # [ 0.708190] usbcore: registered new interface driver usbhid1174clare # [ 0.750146] Key type fscrypt-provisioning registered1175alice # [ 0.708193] usbhid: USB HID core driver1176clare # [ 0.750254] ima: No TPM chip found, activating TPM-bypass!1177clare # [ 0.750264] ima: Allocated hash algorithm: sha11178alice # [ 0.708934] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1179clare # [ 0.750321] ima: No architecture policies found1180alice # [ 0.709806] drop_monitor: Initializing network drop monitor service1181clare # [ 0.750800] input: gpio-keys as /devices/platform/gpio-keys/input/input01182alice # [ 0.709939] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001183bob # [ 0.707047] registered taskstats version 11184bob # [ 0.707183] Loading compiled-in X.509 certificates1185alice # [ 0.715113] hub 1-0:1.0: USB hub found1186alice # [ 0.715140] hub 1-0:1.0: 6 ports detected1187alice # [ 0.715497] NET: Registered PF_INET6 protocol family1188alice # [ 0.716164] Segment Routing with IPv61189bob # [ 0.712626] Demotion targets for Node 0: null1190bob # [ 0.712703] Key type .fscrypt registered1191alice # [ 0.716182] In-situ OAM (IOAM) with IPv61192bob # [ 0.712709] Key type fscrypt-provisioning registered1193alice # [ 0.716237] NET: Registered PF_PACKET protocol family1194bob # [ 0.712817] ima: No TPM chip found, activating TPM-bypass!1195alice # [ 0.716301] 9pnet: Installing 9P2000 support1196bob # [ 0.712827] ima: Allocated hash algorithm: sha11197alice # [ 0.716330] Key type dns_resolver registered1198bob # [ 0.712883] ima: No architecture policies found1199bob # [ 0.713332] input: gpio-keys as /devices/platform/gpio-keys/input/input01200clare # [ 0.763251] clk: Disabling unused clocks1201clare # [ 0.763261] PM: genpd: Disabling unused power domains1202alice # [ 0.722092] registered taskstats version 11203alice # [ 0.722244] Loading compiled-in X.509 certificates1204clare # [ 0.766202] Freeing unused kernel memory: 4736K1205clare # [ 0.766278] Run /init as init process1206alice # [ 0.727769] Demotion targets for Node 0: null1207alice # [ 0.727850] Key type .fscrypt registered1208bob # [ 0.725730] clk: Disabling unused clocks1209alice # [ 0.727856] Key type fscrypt-provisioning registered1210bob # [ 0.725740] PM: genpd: Disabling unused power domains1211alice # [ 0.727984] ima: No TPM chip found, activating TPM-bypass!1212alice # [ 0.727995] ima: Allocated hash algorithm: sha11213alice # [ 0.728086] ima: No architecture policies found1214alice # [ 0.728566] input: gpio-keys as /devices/platform/gpio-keys/input/input01215bob # [ 0.728770] Freeing unused kernel memory: 4736K1216bob # [ 0.728865] Run /init as init process1217alice # [ 0.741478] clk: Disabling unused clocks1218alice # [ 0.741487] PM: genpd: Disabling unused power domains1219clare # [ 0.784010] systemd[1]: Successfully made /usr/ read-only.1220alice # [ 0.744544] Freeing unused kernel memory: 4736K1221alice # [ 0.744629] Run /init as init process1222bob # [ 0.748893] systemd[1]: Successfully made /usr/ read-only.1223alice # [ 0.764309] systemd[1]: Successfully made /usr/ read-only.1224clare # [ 0.961215] usb 1-1: new high-speed USB device number 2 using ehci-pci1225bob # [ 0.937994] usb 1-1: new high-speed USB device number 2 using ehci-pci1226alice # [ 0.961988] usb 1-1: new high-speed USB device number 2 using ehci-pci1227clare # [ 1.111375] 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/input11228clare # [ 1.118197] systemd[1]: systemd 261.3 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)1229clare # [ 1.118225] systemd[1]: Detected virtualization qemu.1230clare # [ 1.118261] systemd[1]: Detected architecture arm64.1231clare # [ 1.118270] systemd[1]: Running in initrd.1232clare # [ 1.119088] systemd[1]: Initializing machine ID from random generator.1233clare # [ 1.119775] systemd[1]: Hostname set to <clare>.1234bob # [ 1.083122] systemd[1]: systemd 261.3 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.083153] systemd[1]: Detected virtualization qemu.1236bob # [ 1.083193] systemd[1]: Detected architecture arm64.1237bob # [ 1.083202] systemd[1]: Running in initrd.1238bob # [ 1.084030] systemd[1]: Initializing machine ID from random generator.1239bob # [ 1.084312] systemd[1]: Hostname set to <bob>.1240alice # [ 1.098449] systemd[1]: systemd 261.3 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)1241alice # [ 1.098480] systemd[1]: Detected virtualization qemu.1242alice # [ 1.098520] systemd[1]: Detected architecture arm64.1243alice # [ 1.098529] systemd[1]: Running in initrd.1244alice # [ 1.099426] systemd[1]: Initializing machine ID from random generator.1245alice # [ 1.099757] systemd[1]: Hostname set to <alice>.1246bob # [ 1.106626] 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/input11247alice # [ 1.122815] 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/input11248clare # [ 1.197344] 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.198090] 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.251599] systemd[1]: bpf-restrict-fs: LSM BPF program attached1251alice # [ 1.210083] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01252bob # [ 1.222055] systemd[1]: bpf-restrict-fs: LSM BPF program attached1253alice # [ 1.238377] systemd[1]: bpf-restrict-fs: LSM BPF program attached1254clare # [ 1.305416] systemd[1]: Queued start job for default target Initrd Default Target.1255clare # [ 1.314757] systemd[1]: Created slice Slice /system/modprobe.1256clare # [ 1.314908] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1257clare # [ 1.314943] systemd[1]: Expecting device /dev/disk/by-label/nixos...1258clare # [ 1.314963] systemd[1]: Reached target Path Units.1259clare # [ 1.314977] systemd[1]: Reached target Slice Units.1260clare # [ 1.314989] systemd[1]: Reached target Swaps.1261clare # [ 1.315001] systemd[1]: Reached target Timer Units.1262clare # [ 1.315137] systemd[1]: Listening on D-Bus System Message Bus Socket.1263bob # [ 1.271224] systemd[1]: Queued start job for default target Initrd Default Target.1264clare # [ 1.315252] systemd[1]: Listening on Journal Socket (/dev/log).1265clare # [ 1.315336] systemd[1]: Listening on Journal Sockets.1266clare # [ 1.315398] systemd[1]: Listening on udev Control Socket.1267clare # [ 1.315478] systemd[1]: Listening on udev Kernel Socket.1268clare # [ 1.315496] systemd[1]: Reached target Socket Units.1269bob # [ 1.275990] systemd[1]: Created slice Slice /system/modprobe.1270clare # [ 1.317081] systemd[1]: Starting Create List of Static Device Nodes...1271bob # [ 1.276129] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1272bob # [ 1.276159] systemd[1]: Expecting device /dev/disk/by-label/nixos...1273clare # [ 1.317133] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1274bob # [ 1.276179] systemd[1]: Reached target Path Units.1275bob # [ 1.276192] systemd[1]: Reached target Slice Units.1276clare # [ 1.317188] usb 1-2: new high-speed USB device number 3 using ehci-pci1277bob # [ 1.276203] systemd[1]: Reached target Swaps.1278bob # [ 1.276214] systemd[1]: Reached target Timer Units.1279bob # [ 1.276338] systemd[1]: Listening on D-Bus System Message Bus Socket.1280bob # [ 1.276451] systemd[1]: Listening on Journal Socket (/dev/log).1281bob # [ 1.276561] systemd[1]: Listening on Journal Sockets.1282bob # [ 1.276629] systemd[1]: Listening on udev Control Socket.1283bob # [ 1.276672] systemd[1]: Listening on udev Kernel Socket.1284bob # [ 1.276685] systemd[1]: Reached target Socket Units.1285bob # [ 1.277702] systemd[1]: Starting Create List of Static Device Nodes...1286bob # [ 1.277749] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1287alice # [ 1.286884] systemd[1]: Queued start job for default target Initrd Default Target.1288alice # [ 1.292054] systemd[1]: Created slice Slice /system/modprobe.1289alice # [ 1.292190] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1290bob # [ 1.286604] systemd[1]: Mounting Kernel Configuration File System...1291alice # [ 1.292219] systemd[1]: Expecting device /dev/disk/by-label/nixos...1292alice # [ 1.292238] systemd[1]: Reached target Path Units.1293alice # [ 1.292250] systemd[1]: Reached target Slice Units.1294alice # [ 1.292262] systemd[1]: Reached target Swaps.1295alice # [ 1.292273] systemd[1]: Reached target Timer Units.1296alice # [ 1.292399] systemd[1]: Listening on D-Bus System Message Bus Socket.1297alice # [ 1.292506] systemd[1]: Listening on Journal Socket (/dev/log).1298alice # [ 1.292617] systemd[1]: Listening on Journal Sockets.1299alice # [ 1.292686] systemd[1]: Listening on udev Control Socket.1300alice # [ 1.292727] systemd[1]: Listening on udev Kernel Socket.1301alice # [ 1.292740] systemd[1]: Reached target Socket Units.1302alice # [ 1.293765] systemd[1]: Starting Create List of Static Device Nodes...1303clare # [ 1.333265] systemd[1]: Mounting Kernel Configuration File System...1304alice # [ 1.293811] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1305clare # [ 1.341787] systemd[1]: Starting Journal Service...1306alice # [ 1.302732] systemd[1]: Mounting Kernel Configuration File System...1307bob # [ 1.294076] systemd[1]: Starting Journal Service...1308clare # [ 1.353316] systemd[1]: Starting Load Kernel Modules...1309clare # [ 1.353394] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1310alice # [ 1.310067] systemd[1]: Starting Journal Service...1311bob # [ 1.310763] systemd[1]: Starting Load Kernel Modules...1312bob # [ 1.310835] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1313bob # [ 1.317975] usb 1-2: new high-speed USB device number 3 using ehci-pci1314alice # [ 1.327424] systemd[1]: Starting Load Kernel Modules...1315alice # [ 1.327491] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1316alice # [ 1.330021] usb 1-2: new high-speed USB device number 3 using ehci-pci1317bob # [ 1.326077] systemd[1]: Starting Coldplug All udev Devices...1318bob # [ 1.328249] systemd-journald[71]: Collecting audit messages is disabled.1319clare # [ 1.369273] systemd[1]: Starting Coldplug All udev Devices...1320clare # [ 1.371453] systemd[1]: Finished Create List of Static Device Nodes.1321clare # [ 1.372215] systemd[1]: Mounted Kernel Configuration File System.1322alice # [ 1.341022] systemd[1]: Starting Coldplug All udev Devices...1323clare # [ 1.381455] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1324alice # [ 1.343925] systemd-journald[71]: Collecting audit messages is disabled.1325bob # [ 1.338989] systemd[1]: Finished Create List of Static Device Nodes.1326bob # [ 1.339633] systemd[1]: Mounted Kernel Configuration File System.1327clare # [ 1.391269] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1328alice # [ 1.346698] systemd[1]: Finished Create List of Static Device Nodes.1329bob # [ 1.346166] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1330clare # [ 1.397248] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1331alice # [ 1.358633] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1332alice # [ 1.358823] systemd[1]: Mounted Kernel Configuration File System.1333clare # [ 1.406931] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01334clare # [ 1.407137] [drm] features: -virgl +edid -resource_blob -host_visible1335clare # [ 1.407139] [drm] features: -context_init1336clare # [ 1.407578] [drm] number of scanouts: 11337clare # [ 1.407586] [drm] number of cap sets: 01338clare # [ 1.416530] systemd-journald[71]: Collecting audit messages is disabled.1339bob # [ 1.384775] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1340bob # [ 1.385433] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1341bob # [ 1.386526] systemd[1]: Starting Create Static Device Nodes in /dev...1342clare # [ 1.433493] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1343clare # [ 1.433503] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01344clare # [ 1.438762] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1345clare # [ 1.439920] systemd[1]: Starting Create Static Device Nodes in /dev...1346alice # [ 1.402032] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1347alice # [ 1.403121] systemd[1]: Starting Create Static Device Nodes in /dev...1348bob # [ 1.405891] systemd[1]: Started Journal Service.1349alice # [ 1.411524] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1350bob # [ 1.406479] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1351clare # [ 1.453562] Console: switching to colour frame buffer device 160x501352alice # [ 1.417913] systemd[1]: Started Journal Service.1353bob # [ 1.416790] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01354bob # [ 1.417011] [drm] features: -virgl +edid -resource_blob -host_visible1355alice # [ 1.417900] systemd-modules-load[73]: Inserted module 'dm_mod'1356bob # [ 1.417016] [drm] features: -context_init1357bob # [ 1.417469] [drm] number of scanouts: 11358bob # [ 1.417478] [drm] number of cap sets: 01359alice # [ 1.419503] systemd-modules-load[73]: Module 'virtio_balloon' is built in[ 1.422457] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1360bob # [ 1.414627] systemd-modules-load[73]: Inserted module 'dm_mod'1361bob # [ 1.420798] systemd-modules-load[73]: Module 'virtio_balloon' is built in1362bob # [ 1.421568] systemd-modules-load[73]: Module 'virtio_console' is built in1363bob # [ 1.422286] systemd[1]: Finished Create Static Device Nodes in /dev.1364clare # [ 1.469706] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1365bob # [ 1.423001] systemd[1]: Reached target Preparation for Local File Systems.1366alice # [ 1.431675] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01367bob # [ 1.423698] systemd[1]: Reached target Local File Systems.1368alice # [ 1.431890] [drm] features: -virgl +edid -resource_blob -host_visible1369alice # [ 1.431894] [drm] features: -context_init1370clare # [ 1.473546] 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/input21371alice # [ 1.432366] [drm] number of scanouts: 11372alice # [ 1.432374] [drm] number of cap sets: 01373clare # [ 1.473698] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01374bob # [ 1.428275] systemd[1]: Starting Create System Files and Directories...1375clare # [ 1.478217] systemd[1]: Finished Load Kernel Modules.1376clare # [ 1.479256] systemd[1]: Starting Apply Kernel Variables...1377alice # 1378alice # [ 1.436691] systemd-modules-load[73]: Module 'virtio_console' is built in1379bob # [ 1.434991] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1380bob # [ 1.435001] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01381alice # [ 1.445619] systemd[1]: Finished Create Static Device Nodes in /dev.1382alice # [ 1.446253] systemd[1]: Reached target Preparation for Local File Systems.1383bob # [ 1.446753] systemd[1]: Starting Rule-based Manager for Device Events and Files...1384alice # [ 1.454142] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1385alice # [ 1.454153] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01386alice # [ 1.453293] systemd[1]: Reached target Local File Systems.1387alice # [ 1.454073] systemd[1]: Starting Create System Files and Directories...1388bob # [ 1.453690] Console: switching to colour frame buffer device 160x501389clare # [ 1.505414] systemd[1]: Finished Create Static Device Nodes in /dev.1390clare # [ 1.505683] systemd[1]: Reached target Preparation for Local File Systems.1391clare # [ 1.505717] systemd[1]: Reached target Local File Systems.1392clare # [ 1.507704] systemd[1]: Starting Rule-based Manager for Device Events and Files...1393clare # [ 1.507927] systemd[1]: Started Journal Service.1394clare # [ 1.501788] systemd-modules-load[72]: Inserted module 'dm_mod'1395clare # [ 1.508854] systemd-modules-load[72]: Module 'virtio_balloon' is built in1396clare # [ 1.509634] systemd-modules-load[72]: Module 'virtio_console' is built in1397clare # [ 1.510362] systemd-modules-load[72]: Inserted module 'virtio_gpu'1398clare # [ 1.511035] systemd-modules-load[72]: Module 'virtio_rng' is built in1399bob # [ 1.468128] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1400alice # [ 1.475265] Console: switching to colour frame buffer device 160x501401clare # [ 1.521391] systemd[1]: Finished Apply Kernel Variables.1402bob # [ 1.475872] 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/input21403bob # [ 1.476037] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01404bob # [ 1.476408] systemd-modules-load[73]: Inserted module 'virtio_gpu'1405bob # [ 1.477085] systemd-modules-load[73]: Module 'virtio_rng' is built in1406alice # [ 1.483407] systemd[1]: Starting Rule-based Manager for Device Events and Files...1407alice # [ 1.493103] 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/input21408bob # [ 1.484073] systemd[1]: Finished Load Kernel Modules.1409bob # [ 1.484622] systemd[1]: Starting Apply Kernel Variables...1410alice # [ 1.493174] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01411clare # [ 1.540299] systemd[1]: Starting Create System Files and Directories...1412bob # [ 1.494672] systemd[1]: Finished Create System Files and Directories.1413alice # [ 1.502083] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1414alice # [ 1.505174] systemd[1]: Finished Create System Files and Directories.1415alice # [ 1.505848] systemd-modules-load[73]: Inserted module 'virtio_gpu'1416alice # [ 1.512117] systemd-modules-load[73]: Module 'virtio_rng' is built in1417alice # [ 1.512780] systemd[1]: Finished Load Kernel Modules.1418bob # [ 1.518274] systemd[1]: Finished Apply Kernel Variables.1419bob # [ 1.524286] systemd-udevd[80]: Using default interface naming scheme 'v261'.1420clare # [ 1.572633] systemd[1]: Finished Create System Files and Directories.1421alice # [ 1.532420] systemd[1]: Starting Apply Kernel Variables...1422alice # [ 1.535346] systemd[1]: Finished Apply Kernel Variables.1423clare # [ 1.577401] systemd-udevd[80]: Using default interface naming scheme 'v261'.1424alice # [ 1.542863] systemd-udevd[84]: Using default interface naming scheme 'v261'.1425bob # [ 1.544395] systemd[1]: Started Rule-based Manager for Device Events and Files.1426clare # [ 1.595425] systemd[1]: Started Rule-based Manager for Device Events and Files.1427alice # [ 1.568300] systemd[1]: Started Rule-based Manager for Device Events and Files.1428bob # [ 1.608898] systemd[1]: Starting Virtual Console Setup...1429clare # [ 1.657120] systemd[1]: Starting Virtual Console Setup...1430alice # [ 1.623173] systemd[1]: Starting Virtual Console Setup...1431bob # [ 1.648557] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1432bob # [ 1.652214] systemd[1]: Finished Virtual Console Setup.1433clare # [ 1.712627] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.1434clare # [ 1.715544] systemd[1]: Finished Virtual Console Setup.1435alice # [ 1.676523] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1436alice # [ 1.678534] systemd[1]: Finished Virtual Console Setup.1437clare # [ 1.959408] systemd[1]: Finished Coldplug All udev Devices.1438clare # [ 1.960578] systemd[1]: Reached target System Initialization.1439clare # [ 1.964702] systemd[1]: Reached target Basic System.1440alice # [ 1.928696] systemd[1]: Finished Coldplug All udev Devices.1441alice # [ 1.930650] systemd[1]: Reached target System Initialization.1442bob # [ 1.929943] systemd[1]: Finished Coldplug All udev Devices.1443bob # [ 1.930601] systemd[1]: Reached target System Initialization.1444bob # [ 1.931130] systemd[1]: Reached target Basic System.1445alice # [ 1.936249] systemd[1]: Reached target Basic System.1446clare # [ 2.083322] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1447bob # [ 2.050647] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1448alice # [ 2.058799] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1449clare # [ 2.123222] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1450alice # [ 2.081833] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.1451bob # [ 2.082162] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1452clare # [ 2.277953] systemd[1]: Found device /dev/disk/by-label/nixos.1453clare # [ 2.284801] systemd[1]: Reached target Initrd Root Device.1454clare # [ 2.300353] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1455bob # [ 2.264924] systemd[1]: Found device /dev/disk/by-label/nixos.1456bob # [ 2.268431] systemd[1]: Reached target Initrd Root Device.1457bob # [ 2.271982] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1458alice # [ 2.325868] systemd[1]: Found device /dev/disk/by-label/nixos.1459alice # [ 2.330713] systemd[1]: Reached target Initrd Root Device.1460alice # [ 2.340182] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1461clare # [ 2.414195] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks1462bob # [ 2.381565] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1463alice # [ 2.410261] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1464clare # [ 2.536080] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1465alice # [ 2.497186] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1466clare # [ 2.542295] systemd[1]: Mounting /sysroot...1467alice # [ 2.500996] systemd[1]: Mounting /sysroot...1468bob # [ 2.498519] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1469bob # [ 2.500126] systemd[1]: Mounting /sysroot...1470clare # [ 2.566573] systemd[1]: Mounted /sysroot.1471clare # [ 2.567928] systemd[1]: Reached target Initrd Root File System.[ 2.569151] EXT4-fs (vda): mounted filesystem 4d5b4875-2f59-41b0-b3d1-06233bd2744a r/w with ordered data mode. Quota mode: none.1472clare # 1473clare # [ 2.572669] systemd[1]: Starting Mountpoints Configured in the Real Root...1474alice # [ 2.531315] systemd[1]: Mounted /sysroot.1475alice # [ 2.535201] EXT4-fs (vda): mounted filesystem 2cc06c57-337d-4d8c-a551-a83915c7cb7b r/w with ordered data mode. Quota mode: none.1476alice # [ 2.533247] systemd[1]: Reached target Initrd Root File System.1477bob # [ 2.532001] EXT4-fs (vda): mounted filesystem 41bf9fc3-1adf-4113-a234-8b17649c2d97 r/w with ordered data mode. Quota mode: none.1478bob # [ 2.530462] systemd[1]: Mounted /sysroot.1479bob # [ 2.533802] systemd[1]: Reached target Initrd Root File System.1480alice # [ 2.539548] systemd[1]: Starting Mountpoints Configured in the Real Root...1481bob # [ 2.537036] systemd[1]: Mounting /sysroot/nix/.ro-store...1482bob # [ 2.547341] systemd[1]: Mounting /sysroot/nix/.rw-store...1483clare # [ 2.595760] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.1484alice # [ 2.555170] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1485clare # [ 2.602473] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...1486clare # [ 2.603550] systemd[1]: Reloading...1487bob # [ 2.557539] systemd[1]: Mounting /sysroot/run...1488alice # [ 2.562169] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1489alice # [ 2.564422] systemd[1]: Reloading...1490bob # [ 2.568511] systemd[1]: Mounting /sysroot/tmp/shared...1491bob # [ 2.587853] systemd[1]: Mounting /sysroot/tmp/xchg...1492bob # [ 2.606960] systemd[1]: Starting Mountpoints Configured in the Real Root...1493bob # [ 2.609391] systemd[1]: Mounted /sysroot/nix/.rw-store.1494bob # [ 2.659930] fuse: init (API version 7.45)1495bob # [ 2.662726] systemd[1]: Starting rw-sysroot-nix-store.service...1496bob # [ 2.667241] virtiofs virtio6: discovered new tag: nix-store1497bob # [ 2.667764] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1498bob # [ 2.668996] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.1499bob # [ 2.673737] systemd[1]: Mounted /sysroot/run.1500bob # [ 2.683287] virtiofs virtio7: discovered new tag: shared1501bob # [ 2.683794] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1502bob # [ 2.685783] virtiofs virtio8: discovered new tag: xchg1503bob # [ 2.692616] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1504bob # [ 2.712991] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...1505bob # [ 2.716844] systemd[1]: Reloading...1506alice # [ 2.752141] systemd[1]: Reloading finished in 188 ms.1507clare # [ 2.794311] systemd[1]: Reloading finished in 189 ms.1508clare # [ 2.816898] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...1509alice # [ 2.776620] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1510alice # [ 2.780116] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1511clare # [ 2.819856] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...1512clare # [ 2.823641] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1513alice # [ 2.782603] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1514clare # [ 2.825130] systemd[1]: Finished Mountpoints Configured in the Real Root.1515alice # [ 2.784419] systemd[1]: Finished Mountpoints Configured in the Real Root.1516clare # [ 2.826910] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1517alice # [ 2.785945] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1518bob # [ 2.911692] systemd[1]: Reloading finished in 201 ms.1519bob # [ 2.943177] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...1520bob # [ 2.946585] systemd[1]: Mounted /sysroot/nix/.ro-store.1521bob # [ 2.948838] systemd[1]: Mounted /sysroot/tmp/shared.1522bob # [ 2.950563] systemd[1]: Mounted /sysroot/tmp/xchg.1523bob # [ 2.951617] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1524bob # [ 2.957664] systemd[1]: Finished rw-sysroot-nix-store.service.1525bob # [ 2.962791] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...1526bob # [ 2.970469] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1527bob # [ 2.972499] systemd[1]: Finished Mountpoints Configured in the Real Root.1528bob # [ 2.974634] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1529bob # [ 2.976900] systemd[1]: Starting rw-sysroot-nix-store.service...1530bob # [ 3.002369] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1531bob # [ 3.003117] systemd[1]: Finished rw-sysroot-nix-store.service.1532alice # [ 3.128270] fuse: init (API version 7.45)1533clare # [ 3.181023] fuse: init (API version 7.45)1534alice # [ 3.175305] virtiofs virtio6: discovered new tag: nix-store1535alice # [ 3.175817] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1536clare # [ 3.218293] virtiofs virtio6: discovered new tag: nix-store1537clare # [ 3.218803] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1538alice # [ 3.178664] (udev-worker)[91]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1539clare # [ 3.223562] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1540clare # [ 3.225291] (udev-worker)[94]: 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 directory1541alice # [ 3.183312] (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 directory1542clare # [ 3.244451] virtiofs virtio7: discovered new tag: shared1543clare # [ 3.244992] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1544alice # [ 3.204741] virtiofs virtio7: discovered new tag: shared1545alice # [ 3.205306] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1546alice # [ 3.208842] virtiofs virtio8: discovered new tag: xchg1547alice # [ 3.209348] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1548alice # [ 3.205921] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1549alice # [ 3.208405] systemd[1]: Stopped Virtual Console Setup.1550clare # [ 3.254550] virtiofs virtio8: discovered new tag: xchg1551clare # [ 3.255076] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1552alice # [ 3.212678] systemd[1]: Stopping Virtual Console Setup...1553alice # [ 3.215023] systemd[1]: Starting Virtual Console Setup...1554clare # [ 3.256790] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1555clare # [ 3.257769] systemd[1]: Stopped Virtual Console Setup.1556clare # [ 3.259117] systemd[1]: Stopping Virtual Console Setup...1557clare # [ 3.262351] systemd[1]: Starting Virtual Console Setup...1558clare # [ 3.278106] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1559alice # [ 3.237552] systemd-vconsole-setup[137]: Configuration of first virtual console was skipped, ignoring remaining ones.1560clare # [ 3.280142] systemd[1]: Stopped Virtual Console Setup.1561clare # [ 3.280992] systemd[1]: Starting Virtual Console Setup...1562alice # [ 3.240426] systemd[1]: Finished Virtual Console Setup.1563clare # [ 3.304276] systemd-vconsole-setup[140]: Configuration of first virtual console was skipped, ignoring remaining ones.1564clare # [ 3.306627] systemd[1]: Finished Virtual Console Setup.1565clare # [ 3.375776] systemd[1]: Mounting /sysroot/nix/.ro-store...1566clare # [ 3.384577] systemd[1]: Mounting /sysroot/nix/.rw-store...1567bob # [ 3.338827] systemd[1]: Mounting /sysroot/nix/store...1568alice # [ 3.352349] systemd[1]: Mounting /sysroot/nix/.ro-store...1569clare # [ 3.399250] systemd[1]: Mounting /sysroot/run...1570alice # [ 3.363298] systemd[1]: Mounting /sysroot/nix/.rw-store...1571clare # [ 3.405365] systemd[1]: Mounting /sysroot/tmp/shared...1572alice # [ 3.369219] systemd[1]: Mounting /sysroot/run...1573alice # [ 3.379579] systemd[1]: Mounting /sysroot/tmp/shared...1574clare # [ 3.427955] systemd[1]: Mounting /sysroot/tmp/xchg...1575alice # [ 3.388517] systemd[1]: Mounting /sysroot/tmp/xchg...1576bob # [ 3.387116] systemd[1]: Mounted /sysroot/nix/store.1577bob # [ 3.387690] systemd[1]: Reached target Initrd File Systems.1578clare # [ 3.435889] systemd[1]: Mounted /sysroot/nix/.ro-store.1579alice # [ 3.396778] systemd[1]: Mounted /sysroot/nix/.rw-store.1580bob # [ 3.392127] systemd[1]: Starting Find NixOS closure...1581clare # [ 3.446513] systemd[1]: Mounted /sysroot/nix/.rw-store.1582bob # [ 3.399687] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1583clare # [ 3.447657] systemd[1]: Mounted /sysroot/run.1584bob # [ 3.406017] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1585alice # [ 3.412547] systemd[1]: Starting rw-sysroot-nix-store.service...1586clare # [ 3.455796] systemd[1]: Starting rw-sysroot-nix-store.service...1587alice # [ 3.414523] systemd[1]: Mounted /sysroot/nix/.ro-store.1588clare # [ 3.458142] systemd[1]: Mounted /sysroot/tmp/shared.1589clare # [ 3.461090] systemd[1]: Mounted /sysroot/tmp/xchg.1590bob # [ 3.413523] (udev-worker)[97]: 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 directory1591alice # [ 3.424187] systemd[1]: Mounted /sysroot/run.1592alice # [ 3.425994] systemd[1]: Mounted /sysroot/tmp/shared.1593alice # [ 3.427475] systemd[1]: Mounted /sysroot/tmp/xchg.1594clare # [ 3.475260] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1595clare # [ 3.476442] systemd[1]: Finished rw-sysroot-nix-store.service.1596alice # [ 3.439098] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1597alice # [ 3.440304] systemd[1]: Finished rw-sysroot-nix-store.service.1598bob # [ 3.436167] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1599bob # [ 3.436981] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1600alice # [ 3.442372] systemd[1]: Mounting /sysroot/nix/store...1601bob # [ 3.451335] systemd[1]: Finished Find NixOS closure.1602bob # [ 3.451921] systemd[1]: Reached target Initrd Default Target.1603bob # [ 3.458127] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1604alice # [ 3.471592] systemd[1]: Mounted /sysroot/nix/store.1605alice # [ 3.472631] systemd[1]: Reached target Initrd File Systems.1606bob # [ 3.469739] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1607bob # [ 3.470966] systemd[1]: Stopped Virtual Console Setup.1608bob # [ 3.471505] systemd[1]: Stopping Virtual Console Setup...1609alice # [ 3.474347] systemd[1]: Starting Find NixOS closure...1610alice # [ 3.483264] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1611bob # [ 3.482227] systemd[1]: Starting Virtual Console Setup...1612bob # [ 3.491397] systemd[1]: Stopped target Initrd Default Target.1613alice # [ 3.501286] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1614bob # [ 3.498850] systemd[1]: Stopped target Basic System.1615bob # [ 3.499451] systemd[1]: Stopped target Initrd Root Device.1616bob # [ 3.499969] systemd[1]: Stopped target Path Units.1617bob # [ 3.501339] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1618bob # [ 3.504232] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1619bob # [ 3.507889] systemd[1]: Stopped target Slice Units.1620bob # [ 3.508555] systemd[1]: Stopped target Socket Units.1621bob # [ 3.512215] systemd[1]: Stopped target System Initialization.1622alice # [ 3.520882] systemd[1]: Finished Find NixOS closure.1623bob # [ 3.516242] systemd[1]: Stopped target Swaps.1624bob # [ 3.516773] systemd[1]: Stopped target Timer Units.1625bob # [ 3.517261] systemd[1]: dbus.socket: Deactivated successfully.1626alice # [ 3.522227] systemd[1]: Reached target Initrd Default Target.1627bob # [ 3.517819] systemd[1]: Closed D-Bus System Message Bus Socket.1628bob # [ 3.518349] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1629bob # [ 3.519004] systemd[1]: Stopped Find NixOS closure.1630bob # [ 3.519622] systemd[1]: Starting rw-sysroot-nix-store.service...1631alice # [ 3.524744] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1632bob # [ 3.529166] systemd[1]: systemd-sysctl.service: Deactivated successfully.1633bob # [ 3.531133] systemd[1]: Stopped Apply Kernel Variables.1634bob # [ 3.531769] systemd[1]: systemd-modules-load.service: Deactivated successfully.1635bob # [ 3.534595] systemd[1]: Stopped Load Kernel Modules.1636bob # [ 3.535967] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1637bob # [ 3.538329] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1638bob # [ 3.539084] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1639bob # [ 3.539741] systemd[1]: Stopped Create System Files and Directories.1640alice # [ 3.548439] systemd[1]: Stopped target Initrd Default Target.1641alice # [ 3.549498] systemd[1]: Stopped target Basic System.1642alice # [ 3.552213] systemd[1]: Stopped target Initrd Root Device.1643alice # [ 3.553042] systemd[1]: Stopped target Path Units.1644alice # [ 3.553567] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1645bob # [ 3.549324] systemd[1]: Stopped target Local File Systems.1646alice # [ 3.555114] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1647bob # [ 3.550733] systemd[1]: Stopped target Preparation for Local File Systems.1648alice # [ 3.556104] systemd[1]: Stopped target Slice Units.1649bob # [ 3.552333] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1650bob # [ 3.553999] systemd[1]: Stopped Coldplug All udev Devices.1651alice # [ 3.560200] systemd[1]: Stopped target Socket Units.1652bob # [ 3.555505] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1653alice # [ 3.560808] systemd[1]: Stopped target System Initialization.1654alice # [ 3.561423] systemd[1]: Stopped target Swaps.1655alice # [ 3.561867] systemd[1]: Stopped target Timer Units.1656alice # [ 3.562346] systemd[1]: dbus.socket: Deactivated successfully.1657alice # [ 3.562910] systemd[1]: Closed D-Bus System Message Bus Socket.1658alice # [ 3.563464] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1659bob # [ 3.559695] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1660bob # [ 3.560801] systemd[1]: Stopped Virtual Console Setup.1661bob # [ 3.561359] systemd[1]: systemd-udevd.service: Deactivated successfully.1662bob # [ 3.561948] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1663bob # [ 3.562577] systemd[1]: systemd-udevd.service: Consumed 1.205s CPU time over 2.104s wall clock time, 23.3M memory peak.1664alice # [ 3.567879] systemd[1]: Stopped Find NixOS closure.1665bob # [ 3.563489] systemd[1]: initrd-cleanup.service: Deactivated successfully.1666alice # [ 3.569521] systemd[1]: Starting rw-sysroot-nix-store.service...1667alice # [ 3.571107] systemd[1]: systemd-sysctl.service: Deactivated successfully.1668bob # [ 3.568310] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1669alice # [ 3.573642] systemd[1]: Stopped Apply Kernel Variables.1670bob # [ 3.568985] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1671bob # [ 3.569661] systemd[1]: Finished rw-sysroot-nix-store.service.1672bob # [ 3.570200] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1673bob # [ 3.571577] systemd[1]: Closed udev Control Socket.1674alice # [ 3.576321] systemd[1]: systemd-modules-load.service: Deactivated successfully.1675bob # [ 3.572712] systemd[1]: Starting Cleanup udev Database...1676bob # [ 3.573236] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1677alice # [ 3.578622] systemd[1]: Stopped Load Kernel Modules.1678bob # [ 3.573931] systemd[1]: Stopped Create Static Device Nodes in /dev.1679bob # [ 3.574523] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1680bob # [ 3.575231] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1681alice # [ 3.579883] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1682bob # [ 3.575920] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1683bob # [ 3.576807] systemd[1]: Stopped Create List of Static Device Nodes.1684alice # [ 3.583730] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1685alice # [ 3.585912] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1686alice # [ 3.587577] systemd[1]: Stopped Create System Files and Directories.1687alice # [ 3.595073] systemd[1]: Stopped target Local File Systems.1688alice # [ 3.595783] systemd[1]: Stopped target Preparation for Local File Systems.1689alice # [ 3.596634] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1690alice # [ 3.600260] systemd[1]: Stopped Coldplug All udev Devices.1691alice # [ 3.600891] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1692alice # [ 3.601823] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1693bob # [ 3.598462] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1694alice # [ 3.603596] systemd[1]: Stopped Virtual Console Setup.1695bob # [ 3.599665] systemd[1]: Finished Cleanup udev Database.1696bob # [ 3.602094] systemd[1]: Reached target Switch Root.1697alice # [ 3.607569] systemd[1]: initrd-cleanup.service: Deactivated successfully.1698alice # [ 3.608422] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1699alice # [ 3.609039] systemd[1]: systemd-udevd.service: Deactivated successfully.1700alice # [ 3.609694] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1701bob # [ 3.605184] systemd[1]: Starting NixOS Activation...1702alice # [ 3.610370] systemd[1]: systemd-udevd.service: Consumed 1.170s CPU time over 2.110s wall clock time, 24.1M memory peak.1703alice # [ 3.611290] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1704alice # [ 3.611956] systemd[1]: Closed udev Control Socket.1705alice # [ 3.614123] systemd[1]: Starting Cleanup udev Database...1706alice # [ 3.614696] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1707alice # [ 3.615409] systemd[1]: Stopped Create Static Device Nodes in /dev.1708alice # [ 3.616044] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1709alice # [ 3.616792] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1710alice # [ 3.617510] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1711alice # [ 3.618166] systemd[1]: Stopped Create List of Static Device Nodes.1712alice # [ 3.618753] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1713alice # [ 3.619418] systemd[1]: Finished rw-sysroot-nix-store.service.1714alice # [ 3.641054] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1715alice # [ 3.642626] systemd[1]: Finished Cleanup udev Database.1716alice # [ 3.643219] systemd[1]: Reached target Switch Root.1717alice # [ 3.648171] systemd[1]: Starting NixOS Activation...1718bob # [ 3.683976] initrd-nixos-activation-start[182]: booting system configuration /nix/store/ahyrv4679vvm0q5sipcp0pp1mdkg2s9n-nixos-system-bob-test1719bob # [ 3.717773] initrd-nixos-activation-start[182]: running activation script...1720alice # [ 3.731270] initrd-nixos-activation-start[172]: booting system configuration /nix/store/4j3663pi8glzya4gqg9yiznbj392dxjl-nixos-system-alice-test1721alice # [ 3.762518] initrd-nixos-activation-start[172]: running activation script...1722bob # [ 3.964293] initrd-nixos-activation-start[205]: setting up /etc...1723alice # [ 4.024317] initrd-nixos-activation-start[195]: setting up /etc...1724bob # [ 4.069167] initrd-nixos-activation-start[205]: setting up age secrets...1725alice # [ 4.121776] initrd-nixos-activation-start[195]: setting up age secrets...1726bob # [ 4.159621] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1727bob # [ 4.161996] systemd[1]: Finished NixOS Activation.1728bob # [ 4.162909] systemd[1]: Starting Switch Root...1729bob # [ 4.178881] systemd[1]: Switching root.1730alice # [ 4.191297] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1731alice # [ 4.192306] systemd[1]: Finished NixOS Activation.1732alice # [ 4.193435] systemd[1]: Starting Switch Root...1733alice # [ 4.211530] systemd[1]: Switching root.1734clare # [ 4.370633] systemd[1]: Mounting /sysroot/nix/store...1735bob # [ 4.350662] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1736alice # [ 4.380935] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1737clare # [ 4.422245] systemd[1]: Mounted /sysroot/nix/store.1738clare # [ 4.424811] systemd[1]: Reached target Initrd File Systems.1739clare # [ 4.428740] systemd[1]: Starting Find NixOS closure...1740clare # [ 4.440405] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1741clare # [ 4.483850] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1742clare # [ 4.486173] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1743clare # [ 4.497828] systemd[1]: Finished Find NixOS closure.1744clare # [ 4.499888] systemd[1]: Reached target Initrd Default Target.1745clare # [ 4.501262] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1746clare # [ 4.528313] systemd[1]: initrd-cleanup.service: Deactivated successfully.1747clare # [ 4.529567] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1748clare # [ 4.533075] systemd[1]: Stopped target Initrd Default Target.1749clare # [ 4.533996] systemd[1]: Stopped target Basic System.1750clare # [ 4.534722] systemd[1]: Stopped target Initrd Root Device.1751clare # [ 4.536208] systemd[1]: Stopped target Path Units.1752clare # [ 4.538403] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1753clare # [ 4.539635] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1754clare # [ 4.544322] systemd[1]: Stopped target Slice Units.1755clare # [ 4.544967] systemd[1]: Stopped target Socket Units.1756clare # [ 4.545546] systemd[1]: Stopped target System Initialization.1757clare # [ 4.546199] systemd[1]: Stopped target Swaps.1758clare # [ 4.546717] systemd[1]: Stopped target Timer Units.1759clare # [ 4.547490] systemd[1]: dbus.socket: Deactivated successfully.1760clare # [ 4.556306] systemd[1]: Closed D-Bus System Message Bus Socket.1761clare # [ 4.556982] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1762clare # [ 4.557732] systemd[1]: Stopped Find NixOS closure.1763clare # [ 4.558239] systemd[1]: Starting rw-sysroot-nix-store.service...1764clare # [ 4.558842] systemd[1]: systemd-sysctl.service: Deactivated successfully.1765clare # [ 4.559648] systemd[1]: Stopped Apply Kernel Variables.1766clare # [ 4.562448] systemd[1]: systemd-modules-load.service: Deactivated successfully.1767clare # [ 4.563418] systemd[1]: Stopped Load Kernel Modules.1768clare # [ 4.563946] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1769clare # [ 4.565131] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1770clare # [ 4.565929] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1771clare # [ 4.566649] systemd[1]: Stopped Create System Files and Directories.1772clare # [ 4.567336] systemd[1]: Stopped target Local File Systems.1773clare # [ 4.567891] systemd[1]: Stopped target Preparation for Local File Systems.1774clare # [ 4.579034] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1775clare # [ 4.579928] systemd[1]: Stopped Coldplug All udev Devices.1776clare # [ 4.584908] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1777clare # [ 4.585772] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1778clare # [ 4.586525] systemd[1]: Stopped Virtual Console Setup.1779clare # [ 4.587059] systemd[1]: systemd-udevd.service: Deactivated successfully.1780clare # [ 4.587840] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1781clare # [ 4.591417] systemd[1]: systemd-udevd.service: Consumed 1.171s CPU time over 3.071s wall clock time, 24.3M memory peak.1782clare # [ 4.592714] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1783clare # [ 4.593423] systemd[1]: Closed udev Control Socket.1784clare # [ 4.593907] systemd[1]: Starting Cleanup udev Database...1785clare # [ 4.594459] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1786clare # [ 4.595347] systemd[1]: Stopped Create Static Device Nodes in /dev.1787clare # [ 4.595940] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1788clare # [ 4.596879] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1789clare # [ 4.597603] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1790clare # [ 4.598246] systemd[1]: Stopped Create List of Static Device Nodes.1791clare # [ 4.598845] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1792clare # [ 4.599700] systemd[1]: Finished rw-sysroot-nix-store.service.1793clare # [ 4.619538] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1794clare # [ 4.622968] systemd[1]: Finished Cleanup udev Database.1795clare # [ 4.623712] systemd[1]: Reached target Switch Root.1796clare # [ 4.626318] systemd[1]: Starting NixOS Activation...1797clare # [ 4.713993] initrd-nixos-activation-start[175]: booting system configuration /nix/store/wv719ask1gnl2x4bid3r2qbvmadrzhvn-nixos-system-clare-test1798clare # [ 4.747637] initrd-nixos-activation-start[175]: running activation script...1799clare # [ 4.983560] initrd-nixos-activation-start[198]: setting up /etc...1800clare # [ 5.078644] initrd-nixos-activation-start[198]: setting up age secrets...1801clare # [ 5.150274] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1802clare # [ 5.152232] systemd[1]: Finished NixOS Activation.1803clare # [ 5.153508] systemd[1]: Starting Switch Root...1804clare # [ 5.174348] systemd[1]: Switching root.1805alice # [ 5.249839] systemd[1]: systemd 261.3 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)1806alice # [ 5.257758] systemd[1]: Detected virtualization qemu.1807alice # [ 5.257884] systemd[1]: Detected architecture arm64.1808alice # [ 5.261795] systemd[1]: Detected first boot.1809alice # [ 5.267315] systemd[1]: Initializing machine ID from random generator.1810bob # [ 5.293469] systemd[1]: systemd 261.3 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)1811clare # [ 5.341850] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1812bob # [ 5.293591] systemd[1]: Detected virtualization qemu.1813bob # [ 5.293657] systemd[1]: Detected architecture arm64.1814bob # [ 5.293783] systemd[1]: Detected first boot.1815bob # [ 5.307490] systemd[1]: Initializing machine ID from random generator.1816alice # [ 5.380982] systemd[1]: bpf-restrict-fs: LSM BPF program attached1817bob # [ 5.446870] systemd[1]: bpf-restrict-fs: LSM BPF program attached1818alice # [ 5.522177] systemd[1]: Applying preset policy.1819bob # [ 5.553440] systemd[1]: Applying preset policy.1820alice # [ 5.718266] systemd[1]: Populated /etc with preset unit settings.1821bob # [ 5.726935] systemd[1]: Populated /etc with preset unit settings.1822clare # [ 5.860923] systemd[1]: systemd 261.3 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)1823clare # [ 5.861022] systemd[1]: Detected virtualization qemu.1824clare # [ 5.861097] systemd[1]: Detected architecture arm64.1825clare # [ 5.871229] systemd[1]: Detected first boot.1826clare # [ 5.876986] systemd[1]: Initializing machine ID from random generator.1827clare # [ 5.979019] systemd[1]: bpf-restrict-fs: LSM BPF program attached1828bob # [ 5.965765] systemd[1]: initrd-switch-root.service: Deactivated successfully.1829bob # [ 5.967482] systemd[1]: Stopped initrd-switch-root.service.1830bob # [ 5.969388] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1831bob # [ 5.973272] systemd[1]: Created slice Slice /system/getty.1832bob # [ 5.975710] systemd[1]: Created slice User and Session Slice.1833bob # [ 5.976470] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1834bob # [ 5.976963] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1835bob # [ 5.980707] systemd[1]: Expecting device /dev/hvc0...1836bob # [ 5.981310] systemd[1]: Expecting device /dev/ttyAMA0...1837bob # [ 5.983440] systemd[1]: Reached target Local Encrypted Volumes.1838bob # [ 5.984067] systemd[1]: Stopped target initrd-fs.target.1839bob # [ 5.984479] systemd[1]: Stopped target initrd-root-fs.target.1840bob # [ 5.985526] systemd[1]: Stopped target initrd-switch-root.target.1841bob # [ 5.988733] systemd[1]: Reached target Virtual Machines and Containers.1842bob # [ 5.989345] systemd[1]: Reached target Path Units.1843bob # [ 5.991020] systemd[1]: Reached target Remote File Systems.1844bob # [ 5.991865] systemd[1]: Reached target Slice Units.1845bob # [ 5.992533] systemd[1]: Reached target Swaps.1846bob # [ 5.997475] systemd[1]: Listening on Query the User Interactively for a Password.1847bob # [ 6.001119] systemd[1]: Listening on Process Core Dump Socket.1848bob # [ 6.004494] systemd[1]: Listening on Credential Encryption/Decryption.1849bob # [ 6.007438] systemd[1]: Listening on Factory Reset Management.1850bob # [ 6.008187] systemd[1]: Listening on Hostname Service Socket.1851bob # [ 6.012412] systemd[1]: Starting Journal Log Access Socket...1852bob # [ 6.014603] systemd[1]: Listening on Journal Audit Socket.1853bob # [ 6.017383] systemd[1]: Listening on Console Output Muting Service Socket.1854bob # [ 6.020108] systemd[1]: Listening on Network Management Metrics Varlink Socket.1855bob # [ 6.022813] systemd[1]: Listening on Network Management Varlink Socket.1856bob # [ 6.023979] systemd[1]: Listening on Network Management Netlink Socket.1857bob # [ 6.024786] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1858bob # [ 6.025362] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1859bob # [ 6.028614] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1860bob # [ 6.033433] systemd[1]: Listening on Disk Repartitioning Service Socket.1861bob # [ 6.035354] systemd[1]: Listening on Resolve Monitor Varlink Socket.1862bob # [ 6.036020] systemd[1]: Listening on Resolve Service Varlink Socket.1863bob # [ 6.036668] systemd[1]: Listening on udev Control Socket.1864bob # [ 6.037303] systemd[1]: Listening on udev Varlink Socket.1865bob # [ 6.042501] systemd[1]: Mounting Huge Pages File System...1866bob # [ 6.045559] systemd[1]: Mounting POSIX Message Queue File System...1867alice # [ 6.051870] systemd[1]: initrd-switch-root.service: Deactivated successfully.1868alice # [ 6.052257] systemd[1]: Stopped initrd-switch-root.service.1869alice # [ 6.055995] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1870alice # [ 6.057735] systemd[1]: Created slice Slice /system/getty.1871alice # [ 6.060710] systemd[1]: Created slice User and Session Slice.1872alice # [ 6.061362] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1873alice # [ 6.061812] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1874alice # [ 6.064277] systemd[1]: Expecting device /dev/hvc0...1875alice # [ 6.064798] systemd[1]: Expecting device /dev/ttyAMA0...1876alice # [ 6.065150] systemd[1]: Reached target Local Encrypted Volumes.1877alice # [ 6.065471] systemd[1]: Stopped target initrd-fs.target.1878alice # [ 6.065760] systemd[1]: Stopped target initrd-root-fs.target.1879alice # [ 6.068534] systemd[1]: Stopped target initrd-switch-root.target.1880alice # [ 6.069191] systemd[1]: Reached target Virtual Machines and Containers.1881alice # [ 6.069803] systemd[1]: Reached target Path Units.1882bob # [ 6.062069] systemd[1]: Mounting Kernel Debug File System...1883alice # [ 6.071924] systemd[1]: Reached target Remote File Systems.1884alice # [ 6.072528] systemd[1]: Reached target Slice Units.1885alice # [ 6.073128] systemd[1]: Reached target Swaps.1886alice # [ 6.077288] systemd[1]: Listening on Query the User Interactively for a Password.1887bob # [ 6.071709] systemd[1]: Mounting Kernel Trace File System...1888alice # [ 6.081574] systemd[1]: Listening on Process Core Dump Socket.1889alice # [ 6.084431] systemd[1]: Listening on Credential Encryption/Decryption.1890alice # [ 6.087911] systemd[1]: Listening on Factory Reset Management.1891alice # [ 6.088677] systemd[1]: Listening on Hostname Service Socket.1892bob # [ 6.085670] systemd[1]: Starting Create List of Static Device Nodes...1893alice # [ 6.093597] systemd[1]: Starting Journal Log Access Socket...1894bob # [ 6.086952] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1895clare # [ 6.136476] systemd[1]: Applying preset policy.1896alice # [ 6.095954] systemd[1]: Listening on Journal Audit Socket.1897alice # [ 6.099654] systemd[1]: Listening on Console Output Muting Service Socket.1898alice # [ 6.100588] systemd[1]: Listening on Network Management Metrics Varlink Socket.1899alice # [ 6.101528] systemd[1]: Listening on Network Management Varlink Socket.1900alice # [ 6.104463] systemd[1]: Listening on Network Management Netlink Socket.1901bob # [ 6.099229] systemd[1]: Mounting Kernel Configuration File System...1902alice # [ 6.106912] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1903alice # [ 6.107782] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1904alice # [ 6.109045] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1905bob # [ 6.106409] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1906bob # [ 6.107066] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1907alice # [ 6.115558] systemd[1]: Listening on Disk Repartitioning Service Socket.1908bob # [ 6.112494] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1909alice # [ 6.116151] systemd[1]: Listening on Resolve Monitor Varlink Socket.1910alice # [ 6.116567] systemd[1]: Listening on Resolve Service Varlink Socket.1911alice # [ 6.116923] systemd[1]: Listening on udev Control Socket.1912alice # [ 6.117272] systemd[1]: Listening on udev Varlink Socket.1913alice # [ 6.123363] systemd[1]: Mounting Huge Pages File System...1914alice # [ 6.126800] systemd[1]: Mounting POSIX Message Queue File System...1915alice # [ 6.139151] systemd[1]: Mounting Kernel Debug File System...1916bob # [ 6.141299] systemd[1]: Mounting FUSE Control File System...1917bob # [ 6.141800] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671918alice # [ 6.154823] systemd[1]: Mounting Kernel Trace File System...1919alice # [ 6.167138] systemd[1]: Starting Create List of Static Device Nodes...1920alice # [ 6.171155] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1921bob # [ 6.175656] systemd[1]: Starting Journal Service...1922alice # [ 6.183412] systemd[1]: Mounting Kernel Configuration File System...1923alice # [ 6.183965] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1924alice # [ 6.194233] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1925alice # [ 6.194863] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1926bob # [ 6.194212] systemd[1]: Starting Load Kernel Modules...1927bob # [ 6.210553] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1928alice # [ 6.223274] systemd[1]: Mounting FUSE Control File System...1929alice # [ 6.223789] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671930bob # [ 6.223485] systemd[1]: Starting Remount Root and Kernel File Systems...1931bob # [ 6.223975] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1932bob # [ 6.239291] systemd-journald[298]: Collecting audit messages is enabled.1933bob # [ 6.243059] systemd[1]: Starting Coldplug All udev Devices...1934bob # [ 6.245496] systemd[1]: Listening on Journal Log Access Socket.1935bob # [ 6.243451] systemd[1]: Queued start job for default target Multi-User System.1936bob # [ 6.246076] systemd[1]: systemd-journald.service: Deactivated successfully.1937alice # [ 6.251460] systemd[1]: Starting Journal Service...1938alice # [ 6.264555] systemd[1]: Starting Load Kernel Modules...1939clare # [ 6.320118] systemd[1]: Populated /etc with preset unit settings.1940bob # [ 6.280638] systemd[1]: Started Journal Service.1941alice # [ 6.286154] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1942bob # [ 6.282456] systemd[1]: Mounted Huge Pages File System.1943bob # [ 6.283195] systemd[1]: Mounted POSIX Message Queue File System.1944bob # [ 6.284335] systemd[1]: Mounted Kernel Debug File System.1945bob # [ 6.284926] systemd[1]: Mounted Kernel Trace File System.1946alice # [ 6.295654] systemd[1]: Starting Remount Root and Kernel File Systems...1947bob # [ 6.289943] systemd[1]: Finished Create List of Static Device Nodes.1948alice # [ 6.298623] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1949bob # [ 6.292604] systemd[1]: Mounted Kernel Configuration File System.1950bob # [ 6.314404] EXT4-fs (vda): re-mounted 41bf9fc3-1adf-4113-a234-8b17649c2d97.1951alice # [ 6.333020] systemd[1]: Starting Coldplug All udev Devices...1952bob # [ 6.327642] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1953bob # [ 6.330492] systemd[1]: Finished Remount Root and Kernel File Systems.1954alice # [ 6.339973] systemd[1]: Listening on Journal Log Access Socket.1955alice # [ 6.340579] systemd[1]: Mounted Huge Pages File System.1956alice # [ 6.341045] systemd[1]: Mounted POSIX Message Queue File System.1957alice # [ 6.341438] systemd[1]: Mounted Kernel Debug File System.1958alice # [ 6.341873] systemd[1]: Mounted Kernel Trace File System.1959bob # [ 6.336505] systemd[1]: Listening on Disk Image Download Service Socket.1960bob # [ 6.341230] systemd[1]: Starting Flush Journal to Persistent Storage...1961bob # [ 6.342573] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1962alice # [ 6.357026] systemd[1]: Finished Create List of Static Device Nodes.1963alice # [ 6.369107] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1964alice # [ 6.372009] systemd[1]: Mounted Kernel Configuration File System.1965bob # [ 6.364326] systemd[1]: Starting Load/Save OS Random Seed...1966bob # [ 6.365012] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1967bob # [ 6.376736] systemd-modules-load[300]: Module 'atkbd' is built in1968bob # [ 6.377501] systemd-modules-load[300]: Module 'loop' is built in1969alice # [ 6.402354] systemd-journald[280]: Collecting audit messages is enabled.1970bob # [ 6.397857] systemd[1]: Finished Load Kernel Modules.1971alice # [ 6.418597] systemd[1]: Queued start job for default target Multi-User System.1972alice # [ 6.426192] systemd[1]: Finished Load Kernel Modules.1973alice # [ 6.426906] systemd[1]: Started Journal Service.1974bob # [ 6.419433] systemd-oomd[301]: No swap; memory pressure usage will be degraded1975alice # [ 6.425330] systemd[1]: systemd-journald.service: Deactivated successfully.1976alice # [ 6.426243] systemd-modules-load[281]: Module 'atkbd' is built in1977alice # [ 6.426959] systemd-modules-load[281]: Module 'loop' is built in1978bob # [ 6.425695] systemd[1]: Starting Firewall...1979bob # [ 6.432289] systemd[1]: Starting Apply Kernel Variables...1980bob # [ 6.432961] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1981alice # [ 6.439606] systemd[1]: Starting Firewall...1982alice # [ 6.441570] systemd[1]: Starting Apply Kernel Variables...1983alice # [ 6.442191] systemd[1]: Mounted FUSE Control File System.1984alice # [ 6.453628] systemd-oomd[282]: No swap; memory pressure usage will be degraded1985alice # [ 6.462643] EXT4-fs (vda): re-mounted 2cc06c57-337d-4d8c-a551-a83915c7cb7b.1986bob # [ 6.459852] systemd[1]: Mounted FUSE Control File System.1987alice # [ 6.469714] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1988alice # [ 6.479973] systemd[1]: Finished Remount Root and Kernel File Systems.1989clare # [ 6.529002] systemd[1]: initrd-switch-root.service: Deactivated successfully.1990clare # [ 6.531323] systemd[1]: Stopped initrd-switch-root.service.1991clare # [ 6.533468] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1992clare # [ 6.534717] systemd[1]: Created slice Slice /system/getty.1993clare # [ 6.535591] systemd[1]: Created slice User and Session Slice.1994clare # [ 6.536025] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1995clare # [ 6.536403] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1996clare # [ 6.536728] systemd[1]: Expecting device /dev/hvc0...1997clare # [ 6.536999] systemd[1]: Expecting device /dev/ttyAMA0...1998bob # [ 6.493244] systemd-journald[298]: Received client request to flush runtime journal.1999clare # [ 6.541635] systemd[1]: Reached target Local Encrypted Volumes.2000clare # [ 6.542434] systemd[1]: Stopped target initrd-fs.target.2001clare # [ 6.543099] systemd[1]: Stopped target initrd-root-fs.target.2002clare # [ 6.543777] systemd[1]: Stopped target initrd-switch-root.target.2003clare # [ 6.544455] systemd[1]: Reached target Virtual Machines and Containers.2004clare # [ 6.545089] systemd[1]: Reached target Path Units.2005clare # [ 6.548980] systemd[1]: Reached target Remote File Systems.2006clare # [ 6.550865] systemd[1]: Reached target Slice Units.2007clare # [ 6.551424] systemd[1]: Reached target Swaps.2008alice # [ 6.507179] systemd[1]: Listening on Disk Image Download Service Socket.2009clare # [ 6.554873] systemd[1]: Listening on Query the User Interactively for a Password.2010clare # [ 6.558020] systemd[1]: Listening on Process Core Dump Socket.2011clare # [ 6.560090] systemd[1]: Listening on Credential Encryption/Decryption.2012clare # [ 6.563199] systemd[1]: Listening on Factory Reset Management.2013clare # [ 6.563910] systemd[1]: Listening on Hostname Service Socket.2014alice # [ 6.520227] systemd[1]: Starting Flush Journal to Persistent Storage...2015alice # [ 6.520936] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2016clare # [ 6.568183] systemd[1]: Starting Journal Log Access Socket...2017clare # [ 6.570671] systemd[1]: Listening on Journal Audit Socket.2018alice # [ 6.529836] systemd[1]: Starting Load/Save OS Random Seed...2019clare # [ 6.573846] systemd[1]: Listening on Console Output Muting Service Socket.2020clare # [ 6.574560] systemd[1]: Listening on Network Management Metrics Varlink Socket.2021alice # [ 6.530520] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2022clare # [ 6.575076] systemd[1]: Listening on Network Management Varlink Socket.2023clare # [ 6.575543] systemd[1]: Listening on Network Management Netlink Socket.2024clare # [ 6.576061] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2025clare # [ 6.576418] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2026clare # [ 6.576681] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2027clare # [ 6.586841] systemd[1]: Listening on Disk Repartitioning Service Socket.2028clare # [ 6.587573] systemd[1]: Listening on Resolve Monitor Varlink Socket.2029clare # [ 6.588378] systemd[1]: Listening on Resolve Service Varlink Socket.2030clare # [ 6.589024] systemd[1]: Listening on udev Control Socket.2031clare # [ 6.591618] systemd[1]: Listening on udev Varlink Socket.2032clare # [ 6.595036] systemd[1]: Mounting Huge Pages File System...2033clare # [ 6.599023] systemd[1]: Mounting POSIX Message Queue File System...2034bob # [ 6.552748] systemd[1]: Finished Load/Save OS Random Seed.2035bob # [ 6.553418] systemd[1]: Reached target First Boot Complete.2036clare # [ 6.610170] systemd[1]: Mounting Kernel Debug File System...2037bob # [ 6.561340] systemd[1]: Finished Flush Journal to Persistent Storage.2038clare # [ 6.614131] systemd[1]: Mounting Kernel Trace File System...2039clare # [ 6.632979] systemd[1]: Starting Create List of Static Device Nodes...2040clare # [ 6.634877] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2041bob # [ 6.595571] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2042clare # [ 6.648972] systemd[1]: Mounting Kernel Configuration File System...2043clare # [ 6.653390] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2044clare # [ 6.654676] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2045bob # [ 6.605368] systemd[1]: Starting Create Static Device Nodes in /dev...2046clare # [ 6.655233] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2047alice # [ 6.613927] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2048alice # [ 6.632544] systemd-journald[280]: Received client request to flush runtime journal.2049bob # [ 6.636697] systemd[1]: Finished Apply Kernel Variables.2050clare # [ 6.690235] systemd[1]: Mounting FUSE Control File System...2051clare # [ 6.690702] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672052bob # [ 6.645229] systemd[1]: Starting Network Name Resolution...2053clare # [ 6.714402] systemd[1]: Starting Journal Service...2054clare # [ 6.733465] systemd[1]: Starting Load Kernel Modules...2055alice # [ 6.692539] systemd[1]: Starting Create Static Device Nodes in /dev...2056alice # [ 6.693566] systemd[1]: Finished Load/Save OS Random Seed.2057alice # [ 6.694209] systemd[1]: Reached target First Boot Complete.2058alice # [ 6.694737] systemd[1]: Finished Apply Kernel Variables.2059alice # [ 6.704673] systemd[1]: Starting Network Name Resolution...2060alice # [ 6.705500] systemd[1]: Finished Flush Journal to Persistent Storage.2061clare # [ 6.752946] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2062clare # [ 6.773010] systemd[1]: Starting Remount Root and Kernel File Systems...2063clare # [ 6.775537] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2064clare # [ 6.801523] systemd[1]: Starting Coldplug All udev Devices...2065clare # [ 6.803865] systemd[1]: Listening on Journal Log Access Socket.2066clare # [ 6.804442] systemd[1]: Mounted Huge Pages File System.2067clare # [ 6.804893] systemd[1]: Mounted POSIX Message Queue File System.2068clare # [ 6.818117] systemd[1]: Mounted Kernel Debug File System.2069clare # [ 6.818708] systemd[1]: Mounted Kernel Trace File System.2070clare # [ 6.822839] systemd[1]: Finished Create List of Static Device Nodes.2071clare # [ 6.842609] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2072clare # [ 6.846934] systemd-journald[283]: Collecting audit messages is enabled.2073clare # [ 6.854184] systemd[1]: Finished Load Kernel Modules.2074clare # [ 6.866792] systemd[1]: Queued start job for default target Multi-User System.2075clare # [ 6.868774] systemd[1]: systemd-journald.service: Deactivated successfully.2076clare # [ 6.869663] systemd-modules-load[284]: Module 'atkbd' is built in2077clare # [ 6.870349] systemd-modules-load[284]: Module 'loop' is built in2078clare # [ 6.880299] systemd[1]: Starting Firewall...2079bob # [ 6.837980] systemd-resolved[329]: Positive Trust Anchors:2080bob # [ 6.838631] systemd-resolved[329]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2081bob # [ 6.839513] systemd-resolved[329]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162082bob # [ 6.841068] systemd-resolved[329]: 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 test2083clare # [ 6.895044] systemd-oomd[285]: No swap; memory pressure usage will be degraded2084clare # [ 6.905104] systemd[1]: Starting Apply Kernel Variables...2085clare # [ 6.907501] systemd[1]: Started Journal Service.2086clare # [ 6.910624] EXT4-fs (vda): re-mounted 4d5b4875-2f59-41b0-b3d1-06233bd2744a.2087alice # [ 6.873096] systemd-resolved[312]: Positive Trust Anchors:2088alice # [ 6.873807] systemd-resolved[312]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2089alice # [ 6.874643] systemd-resolved[312]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162090clare # [ 6.917610] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2091alice # [ 6.875487] systemd-resolved[312]: 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 test2092bob # [ 6.877735] systemd[1]: Finished Create Static Device Nodes in /dev.2093clare # [ 6.925282] systemd[1]: Mounted FUSE Control File System.2094bob # [ 6.885356] systemd[1]: Reached target Preparation for Local File Systems.2095bob # [ 6.887890] systemd[1]: Starting Rule-based Manager for Device Events and Files...2096clare # [ 6.935304] systemd[1]: Mounted Kernel Configuration File System.2097clare # [ 6.949208] systemd[1]: Finished Remount Root and Kernel File Systems.2098alice # [ 6.917197] systemd[1]: Finished Create Static Device Nodes in /dev.2099alice # [ 6.918170] systemd[1]: Reached target Preparation for Local File Systems.2100alice # [ 6.927766] systemd[1]: Starting Rule-based Manager for Device Events and Files...2101clare # [ 6.976742] systemd[1]: Listening on Disk Image Download Service Socket.2102clare # [ 6.982453] systemd[1]: Starting Flush Journal to Persistent Storage...2103clare # [ 6.983201] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2104bob # [ 6.940596] systemd[1]: Finished Coldplug All udev Devices.2105clare # [ 6.991715] systemd[1]: Starting Load/Save OS Random Seed...2106clare # [ 6.992667] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2107bob # [ 6.977700] systemd[1]: Mounting /run/wrappers...2108bob # [ 7.015324] systemd-resolved[329]: Using system hostname 'bob'.2109bob # [ 7.019314] systemd[1]: Started Network Name Resolution.2110bob # [ 7.034601] systemd[1]: Mounted /run/wrappers.2111bob # [ 7.035805] systemd[1]: Reached target Local File Systems.2112bob # [ 7.042384] systemd[1]: Listening on Boot Loader Control Service Socket.2113bob # [ 7.046867] systemd[1]: Starting register-nix-paths.service...2114clare # [ 7.104274] systemd-journald[283]: Received client request to flush runtime journal.2115alice # [ 7.056957] systemd[1]: Mounting /run/wrappers...2116bob # [ 7.058321] systemd-udevd[335]: Using default interface naming scheme 'v261'.2117bob # [ 7.059573] systemd[1]: Starting Create SUID/SGID Wrappers...2118bob # [ 7.061976] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2119bob # [ 7.074835] systemd[1]: Starting Save Transient machine-id to Disk...2120alice # [ 7.082704] systemd-resolved[312]: Using system hostname 'alice'.2121alice # [ 7.086750] systemd[1]: Started Network Name Resolution.2122bob # [ 7.089104] systemd[1]: Starting Create System Files and Directories...2123alice # [ 7.105204] systemd[1]: Finished Coldplug All udev Devices.2124clare # [ 7.165280] systemd[1]: Finished Load/Save OS Random Seed.2125clare # [ 7.166089] systemd[1]: Reached target First Boot Complete.2126clare # [ 7.166627] systemd[1]: Finished Apply Kernel Variables.2127clare # [ 7.167187] systemd[1]: Starting Network Name Resolution...2128clare # [ 7.167711] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2129alice # [ 7.127051] systemd[1]: Mounted /run/wrappers.2130alice # [ 7.128474] systemd[1]: Reached target Local File Systems.2131alice # [ 7.131105] systemd-udevd[319]: Using default interface naming scheme 'v261'.2132alice # [ 7.134456] systemd[1]: Listening on Boot Loader Control Service Socket.2133clare # [ 7.180617] systemd[1]: Starting Create Static Device Nodes in /dev...2134alice # [ 7.139352] systemd[1]: Starting register-nix-paths.service...2135clare # [ 7.183805] systemd[1]: Finished Flush Journal to Persistent Storage.2136alice # [ 7.144300] systemd[1]: Starting Create SUID/SGID Wrappers...2137alice # [ 7.145008] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2138alice # [ 7.170140] systemd[1]: Starting Save Transient machine-id to Disk...2139alice # [ 7.177852] systemd[1]: Starting Create System Files and Directories...2140bob # [ 7.210312] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2141bob # [ 7.217339] systemd[1]: Finished Save Transient machine-id to Disk.2142bob # [ 7.242386] systemd[1]: Started Rule-based Manager for Device Events and Files.2143bob # [ 7.275319] systemd[1]: Finished Create System Files and Directories.2144clare # [ 7.332860] systemd-resolved[311]: Positive Trust Anchors:2145clare # [ 7.333986] systemd-resolved[311]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2146bob # [ 7.287862] systemd[1]: Starting Rebuild Journal Catalog...2147clare # [ 7.334968] systemd-resolved[311]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162148clare # [ 7.335829] systemd-resolved[311]: 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 test2149bob # [ 7.294142] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2150alice # [ 7.299592] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2151alice # [ 7.316248] systemd[1]: Finished Save Transient machine-id to Disk.2152alice # [ 7.316992] systemd[1]: Started Rule-based Manager for Device Events and Files.2153clare # [ 7.381932] systemd[1]: Finished Create Static Device Nodes in /dev.2154clare # [ 7.384682] systemd[1]: Reached target Preparation for Local File Systems.2155clare # [ 7.392356] systemd[1]: Starting Rule-based Manager for Device Events and Files...2156alice # [ 7.354224] systemd[1]: Finished Create System Files and Directories.2157alice # [ 7.366540] systemd[1]: Starting Rebuild Journal Catalog...2158alice # [ 7.374075] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2159bob # [ 7.415504] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2160clare # [ 7.510418] systemd-resolved[311]: Using system hostname 'clare'.2161clare # [ 7.514107] systemd[1]: Started Network Name Resolution.2162bob # [ 7.468061] systemd[1]: Finished Rebuild Journal Catalog.2163bob # [ 7.479261] systemd[1]: Starting Update is Completed...2164clare # [ 7.531993] systemd[1]: Mounting /run/wrappers...2165alice # [ 7.501043] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2166clare # [ 7.561260] systemd-udevd[323]: Using default interface naming scheme 'v261'.2167alice # [ 7.539455] systemd[1]: Finished Rebuild Journal Catalog.2168alice # [ 7.546235] systemd[1]: Starting Update is Completed...2169clare # [ 7.595138] systemd[1]: Mounted /run/wrappers.2170clare # [ 7.595717] systemd[1]: Reached target Local File Systems.2171clare # [ 7.603614] systemd[1]: Listening on Boot Loader Control Service Socket.2172clare # [ 7.610277] systemd[1]: Starting register-nix-paths.service...2173bob # [ 7.565596] systemd[1]: Finished Update is Completed.2174clare # [ 7.618144] systemd[1]: Starting Create SUID/SGID Wrappers...2175clare # [ 7.618819] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2176clare # [ 7.625842] systemd[1]: Starting Save Transient machine-id to Disk...2177clare # [ 7.650166] systemd[1]: Starting Create System Files and Directories...2178clare # [ 7.662071] systemd[1]: Finished Coldplug All udev Devices.2179alice # [ 7.626059] systemd[1]: Finished Update is Completed.2180alice # [ 7.658592] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2181bob # [ 7.661674] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2182bob # [ 7.700784] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2183alice # [ 7.726728] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2184clare # [ 7.787195] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2185clare # [ 7.800210] systemd[1]: Started Rule-based Manager for Device Events and Files.2186clare # [ 7.804884] systemd[1]: Finished Save Transient machine-id to Disk.2187clare # [ 7.820436] systemd[1]: Finished Create System Files and Directories.2188clare # [ 7.835453] systemd[1]: Starting Rebuild Journal Catalog...2189clare # [ 7.840572] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2190bob # [ 7.903652] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2191clare # [ 7.992912] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2192clare # [ 8.021016] systemd[1]: Finished Rebuild Journal Catalog.2193clare # [ 8.030372] systemd[1]: Starting Update is Completed...2194bob # [ 7.990392] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2195alice # [ 8.008412] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2196clare # [ 8.098800] systemd[1]: Finished Update is Completed.2197alice # [ 8.090615] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2198bob # [ 8.210480] (udev-worker)[393]: Network interface NamePolicy= disabled on kernel command line.2199bob # [ 8.214068] (udev-worker)[405]: Network interface NamePolicy= disabled on kernel command line.2200bob # [ 8.223283] systemd[1]: Finished register-nix-paths.service.2201alice # [ 8.247549] systemd[1]: Finished register-nix-paths.service.2202clare # [ 8.295580] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2203bob # [ 8.255250] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2204bob # [ 8.260172] systemd[1]: Finished Create SUID/SGID Wrappers.2205bob # [ 8.260878] systemd[1]: Reached target System Initialization.2206bob # [ 8.261476] systemd[1]: Started Discard unused filesystem blocks once a week.2207bob # [ 8.262168] systemd[1]: Started Daily Cleanup of Temporary Directories.2208bob # [ 8.262816] systemd[1]: Reached target Timer Units.2209bob # [ 8.271736] systemd[1]: Listening on D-Bus System Message Bus Socket.2210bob # [ 8.273644] systemd[1]: Listening on Nix Daemon Socket.2211bob # [ 8.274200] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2212bob # [ 8.274995] systemd[1]: Reached target Socket Units.2213bob # [ 8.275513] systemd[1]: Reached target Basic System.2214alice # [ 8.285599] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2215bob # [ 8.282290] systemd[1]: Started backdoor.service.2216bob # [ 8.282935] systemd[1]: Starting Import lastlog data into lastlog2 database...2217alice # [ 8.288329] systemd[1]: Finished Create SUID/SGID Wrappers.2218alice # [ 8.291336] systemd[1]: Reached target System Initialization.2219bob # [ 8.287763] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2220alice # [ 8.295574] systemd[1]: Started Discard unused filesystem blocks once a week.2221alice # [ 8.297692] systemd[1]: Started Daily Cleanup of Temporary Directories.2222alice # [ 8.298339] systemd[1]: Reached target Timer Units.2223alice # [ 8.298803] systemd[1]: Listening on D-Bus System Message Bus Socket.2224alice # [ 8.299356] systemd[1]: Listening on Nix Daemon Socket.2225alice # [ 8.299820] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2226bob # [ 8.297343] systemd[1]: Starting Post-Boot Actions...2227clare # [ 8.348869] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2228alice # [ 8.307024] systemd[1]: Reached target Socket Units.2229alice # [ 8.307570] systemd[1]: Reached target Basic System.2230alice # [ 8.311146] systemd[1]: Started backdoor.service.2231alice # [ 8.313736] systemd[1]: Starting Import lastlog data into lastlog2 database...2232alice # [ 8.324145] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2233bob # [ 8.321744] systemd[1]: Started Reset console on configuration changes.2234alice # [ 8.341120] systemd[1]: Starting Post-Boot Actions...2235alice # [ 8.351305] (udev-worker)[382]: Network interface NamePolicy= disabled on kernel command line.2236alice # [ 8.366103] systemd[1]: Started Reset console on configuration changes.2237alice # [ 8.395217] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line.2238bob # [ 8.407484] systemd[1]: Starting D-Bus System Message Bus...2239alice # [ 8.423363] systemd[1]: Starting D-Bus System Message Bus...2240bob # connecting to host...2241bob # [ 8.486708] systemd[1]: Finished Post-Boot Actions.2242clare # [ 8.533360] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2243alice # connecting to host...2244bob # [ 8.511459] systemd[1]: Started Name Service Cache Daemon (nsncd).2245bob # [ 8.514399] systemd[1]: Reached target Host and Network Name Lookups.2246bob # [ 8.515326] nsncd[476]: Oct 14 20:03:47.337 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2247alice # [ 8.530567] systemd[1]: Finished Post-Boot Actions.2248bob # [ 8.530515] systemd[1]: Reached target User and Group Name Lookups.2249clare # [ 8.577856] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2250bob # [ 8.535845] systemd[1]: Starting User Login Management...2251alice # [ 8.551836] systemd[1]: Started Name Service Cache Daemon (nsncd).2252alice # [ 8.555062] systemd[1]: Reached target Host and Network Name Lookups.2253alice # [ 8.555956] nsncd[458]: Oct 14 20:03:47.358 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2254alice # [ 8.569945] systemd[1]: Reached target User and Group Name Lookups.2255bob: Guest shell says: b'Spawning backdoor root shell...\n'2256alice # [ 8.574209] systemd[1]: Starting User Login Management...2257bob # [ 8.589405] systemd[1]: Finished Import lastlog data into lastlog2 database.2258alice # [ 8.621446] systemd[1]: Finished Import lastlog data into lastlog2 database.2259bob: connected to guest root shell2260bob: (connecting took 8.89 seconds)2261bob: (finished: waiting for the VM to finish booting, in 8.89 seconds)2262clare # [ 8.717937] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2263clare # [ 8.722847] systemd[1]: Finished Create SUID/SGID Wrappers.2264bob # [ 8.699692] dbus-broker-launch[487]: Looking up NSS user entry for 'systemd-timesync'...2265clare # [ 8.748224] systemd[1]: Finished register-nix-paths.service.2266clare # [ 8.748909] systemd[1]: Reached target System Initialization.2267clare # [ 8.749440] systemd[1]: Started Discard unused filesystem blocks once a week.2268clare # [ 8.750044] systemd[1]: Started Daily Cleanup of Temporary Directories.2269clare # [ 8.750603] systemd[1]: Reached target Timer Units.2270bob # [ 8.706933] systemd-logind[495]: Watching system buttons on /dev/input/event0 (gpio-keys)2271bob # [ 8.711126] systemd-logind[495]: New seat seat0.2272clare # [ 8.760274] systemd[1]: Listening on D-Bus System Message Bus Socket.2273clare # [ 8.760981] systemd[1]: Listening on harmonia binary cache socket.2274clare # [ 8.761524] systemd[1]: Listening on Nix Daemon Socket.2275clare # [ 8.762001] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2276clare # [ 8.762704] systemd[1]: Reached target Socket Units.2277clare # [ 8.763187] systemd[1]: Reached target Basic System.2278bob # [ 8.716345] systemd[1]: Started User Login Management.2279clare # [ 8.763894] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line.2280bob # [ 8.721103] systemd[1]: Starting linger-users.service...2281bob # [ 8.721706] dbus-broker-launch[487]: NSS returned no entry for 'systemd-timesync'2282bob # [ 8.722308] dbus-broker-launch[487]: Invalid user-name in /nix/store/1n1m956aayck8lzlfcpgz5j951b941w3-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2283clare # [ 8.773298] systemd[1]: Started backdoor.service.2284alice # [ 8.731334] systemd-logind[478]: Watching system buttons on /dev/input/event0 (gpio-keys)2285clare # [ 8.773831] systemd[1]: Starting Import lastlog data into lastlog2 database...2286alice # [ 8.733902] systemd-logind[478]: New seat seat0.2287clare # [ 8.779522] (udev-worker)[402]: Network interface NamePolicy= disabled on kernel command line.2288alice # [ 8.738320] dbus-broker-launch[465]: Looking up NSS user entry for 'systemd-timesync'...2289clare # [ 8.780707] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2290alice # [ 8.743061] systemd[1]: Started User Login Management.2291alice # [ 8.748916] systemd[1]: Starting linger-users.service...2292alice # [ 8.753015] dbus-broker-launch[465]: NSS returned no entry for 'systemd-timesync'2293alice # [ 8.753777] dbus-broker-launch[465]: Invalid user-name in /nix/store/fw8zafkw97d3ikcjlws1jwnwvgl2zxyz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2294clare # [ 8.812958] systemd[1]: Starting Post-Boot Actions...2295bob # [ 8.782339] systemd[1]: Started D-Bus System Message Bus.2296clare # [ 8.833079] systemd[1]: Started Reset console on configuration changes.2297alice # [ 8.800141] systemd[1]: Started D-Bus System Message Bus.2298bob # [ 8.819376] systemd[1]: linger-users.service: Deactivated successfully.2299bob # [ 8.825406] systemd[1]: Finished linger-users.service.2300alice # [ 8.834666] systemd[1]: linger-users.service: Deactivated successfully.2301alice # [ 8.838597] dbus-broker-launch[465]: Ready2302alice # [ 8.839135] systemd[1]: Finished linger-users.service.2303bob # [ 8.834522] dbus-broker-launch[487]: Ready2304alice # [ 8.864134] mousedev: PS/2 mouse device common for all mice2305clare # [ 8.904860] systemd[1]: Starting D-Bus System Message Bus...2306bob # [ 8.868011] mousedev: PS/2 mouse device common for all mice2307clare # connecting to host...2308bob # [ 8.890923] systemd-logind[495]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2309alice # [ 8.915289] systemd-logind[478]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2310clare # [ 8.974522] systemd[1]: Started Name Service Cache Daemon (nsncd).2311clare # [ 8.980337] systemd[1]: Reached target Host and Network Name Lookups.2312clare # [ 8.981287] nsncd[467]: Oct 14 20:03:47.792 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2313clare # [ 8.982588] systemd[1]: Reached target User and Group Name Lookups.2314clare # [ 9.003873] systemd[1]: Starting User Login Management...2315clare # [ 9.035900] systemd[1]: Finished Post-Boot Actions.2316clare # [ 9.085002] systemd[1]: Finished Import lastlog data into lastlog2 database.2317clare # [ 9.110052] dbus-broker-launch[473]: Looking up NSS user entry for 'systemd-timesync'...2318clare # [ 9.128354] dbus-broker-launch[473]: NSS returned no entry for 'systemd-timesync'2319clare # [ 9.129100] dbus-broker-launch[473]: Invalid user-name in /nix/store/i93zg9gq7f614x42cnzk9ahs5xlj4ixc-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2320alice # [ 9.095598] systemd[1]: Finished Firewall.2321alice # [ 9.098805] systemd[1]: Reached target Preparation for Network.2322alice # [ 9.099432] systemd[1]: Listening on Network Management Resolve Hook Socket.2323alice # [ 9.105227] systemd[1]: Starting Network Management...2324clare # [ 9.185993] systemd[1]: Started D-Bus System Message Bus.2325clare # [ 9.192378] systemd-logind[494]: New seat seat0.2326bob # [ 9.147310] systemd[1]: Finished Firewall.2327bob # [ 9.150647] systemd[1]: Reached target Preparation for Network.2328bob # [ 9.151310] systemd[1]: Listening on Network Management Resolve Hook Socket.2329clare # [ 9.199155] systemd[1]: Started User Login Management.2330clare # [ 9.202136] systemd[1]: Starting linger-users.service...2331bob # [ 9.156423] systemd[1]: Starting Network Management...2332clare # [ 9.227521] systemd-logind[494]: Watching system buttons on /dev/input/event0 (gpio-keys)2333clare # [ 9.231488] dbus-broker-launch[473]: Ready2334clare # [ 9.276410] systemd[1]: linger-users.service: Deactivated successfully.2335clare # [ 9.278530] systemd[1]: Finished linger-users.service.2336clare # [ 9.333359] mousedev: PS/2 mouse device common for all mice2337alice # [ 9.299858] cfg80211: Loading compiled-in X.509 certificates for regulatory database2338clare # [ 9.350936] systemd-logind[494]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2339bob # [ 9.345307] cfg80211: Loading compiled-in X.509 certificates for regulatory database2340alice # [ 9.350942] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2341alice # [ 9.351549] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2342alice # [ 9.353273] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22343alice # [ 9.353671] cfg80211: failed to load regulatory.db2344alice # [ 9.386489] systemd-networkd[537]: lo: Link UP2345alice # [ 9.388183] systemd-networkd[537]: lo: Gained carrier2346bob # [ 9.392275] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2347bob # [ 9.392809] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2348alice # [ 9.395729] systemd-networkd[537]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2349bob # [ 9.396377] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22350bob # [ 9.396801] cfg80211: failed to load regulatory.db2351alice # [ 9.403107] systemd[1]: Started Network Management.2352alice # [ 9.403621] systemd[1]: Reached target Network.2353clare # [ 9.448421] systemd[1]: Finished Firewall.2354clare # [ 9.448967] systemd[1]: Reached target Preparation for Network.2355clare # [ 9.449477] systemd[1]: Listening on Network Management Resolve Hook Socket.2356alice # [ 9.407406] systemd-networkd[537]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2357clare # [ 9.453876] systemd[1]: Starting Network Management...2358alice # [ 9.413599] systemd-networkd[537]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2359alice # [ 9.414578] systemd-networkd[537]: eth0: Link UP2360alice # [ 9.415029] systemd-networkd[537]: eth0: Gained carrier2361alice # [ 9.421042] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2362alice # [ 9.423682] systemd-networkd[537]: eth1: Link UP2363alice # [ 9.428708] systemd-networkd[537]: eth1: Gained carrier2364bob # [ 9.424735] systemd-networkd[564]: lo: Link UP2365alice # [ 9.429255] systemd-networkd[537]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2366alice # [ 9.430546] systemd[1]: Starting Permit User Sessions...2367bob # [ 9.425251] systemd-networkd[564]: lo: Gained carrier2368bob # [ 9.433904] systemd[1]: Started Network Management.2369alice # [ 9.438486] systemd-networkd[537]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22370bob # [ 9.440174] systemd[1]: Reached target Network.2371bob # [ 9.440711] systemd[1]: Reached target Network is Online.2372bob # [ 9.441202] systemd-networkd[564]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2373bob # [ 9.442479] systemd-networkd[564]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2374bob # [ 9.453819] systemd-networkd[564]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2375bob # [ 9.454792] systemd-networkd[564]: eth1: Link UP2376bob # [ 9.455200] systemd-networkd[564]: eth1: Gained carrier2377bob # [ 9.455620] systemd-networkd[564]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2378bob # [ 9.466704] systemd[1]: Starting ncps binary cache proxy service...2379bob # [ 9.467354] systemd-networkd[564]: eth0: Link UP2380bob # [ 9.467770] systemd-networkd[564]: eth0: Gained carrier2381bob # [ 9.473355] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2382bob # [ 9.474090] systemd-networkd[564]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22383bob # [ 9.478595] systemd[1]: Starting Permit User Sessions...2384alice # [ 9.493299] systemd[1]: Finished Permit User Sessions.2385alice # [ 9.504600] systemd[1]: Started Getty on tty1.2386alice # [ 9.505138] systemd[1]: Reached target Login Prompts.2387alice # [ 9.505609] systemd[1]: Reached target Multi-User System.2388alice # [ 9.511295] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2389alice # [ 9.513905] systemd[1]: Startup finished in 743ms (kernel) + 4.086s (initrd) + 4.682s (userspace) = 9.512s.2390bob # [ 9.567401] systemd[1]: Finished Permit User Sessions.2391bob # [ 9.588280] systemd[1]: Started Getty on tty1.2392bob # [ 9.588857] systemd[1]: Reached target Login Prompts.2393clare # [ 9.641068] cfg80211: Loading compiled-in X.509 certificates for regulatory database2394bob # [ 9.598931] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2395bob # [ 9.631491] ncps-pre-start[571]: /nix/store/p49967wmhfqb4q80dmlvzyhgpxfj3940-ncps-0.9.4/bin/dbmate-ncps up2396clare # [ 9.685472] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2397clare # [ 9.685998] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2398clare # [ 9.687408] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22399clare # [ 9.687796] cfg80211: failed to load regulatory.db2400clare # [ 9.721016] systemd-networkd[542]: lo: Link UP2401clare # [ 9.721570] systemd-networkd[542]: lo: Gained carrier2402clare # [ 9.728171] systemd[1]: Started Network Management.2403clare # [ 9.728736] systemd[1]: Reached target Network.2404clare # [ 9.733415] systemd-networkd[542]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2405clare # [ 9.739944] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2406clare # [ 9.743982] systemd-networkd[542]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2407clare # [ 9.746540] systemd-networkd[542]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2408clare # [ 9.747320] systemd-networkd[542]: eth0: Link UP2409clare # [ 9.747792] systemd-networkd[542]: eth0: Gained carrier2410clare # [ 9.758853] systemd[1]: Starting Permit User Sessions...2411clare # [ 9.759479] systemd-networkd[542]: eth1: Link UP2412clare # [ 9.759920] systemd-networkd[542]: eth1: Gained carrier2413clare # [ 9.764449] systemd-networkd[542]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2414clare # [ 9.770618] systemd-networkd[542]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22415alice # [ 9.739249] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32416clare # [ 9.824332] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2417clare # [ 9.833345] systemd[1]: Finished Permit User Sessions.2418clare # [ 9.839459] systemd[1]: Started Getty on tty1.2419clare # [ 9.841510] systemd[1]: Reached target Login Prompts.2420bob # [ 9.801599] ncps-pre-start[586]: Creating: /var/lib/ncps/db/db.sqlite2421clare # [ 9.848475] systemd[1]: Reached target Multi-User System.2422clare # [ 9.851016] systemd[1]: Startup finished in 766ms (kernel) + 4.659s (initrd) + 4.425s (userspace) = 9.850s.2423bob # [ 9.822044] ncps-pre-start[586]: Applying: 20241210054814_create-narinfos-table.sql2424bob # [ 9.829279] ncps-pre-start[586]: Applied: 20241210054814_create-narinfos-table.sql in 7.20568ms2425bob # [ 9.831841] ncps-pre-start[586]: Applying: 20241210054829_create-nars-table.sql2426bob # [ 9.837078] ncps-pre-start[586]: Applied: 20241210054829_create-nars-table.sql in 7.74724ms2427bob # [ 9.837853] ncps-pre-start[586]: Applying: 20241213014846_add-query-to-nars-table.sql2428bob # [ 9.847471] ncps-pre-start[586]: Applied: 20241213014846_add-query-to-nars-table.sql in 10.40452ms2429bob # [ 9.852163] ncps-pre-start[586]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2430bob # [ 9.857569] ncps-pre-start[586]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 10.15636ms2431bob # [ 9.860315] ncps-pre-start[586]: Applying: 20260101000000_add-config-table.sql2432bob # [ 9.864885] ncps-pre-start[586]: Applied: 20260101000000_add-config-table.sql in 6.28844ms2433bob # [ 9.867460] ncps-pre-start[586]: Applying: 20260105025735_remove-redundant-indexes.sql2434bob # [ 9.871103] ncps-pre-start[586]: Applied: 20260105025735_remove-redundant-indexes.sql in 6.20096ms2435bob # [ 9.871974] ncps-pre-start[586]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2436bob # [ 9.881122] ncps-pre-start[586]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 9.6068ms2437bob # [ 9.881993] ncps-pre-start[586]: Applying: 20260117195000_add_narinfo_de_normalized.sql2438bob # [ 9.894190] ncps-pre-start[586]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 12.89004ms2439bob # [ 9.895009] ncps-pre-start[586]: Applying: 20260127223000_allow_multiple_nar_representations.sql2440bob # [ 9.909584] ncps-pre-start[586]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 14.73164ms2441bob # [ 9.910464] ncps-pre-start[586]: Applying: 20260131021850_add_chunks.sql2442bob # [ 9.915682] ncps-pre-start[586]: Applied: 20260131021850_add_chunks.sql in 7.2422ms2443bob # [ 9.918848] ncps-pre-start[586]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2444bob # [ 9.929447] ncps-pre-start[586]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 12.97444ms2445bob # [ 9.932516] ncps-pre-start[586]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2446bob # [ 9.937543] ncps-pre-start[586]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 8.82376ms2447bob # [ 9.938428] ncps-pre-start[586]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2448bob # [ 9.950973] ncps-pre-start[586]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 11.432ms2449bob # [ 10.054384] systemd[1]: Started ncps binary cache proxy service.2450bob # [ 10.056915] systemd[1]: Reached target Multi-User System.2451bob # [ 10.059955] systemd[1]: Startup finished in 728ms (kernel) + 4.100s (initrd) + 5.229s (userspace) = 10.058s.2452alice # [ 10.066864] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2453alice # [ 10.072211] systemd[1]: Starting Virtual Console Setup...2454clare # [ 10.132023] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32455alice # [ 10.090527] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2456alice # [ 10.094107] systemd[1]: Stopped Virtual Console Setup.2457alice # [ 10.100485] systemd-logind[478]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2458alice # [ 10.103703] systemd[1]: Starting Virtual Console Setup...2459alice # [ 10.210668] systemd-vconsole-setup[556]: Configuration of first virtual console was skipped, ignoring remaining ones.2460alice # [ 10.213757] systemd[1]: Finished Virtual Console Setup.2461bob # [ 10.227955] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32462bob # [ 10.347694] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","log_level":"info","time":"2026-10-14T20:03:49Z","message":"logger created"}2463bob # [ 10.352557] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","xz-binary-path":"/nix/store/csrwf31hprwghnbyiglxa3p787lgrl67-xz-5.8.4-bin/bin/xz","time":"2026-10-14T20:03:49Z","message":"Using xz binary for xz decompression"}2464bob # [ 10.359011] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-10-14T20:03:49Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2465bob # [ 10.376660] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","time":"2026-10-14T20:03:49Z","message":"using local locks (single-instance mode)"}2466bob # [ 10.389936] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-14T20:03:49Z","message":"setting up tracer provider to discard traces"}2467bob # [ 10.395137] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-14T20:03:49Z","message":"setting up meter provider to discard metrics"}2468bob # [ 10.397769] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-14T20:03:49Z","message":"setting up logger provider to discard logs"}2469bob # [ 10.413871] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-10-14T20:03:49Z","message":"Reporting anonymous metrics to the project maintainers"}2470bob # [ 10.415469] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-10-14T20:03:49Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2471clare # [ 10.467487] systemd[1]: Starting Virtual Console Setup...2472bob # [ 10.424833] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-10-14T20:03:49Z","message":"using local storage"}2473clare # [ 10.478186] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2474clare # [ 10.484965] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2475clare # [ 10.485719] systemd[1]: Stopped Virtual Console Setup.2476clare # [ 10.491081] systemd[1]: Starting Virtual Console Setup...2477clare # [ 10.514134] systemd-logind[494]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2478clare # [ 10.520206] systemd[1]: Starting harmonia binary cache service...2479clare # [ 10.601719] harmonia-cache[562]: 2026-10-14T20:03:49.417541Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2480clare # [ 10.603956] harmonia-cache[562]: 2026-10-14T20:03:49.419532Z INFO actix_server::builder: starting 4 workers2481clare # [ 10.607185] harmonia-cache[562]: 2026-10-14T20:03:49.421545Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2482bob # [ 10.561685] systemd-networkd[564]: eth0: Gained IPv6LL2483clare # [ 10.610807] harmonia-cache[562]: 2026-10-14T20:03:49.421602Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2484clare # [ 10.612465] harmonia-cache[562]: 2026-10-14T20:03:49.421682Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002485clare # [ 10.615155] systemd[1]: Started harmonia binary cache service.2486bob # [ 10.584863] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-10-14T20:03:49Z","message":"upstream became healthy and is now available for requests"}2487bob # [ 10.586422] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-10-14T20:03:49Z","message":"Server started"}2488alice # [ 10.593589] systemd-networkd[537]: eth1: Gained IPv6LL2489clare # [ 10.688900] systemd-vconsole-setup[561]: Configuration of first virtual console was skipped, ignoring remaining ones.2490clare # [ 10.691877] systemd[1]: Finished Virtual Console Setup.2491bob # [ 10.664349] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2492bob # [ 10.671553] systemd[1]: Starting Virtual Console Setup...2493bob # [ 10.702453] systemd-logind[495]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2494bob # [ 10.791690] systemd-vconsole-setup[619]: Configuration of first virtual console was skipped, ignoring remaining ones.2495bob # [ 10.794475] systemd[1]: Finished Virtual Console Setup.2496bob # [ 10.978710] systemd-networkd[564]: eth1: Gained IPv6LL2497bob: (finished: waiting for unit ncps, in 11.30 seconds)2498bob: must succeed: systemctl status ncps2499bob: (finished: must succeed: systemctl status ncps, in 0.04 seconds)2500clare: waiting for unit harmonia.socket2501clare: waiting for the VM to finish booting2502clare: Guest shell says: b'Spawning backdoor root shell...\n'2503clare: connected to guest root shell2504clare: (connecting took 0.00 seconds)2505clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2506clare: (finished: waiting for unit harmonia.socket, in 0.06 seconds)2507alice: waiting for success: curl bob:8502/nix-cache-info2508alice: waiting for the VM to finish booting2509alice: Guest shell says: b'Spawning backdoor root shell...\n'2510alice: connected to guest root shell2511alice: (connecting took 0.00 seconds)2512alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2513alice # [ 11.234964] systemd-networkd[537]: eth0: Gained IPv6LL2514bob # [ 11.420302] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: 2026/10/14 20:03:50 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2515alice # % Total % Received % Xferd Average Speed Time Time Time Current2516alice # Dload Upload Total Spent Left Speed2517bob # [ 11.439324] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"192.168.1.1:51004","trace_id":"2669de29664d8315103dccd54e13a252","span_id":"61883b398caa88e5","status":200,"elapsed":0.05744,"bytes":50,"time":"2026-10-14T20:03:50Z","message":"handled request"}2518alice # 0 0 0 0 0 0 0 0 0100 50 100 50 0 0 198 0 0100 50 100 50 0 0 194 0 0100 50 100 50 0 0 191 0 02519alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 0.33 seconds)2520bob: waiting for success: curl clare:5000/nix-cache-info2521bob # % Total % Received % Xferd Average Speed Time Time Time Current2522bob # Dload Upload Total Spent Left Speed2523clare # [ 11.587536] systemd-networkd[542]: eth0: Gained IPv6LL2524bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 4192 0 0100 51 100 51 0 0 3466 0 0100 51 100 51 0 0 2991 0 02525bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.09 seconds)2526clare: waiting for unit harmonia2527clare: (finished: waiting for unit harmonia, in 0.07 seconds)2528clare: must succeed: systemctl status harmonia2529clare: (finished: must succeed: systemctl status harmonia, in 0.04 seconds)2530clare: must succeed: nix-build --expr '2531 builtins.derivation {2532 name = "hi";2533 builder = "/bin/sh";2534 args = [ "-c" "echo hi > $out" ];2535 system = "aarch64-linux";2536 }2537' 2>&125382539clare # [ 11.713835] systemd-networkd[542]: eth1: Gained IPv6LL2540clare # [ 12.097378] systemd-resolved[311]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2541clare # [ 12.772960] systemd-resolved[311]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2542clare # [ 12.776657] systemd-resolved[311]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2543clare # [ 14.012333] systemd-resolved[311]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2544clare # [ 14.015538] systemd-resolved[311]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2545clare # [ 16.459324] systemd-resolved[311]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2546clare # [ 16.463537] systemd-resolved[311]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2547clare: (finished: must succeed: nix-build --expr '2548 builtins.derivation {2549 name = "hi";2550 builder = "/bin/sh";2551 args = [ "-c" "echo hi > $out" ];2552 system = "aarch64-linux";2553 }2554' 2>&12555, in 4.87 seconds)2556alice: must succeed: nix-build --expr '2557 builtins.derivation {2558 name = "hi";2559 builder = "/bin/sh";2560 args = [ "-c" "echo hi > $out" ];2561 system = "aarch64-linux";2562 }2563' 2>&125642565bob # [ 16.638194] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:50706","trace_id":"633efb3cbe39ccad643ccd28212d55a1","span_id":"8e3309d2305945fa","status":200,"elapsed":0.03228,"bytes":50,"time":"2026-10-14T20:03:55Z","message":"handled request"}2566alice # [ 16.933045] systemd-resolved[312]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2567alice # [ 16.937615] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2568alice # [ 16.940951] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2569alice # [ 17.456217] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2570alice # [ 17.460813] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2571alice # [ 18.757554] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2572alice # [ 18.761483] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2573alice # [ 21.024307] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2574alice # [ 21.028488] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2575bob # [ 21.033106] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","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-10-14T20:03:59Z","message":"download the narinfo from upstream"}2576bob # [ 21.062828] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-14T20:03:59Z","message":"downloading the nar from upstream"}2577bob # [ 21.078773] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","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-10-14T20:03:59Z","message":"download the nar from upstream"}2578bob # [ 21.105462] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-14T20:03:59Z","message":"storing narinfo and nar_file record in the database"}2579bob # [ 21.113925] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":81.54532,"time":"2026-10-14T20:03:59Z","message":"download of narinfo complete"}2580bob # [ 21.120172] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","status":200,"elapsed":84.94792,"bytes":532,"time":"2026-10-14T20:03:59Z","message":"handled request"}2581bob # [ 21.123070] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:50706","trace_id":"fefebc82299d06a15e70da0150acf5ba","span_id":"2ef91a59e5ff7837","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":50.87232,"time":"2026-10-14T20:03:59Z","message":"download of nar complete"}2582bob # [ 21.129628] gsk8hxbprv9zyp2b8ap2gi0s3szsn1hf-ncps-wrapper[596]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:50706","trace_id":"54ce51133c94756d5757b3f1b50281d8","span_id":"3c7820ed6cbba9fa","status":200,"elapsed":0.55244,"bytes":95,"time":"2026-10-14T20:03:59Z","message":"handled request"}2583alice: (finished: must succeed: nix-build --expr '2584 builtins.derivation {2585 name = "hi";2586 builder = "/bin/sh";2587 args = [ "-c" "echo hi > $out" ];2588 system = "aarch64-linux";2589 }2590' 2>&12591, in 4.63 seconds)2592(finished: run the VM test script, in 21.91 seconds)2593test script finished in 22.15s2594cleanup2595kill QemuMachine (pid 47)2596alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2597alice # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2598alice # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2599alice # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2600kill QemuMachine (pid 49)2601bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2602bob # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2603bob # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2604bob # [2026-10-14T20:03:59Z INFO virtiofsd] Client disconnected, shutting down2605kill QemuMachine (pid 50)2606clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2607clare # [2026-10-14T20:04:00Z INFO virtiofsd] Client disconnected, shutting down2608clare # [2026-10-14T20:04:00Z INFO virtiofsd] Client disconnected, shutting down2609clare # [2026-10-14T20:04:00Z INFO virtiofsd] Client disconnected, shutting down2610(finished: cleanup, in 0.44 seconds)