vm-test-run-ncps
checks.aarch64-linux.ncps
· build #857
· raw
1build01: building 6p5xygzwqg9vjvzh9ds4r34wqwqlx9p3-vm-test-run-ncps.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 alice, bob, clare,9 vlan1,10 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh11start all VMs12alice: starting vm13bob: starting vm14clare: starting vm15alice # Disk image does not exist, creating the virtualisation disk image...16alice # Formatting '/build/vm-state-alice/tmp.RL92TAt1oh', fmt=raw size=107374182417alice # mke2fs 1.47.4 (6-Mar-2025)18alice # Discarding device blocks: 0/262144 done19alice # Creating filesystem with 262144 4k blocks and 65536 inodes20alice # Filesystem UUID: ca69e2fd-0d6e-4018-9de7-1c03a241e46b21alice # Superblock backups stored on blocks:22alice # 32768, 98304, 163840, 22937623alice # 24alice # Allocating group tables: 0/8 done25alice # Writing inode tables: 0/8 done26alice # Creating journal (8192 blocks): done27alice # Writing superblocks and filesystem accounting information: 0/8 done28alice # 29alice # Virtualisation disk image created.30alice # Starting virtiofs daemons...31alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32clare # Disk image does not exist, creating the virtualisation disk image...33alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34bob # Disk image does not exist, creating the virtualisation disk image...35bob: QEMU running (pid 49)36alice: QEMU running (pid 48)37alice # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...38bob # Formatting '/build/vm-state-bob/tmp.PkYJssGZZu', fmt=raw size=107374182439clare # Formatting '/build/vm-state-clare/tmp.c2xakDjVKJ', fmt=raw size=107374182440alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)41bob # mke2fs 1.47.4 (6-Mar-2025)42clare: QEMU running (pid 50)43clare # mke2fs 1.47.4 (6-Mar-2025)44bob # Discarding device blocks: 0/262144 done45clare # Discarding device blocks: 0/262144 done46bob # Creating filesystem with 262144 4k blocks and 65536 inodes47clare # Creating filesystem with 262144 4k blocks and 65536 inodes48(finished: start all VMs, in 0.63 seconds)49alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether50bob # Filesystem UUID: ca293e06-3a90-4536-8cd5-57b892a56c0751clare # Filesystem UUID: ac2a4e0d-e1d9-4b2f-95a2-3650b3b60bdc52bob: waiting for unit ncps53alice # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...54bob # Superblock backups stored on blocks:55bob: waiting for the VM to finish booting56alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)57clare # Superblock backups stored on blocks:58alice # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether59clare # 32768, 98304, 163840, 22937660alice # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...61clare # 62alice # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests63clare # Allocating group tables: 0/8 done64alice # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests65clare # Writing inode tables: 0/8 done66alice # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests67clare # Creating journal (8192 blocks): done68bob # 32768, 98304, 163840, 22937669clare # Writing superblocks and filesystem accounting information: 0/8 done70bob # 71clare # 72bob # Allocating group tables: 0/8 done73clare # Virtualisation disk image created.74bob # Writing inode tables: 0/8 done75clare # Starting virtiofs daemons...76bob # Creating journal (8192 blocks): done77clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)78bob # Writing superblocks and filesystem accounting information: 0/8 done79clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether80bob # 81clare # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...82bob # Virtualisation disk image created.83clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)84bob # Starting virtiofs daemons...85clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether86bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)87clare # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...88bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether89clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)90bob # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...91clare # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether92bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)93clare # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...94bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether95clare # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests96bob # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...97clare # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests98bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)99clare # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests100bob # [2026-10-05T15:30:36Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether101bob # [2026-10-05T15:30:36Z INFO virtiofsd] Waiting for vhost-user socket connection...102bob # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests103bob # [2026-10-05T15:30:36Z INFO virtiofsd] Client connected, servicing requests104bob # [2026-10-05T15:30:36Z 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/6grzaynwk99q3ylk0nxx1cpv82nxyb56-nixos-system-clare-test/init regInfo=/nix/.ro-store/gh1xzwi3jlvqx6ayb74fsxii7pqh9iqj-closure-info/registration console=ttyAMA0,115200n8 console=tty0142clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/gh1xzwi3jlvqx6ayb74fsxii7pqh9iqj-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 @44ce0000 (indirect, esz 8, psz 64K, shr 1)177clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (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.000060] arm-pv: using stolen time PV187clare # [ 0.000407] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)188clare # [ 0.000719] Console: colour dummy device 80x25189clare # [ 0.000731] printk: legacy console [tty0] enabled190clare # [ 0.000953] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)191clare # [ 0.000958] pid_max: default: 32768 minimum: 301192clare # [ 0.001043] LSM: initializing lsm=capability,landlock,yama,bpf,ima193clare # [ 0.001211] landlock: Up and running.194clare # [ 0.001215] Yama: becoming mindful.195clare # [ 0.001674] LSM support for eBPF active196clare # [ 0.001859] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)197clare # [ 0.001881] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)198clare # [ 0.004916] rcu: Hierarchical SRCU implementation.199clare # [ 0.004923] rcu: Max phase no-delay instances is 1000.200bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]201clare # [ 0.005994] fsl-mc MSI: its@8080000 domain created202clare # [ 0.006200] EFI services will not be available.203bob # [ 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 2026204clare # [ 0.006339] smp: Bringing up secondary CPUs ...205bob # [ 0.000000] KASLR enabled206alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]207clare # [ 0.006374] smp: Brought up 1 node, 1 CPU208bob # [ 0.000000] random: crng init done209clare # [ 0.006379] SMP: Total of 1 processors activated.210bob # [ 0.000000] Machine model: linux,dummy-virt211bob # [ 0.000000] efi: UEFI not found.212clare # [ 0.006380] CPU: All CPU(s) started at EL1213alice # [ 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 2026214clare # [ 0.006393] CPU features: detected: 32-bit EL0 Support215alice # [ 0.000000] KASLR enabled216bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT217alice # [ 0.000000] random: crng init done218alice # [ 0.000000] Machine model: linux,dummy-virt219clare # [ 0.006396] CPU features: detected: Data cache clean to the PoU not required for I/D coherence220bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]221alice # [ 0.000000] efi: UEFI not found.222clare # [ 0.006399] CPU features: detected: Common not Private translations223bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]224bob # [ 0.000000] Zone ranges:225alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT226clare # [ 0.006401] CPU features: detected: CRC32 instructions227bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]228alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]229clare # [ 0.006403] CPU features: detected: Data cache clean to Point of Persistence230bob # [ 0.000000] DMA32 empty231bob # [ 0.000000] Normal empty232alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]233clare # [ 0.006405] CPU features: detected: Enhanced Virtualization Traps234bob # [ 0.000000] Device empty235alice # [ 0.000000] Zone ranges:236bob # [ 0.000000] Movable zone start for each node237clare # [ 0.006416] CPU features: detected: RCpc load-acquire (LDAPR)238alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]239bob # [ 0.000000] Early memory node ranges240alice # [ 0.000000] DMA32 empty241clare # [ 0.006418] CPU features: detected: LSE atomic instructions242alice # [ 0.000000] Normal empty243bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]244alice # [ 0.000000] Device empty245clare # [ 0.006420] CPU features: detected: Privileged Access Never246bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]247clare # [ 0.006422] CPU features: detected: PMUv3248alice # [ 0.000000] Movable zone start for each node249bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000250clare # [ 0.006424] CPU features: detected: RAS Extension Support251alice # [ 0.000000] Early memory node ranges252bob # [ 0.000000] psci: probing for conduit method from DT.253alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]254clare # [ 0.006427] CPU features: detected: Speculative Store Bypassing Safe (SSBS)255bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.256alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]257clare # [ 0.006450] alternatives: applying system-wide alternatives258bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs259alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000260bob # [ 0.000000] psci: Trusted OS migration not required261clare # [ 0.007861] CPU features: detected: Hardware dirty bit management on CPU0262alice # [ 0.000000] psci: probing for conduit method from DT.263bob # [ 0.000000] psci: SMC Calling Convention v1.1264alice # [ 0.000000] psci: PSCIv1.3 detected in firmware.265bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)266alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs267clare # [ 0.008061] Memory: 890920K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116132K reserved, 32768K cma-reserved)268alice # [ 0.000000] psci: Trusted OS migration not required269clare # [ 0.008605] devtmpfs: initialized270bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296271alice # [ 0.000000] psci: SMC Calling Convention v1.1272bob # [ 0.000000] Detected PIPT I-cache on CPU0273clare # [ 0.010540] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)274bob # [ 0.000000] CPU features: detected: GICv3 CPU interface275alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)276clare # [ 0.010564] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).277bob # [ 0.000000] CPU features: detected: Spectre-v4278alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u311296279bob # [ 0.000000] CPU features: detected: Spectre-BHB280clare # [ 0.010714] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL281alice # [ 0.000000] Detected PIPT I-cache on CPU0282clare # [ 0.010720] 0 pages in range for non-PLT usage283bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR284alice # [ 0.000000] CPU features: detected: GICv3 CPU interface285clare # [ 0.010721] 508192 pages in range for PLT usage286alice # [ 0.000000] CPU features: detected: Spectre-v4287bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)288clare # [ 0.010823] pinctrl core: initialized pinctrl subsystem289alice # [ 0.000000] CPU features: detected: Spectre-BHB290bob # [ 0.000000] CPU features: detected: ARM erratum 1418040291clare # [ 0.011665] DMI not present or invalid.292alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR293bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion294clare # [ 0.015447] NET: Registered PF_NETLINK/PF_ROUTE protocol family295alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)296bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing297clare # [ 0.018170] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations298bob # [ 0.000000] alternatives: applying boot alternatives299alice # [ 0.000000] CPU features: detected: ARM erratum 1418040300clare # [ 0.018307] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations301alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion302clare # [ 0.018454] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations303alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing304clare # [ 0.018473] audit: initializing netlink subsys (disabled)305alice # [ 0.000000] alternatives: applying boot alternatives306clare # [ 0.019178] thermal_sys: Registered thermal governor 'fair_share'307clare # [ 0.019180] thermal_sys: Registered thermal governor 'bang_bang'308bob # [ 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/y4cm46pm38139pfhcscs8ifakphpsk33-nixos-system-bob-test/init regInfo=/nix/.ro-store/q5pxk33d6mpgsykjzry5v4ys8ia57ncj-closure-info/registration console=ttyAMA0,115200n8 console=tty0309clare # [ 0.019183] thermal_sys: Registered thermal governor 'step_wise'310clare # [ 0.019185] thermal_sys: Registered thermal governor 'user_space'311clare # [ 0.019187] thermal_sys: Registered thermal governor 'power_allocator'312bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/q5pxk33d6mpgsykjzry5v4ys8ia57ncj-closure-info/registration", will be passed to user space.313alice # [ 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/0kxwi100mqm1947haa05cgfplxnszjgr-nixos-system-alice-test/init regInfo=/nix/.ro-store/lsrbzsxs9q9lqb2l2grfh0sai4a8wa2y-closure-info/registration console=ttyAMA0,115200n8 console=tty0314clare # [ 0.019234] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1315bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes316clare # [ 0.019244] cpuidle: using governor ladder317bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)318clare # [ 0.019250] cpuidle: using governor menu319alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/lsrbzsxs9q9lqb2l2grfh0sai4a8wa2y-closure-info/registration", will be passed to user space.320clare # [ 0.019390] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.321bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)322alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes323clare # [ 0.019414] ASID allocator initialised with 32768 entries324bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB325clare # [ 0.020131] Serial: AMBA PL011 UART driver326alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)327bob # [ 0.000000] software IO TLB: area num 1.328alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)329clare # [ 0.023905] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1330bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)331clare # [ 0.024067] printk: console [ttyAMA0] enabled332bob # [ 0.000000] Fallback order for Node 0: 0333alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB334alice # [ 0.000000] software IO TLB: area num 1.335bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144336bob # [ 0.000000] Policy zone: DMA337alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)338bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off339alice # [ 0.000000] Fallback order for Node 0: 0340bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1341alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144342alice # [ 0.000000] Policy zone: DMA343bob # [ 0.000000] allocated 2097152 bytes of page_ext344bob # [ 0.000000] ftrace: allocating 75039 entries in 294 pages345alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off346bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups347alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1348bob # [ 0.000000] rcu: Hierarchical RCU implementation.349alice # [ 0.000000] allocated 2097152 bytes of page_ext350bob # [ 0.000000] rcu: RCU event tracing is enabled.351alice # [ 0.000000] ftrace: allocating 75039 entries in 294 pages352bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.353alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups354bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.355alice # [ 0.000000] rcu: Hierarchical RCU implementation.356bob # [ 0.000000] Rude variant of Tasks RCU enabled.357alice # [ 0.000000] rcu: RCU event tracing is enabled.358bob # [ 0.000000] Tracing variant of Tasks RCU enabled.359alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.360bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.361alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.362alice # [ 0.000000] Rude variant of Tasks RCU enabled.363bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1364alice # [ 0.000000] Tracing variant of Tasks RCU enabled.365bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.366alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.367bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.368alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1369bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.370alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.371bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0372bob # [ 0.000000] GICv3: 256 SPIs implemented373alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.374bob # [ 0.000000] GICv3: 0 Extended SPIs implemented375bob # [ 0.000000] Root IRQ handler: gic_handle_irq376alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.377bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI378alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0379bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0380alice # [ 0.000000] GICv3: 256 SPIs implemented381clare # [ 0.098992] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages382alice # [ 0.000000] GICv3: 0 Extended SPIs implemented383bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000384alice # [ 0.000000] Root IRQ handler: gic_handle_irq385clare # [ 0.099007] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page386bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]387alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI388clare # [ 0.099010] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages389alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0390bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)391clare # [ 0.099014] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page392alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000393bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)394clare # [ 0.099016] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages395alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]396clare # [ 0.099018] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page397bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000398alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)399bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000400clare # [ 0.099020] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages401clare # [ 0.099022] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page402alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)403bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.404clare # [ 0.100027] fbcon: Taking over console405alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000406clare # [ 0.100038] ACPI: Interpreter disabled.407bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns408clare # [ 0.100700] iommu: Default domain type: Translated409alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000410bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040411clare # [ 0.100704] iommu: DMA domain TLB invalidation policy: strict mode412alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.413clare # [ 0.100987] SCSI subsystem initialized414bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).415clare # [ 0.102777] usbcore: registered new interface driver usbfs416alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns417bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns418clare # [ 0.102807] usbcore: registered new interface driver hub419clare # [ 0.102818] usbcore: registered new device driver usb420alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040421bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns422clare # [ 0.103050] pps_core: LinuxPPS API ver. 1 registered423alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).424bob # [ 0.000057] arm-pv: using stolen time PV425clare # [ 0.103053] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>426bob # [ 0.000381] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)427alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns428clare # [ 0.103057] PTP clock support registered429bob # [ 0.000681] Console: colour dummy device 80x25430clare # [ 0.103095] EDAC MC: Ver: 3.0.0431alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns432bob # [ 0.000692] printk: legacy console [tty0] enabled433alice # [ 0.000056] arm-pv: using stolen time PV434bob # [ 0.000905] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)435alice # [ 0.000421] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)436bob # [ 0.000910] pid_max: default: 32768 minimum: 301437alice # [ 0.000732] Console: colour dummy device 80x25438bob # [ 0.001004] LSM: initializing lsm=capability,landlock,yama,bpf,ima439alice # [ 0.000743] printk: legacy console [tty0] enabled440bob # [ 0.001153] landlock: Up and running.441bob # [ 0.001155] Yama: becoming mindful.442bob # [ 0.001621] LSM support for eBPF active443alice # [ 0.000967] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)444alice # [ 0.000972] pid_max: default: 32768 minimum: 301445bob # [ 0.001811] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)446alice # [ 0.001054] LSM: initializing lsm=capability,landlock,yama,bpf,ima447clare # [ 0.111561] scmi_core: SCMI protocol bus registered448bob # [ 0.001832] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)449alice # [ 0.001214] landlock: Up and running.450clare # [ 0.111930] FPGA manager framework451alice # [ 0.001217] Yama: becoming mindful.452bob # [ 0.004658] rcu: Hierarchical SRCU implementation.453alice # [ 0.001673] LSM support for eBPF active454bob # [ 0.004666] rcu: Max phase no-delay instances is 1000.455alice # [ 0.001884] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)456bob # [ 0.005653] fsl-mc MSI: its@8080000 domain created457bob # [ 0.005861] EFI services will not be available.458alice # [ 0.001905] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)459bob # [ 0.005991] smp: Bringing up secondary CPUs ...460alice # [ 0.004840] rcu: Hierarchical SRCU implementation.461bob # [ 0.006027] smp: Brought up 1 node, 1 CPU462bob # [ 0.006032] SMP: Total of 1 processors activated.463alice # [ 0.004847] rcu: Max phase no-delay instances is 1000.464bob # [ 0.006034] CPU: All CPU(s) started at EL1465alice # [ 0.005817] fsl-mc MSI: its@8080000 domain created466bob # [ 0.006045] CPU features: detected: 32-bit EL0 Support467alice # [ 0.006013] EFI services will not be available.468alice # [ 0.006106] smp: Bringing up secondary CPUs ...469bob # [ 0.006048] CPU features: detected: Data cache clean to the PoU not required for I/D coherence470clare # [ 0.115610] vgaarb: loaded471alice # [ 0.006140] smp: Brought up 1 node, 1 CPU472alice # [ 0.006144] SMP: Total of 1 processors activated.473clare # [ 0.115860] clocksource: Switched to clocksource arch_sys_counter474bob # [ 0.006051] CPU features: detected: Common not Private translations475alice # [ 0.006146] CPU: All CPU(s) started at EL1476bob # [ 0.006053] CPU features: detected: CRC32 instructions477alice # [ 0.006159] CPU features: detected: 32-bit EL0 Support478bob # [ 0.006055] CPU features: detected: Data cache clean to Point of Persistence479alice # [ 0.006162] CPU features: detected: Data cache clean to the PoU not required for I/D coherence480bob # [ 0.006058] CPU features: detected: Enhanced Virtualization Traps481alice # [ 0.006165] CPU features: detected: Common not Private translations482bob # [ 0.006067] CPU features: detected: RCpc load-acquire (LDAPR)483alice # [ 0.006167] CPU features: detected: CRC32 instructions484bob # [ 0.006069] CPU features: detected: LSE atomic instructions485bob # [ 0.006071] CPU features: detected: Privileged Access Never486alice # [ 0.006169] CPU features: detected: Data cache clean to Point of Persistence487bob # [ 0.006073] CPU features: detected: PMUv3488alice # [ 0.006172] CPU features: detected: Enhanced Virtualization Traps489bob # [ 0.006074] CPU features: detected: RAS Extension Support490alice # [ 0.006182] CPU features: detected: RCpc load-acquire (LDAPR)491bob # [ 0.006078] CPU features: detected: Speculative Store Bypassing Safe (SSBS)492alice # [ 0.006184] CPU features: detected: LSE atomic instructions493bob # [ 0.006099] alternatives: applying system-wide alternatives494alice # [ 0.006186] CPU features: detected: Privileged Access Never495alice # [ 0.006187] CPU features: detected: PMUv3496bob # [ 0.007492] CPU features: detected: Hardware dirty bit management on CPU0497alice # [ 0.006189] CPU features: detected: RAS Extension Support498alice # [ 0.006193] CPU features: detected: Speculative Store Bypassing Safe (SSBS)499bob # [ 0.007720] Memory: 891128K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116112K reserved, 32768K cma-reserved)500bob # [ 0.008214] devtmpfs: initialized501alice # [ 0.006215] alternatives: applying system-wide alternatives502bob # [ 0.009783] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)503alice # [ 0.007813] CPU features: detected: Hardware dirty bit management on CPU0504bob # [ 0.009807] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).505bob # [ 0.009955] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL506alice # [ 0.008050] Memory: 890908K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116128K reserved, 32768K cma-reserved)507alice # [ 0.008573] devtmpfs: initialized508bob # [ 0.009961] 0 pages in range for non-PLT usage509clare # [ 0.127034] VFS: Disk quotas dquot_6.6.0510bob # [ 0.009962] 508192 pages in range for PLT usage511alice # [ 0.010066] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)512bob # [ 0.010080] pinctrl core: initialized pinctrl subsystem513clare # [ 0.127061] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)514bob # [ 0.010858] DMI not present or invalid.515alice # [ 0.010089] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).516bob # [ 0.014284] NET: Registered PF_NETLINK/PF_ROUTE protocol family517alice # [ 0.010215] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL518alice # [ 0.010221] 0 pages in range for non-PLT usage519bob # [ 0.016971] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations520alice # [ 0.010221] 508192 pages in range for PLT usage521bob # [ 0.017106] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations522alice # [ 0.010325] pinctrl core: initialized pinctrl subsystem523alice # [ 0.011111] DMI not present or invalid.524bob # [ 0.017252] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations525alice # [ 0.014483] NET: Registered PF_NETLINK/PF_ROUTE protocol family526bob # [ 0.017271] audit: initializing netlink subsys (disabled)527alice # [ 0.017229] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations528bob # [ 0.017867] thermal_sys: Registered thermal governor 'fair_share'529clare # [ 0.128885] netfs: FS-Cache loaded530bob # [ 0.017869] thermal_sys: Registered thermal governor 'bang_bang'531alice # [ 0.017369] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations532clare # [ 0.129011] pnp: PnP ACPI: disabled533clare # [ 0.131459] NET: Registered PF_INET protocol family534bob # [ 0.017872] thermal_sys: Registered thermal governor 'step_wise'535alice # [ 0.017516] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations536bob # [ 0.017875] thermal_sys: Registered thermal governor 'user_space'537clare # [ 0.131636] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)538alice # [ 0.017534] audit: initializing netlink subsys (disabled)539bob # [ 0.017877] thermal_sys: Registered thermal governor 'power_allocator'540alice # [ 0.018167] thermal_sys: Registered thermal governor 'fair_share'541alice # [ 0.018169] thermal_sys: Registered thermal governor 'bang_bang'542bob # [ 0.017917] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1543bob # [ 0.017926] cpuidle: using governor ladder544alice # [ 0.018172] thermal_sys: Registered thermal governor 'step_wise'545bob # [ 0.017931] cpuidle: using governor menu546alice # [ 0.018174] thermal_sys: Registered thermal governor 'user_space'547bob # [ 0.018058] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.548alice # [ 0.018176] thermal_sys: Registered thermal governor 'power_allocator'549bob # [ 0.018078] ASID allocator initialised with 32768 entries550bob # [ 0.018736] Serial: AMBA PL011 UART driver551alice # [ 0.018219] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1552alice # [ 0.018228] cpuidle: using governor ladder553bob # [ 0.022542] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1554alice # [ 0.018233] cpuidle: using governor menu555bob # [ 0.022688] printk: console [ttyAMA0] enabled556alice # [ 0.018358] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.557alice # [ 0.018378] ASID allocator initialised with 32768 entries558alice # [ 0.019051] Serial: AMBA PL011 UART driver559alice # [ 0.022554] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1560alice # [ 0.022754] printk: console [ttyAMA0] enabled561bob # [ 0.095901] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages562bob # [ 0.095916] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page563bob # [ 0.095919] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages564bob # [ 0.095923] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page565bob # [ 0.095926] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages566alice # [ 0.096800] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages567bob # [ 0.095927] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page568alice # [ 0.096815] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page569bob # [ 0.095930] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages570alice # [ 0.096817] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages571bob # [ 0.095931] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page572alice # [ 0.096822] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page573bob # [ 0.096911] fbcon: Taking over console574alice # [ 0.096824] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages575bob # [ 0.096921] ACPI: Interpreter disabled.576bob # [ 0.097613] iommu: Default domain type: Translated577alice # [ 0.096826] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page578bob # [ 0.097617] iommu: DMA domain TLB invalidation policy: strict mode579alice # [ 0.096828] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages580bob # [ 0.097905] SCSI subsystem initialized581alice # [ 0.096830] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page582bob # [ 0.098103] usbcore: registered new interface driver usbfs583alice # [ 0.097856] fbcon: Taking over console584bob # [ 0.098137] usbcore: registered new interface driver hub585alice # [ 0.097866] ACPI: Interpreter disabled.586bob # [ 0.098146] usbcore: registered new device driver usb587alice # [ 0.098515] iommu: Default domain type: Translated588bob # [ 0.098374] pps_core: LinuxPPS API ver. 1 registered589alice # [ 0.098519] iommu: DMA domain TLB invalidation policy: strict mode590alice # [ 0.098830] SCSI subsystem initialized591bob # [ 0.098377] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>592alice # [ 0.099029] usbcore: registered new interface driver usbfs593bob # [ 0.098389] PTP clock support registered594bob # [ 0.098420] EDAC MC: Ver: 3.0.0595alice # [ 0.099061] usbcore: registered new interface driver hub596alice # [ 0.099070] usbcore: registered new device driver usb597alice # [ 0.099273] pps_core: LinuxPPS API ver. 1 registered598alice # [ 0.099276] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>599alice # [ 0.099280] PTP clock support registered600alice # [ 0.099312] EDAC MC: Ver: 3.0.0601clare # [ 0.157754] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)602clare # [ 0.157778] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)603bob # [ 0.108140] scmi_core: SCMI protocol bus registered604clare # [ 0.157790] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)605bob # [ 0.108545] FPGA manager framework606bob # [ 0.112062] vgaarb: loaded607clare # [ 0.157826] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)608clare # [ 0.157892] TCP: Hash tables configured (established 8192 bind 8192)609alice # [ 0.109145] scmi_core: SCMI protocol bus registered610clare # [ 0.157993] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)611alice # [ 0.109542] FPGA manager framework612alice # [ 0.112531] vgaarb: loaded613clare # [ 0.158059] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)614clare # [ 0.158112] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)615clare # [ 0.158239] NET: Registered PF_UNIX/PF_LOCAL protocol family616clare # [ 0.158287] NET: Registered PF_XDP protocol family617clare # [ 0.158309] PCI: CLS 0 bytes, default 64618bob # [ 0.113156] clocksource: Switched to clocksource arch_sys_counter619clare # [ 0.158656] Trying to unpack rootfs image as initramfs...620alice # [ 0.113617] clocksource: Switched to clocksource arch_sys_counter621clare # [ 0.166229] kvm [1]: HYP mode not available622bob # [ 0.122868] VFS: Disk quotas dquot_6.6.0623bob # [ 0.122893] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)624bob # [ 0.124342] netfs: FS-Cache loaded625bob # [ 0.124458] pnp: PnP ACPI: disabled626alice # [ 0.123265] VFS: Disk quotas dquot_6.6.0627alice # [ 0.123291] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)628alice # [ 0.124796] netfs: FS-Cache loaded629alice # [ 0.124920] pnp: PnP ACPI: disabled630bob # [ 0.127797] NET: Registered PF_INET protocol family631bob # [ 0.127992] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)632alice # [ 0.128240] NET: Registered PF_INET protocol family633alice # [ 0.128425] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)634bob # [ 0.153533] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)635bob # [ 0.153557] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)636bob # [ 0.153570] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)637bob # [ 0.153608] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)638alice # [ 0.154139] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)639bob # [ 0.153674] TCP: Hash tables configured (established 8192 bind 8192)640alice # [ 0.154163] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)641bob # [ 0.153774] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)642alice # [ 0.154176] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)643bob # [ 0.153842] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)644alice # [ 0.154211] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)645bob # [ 0.153865] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)646alice # [ 0.154277] TCP: Hash tables configured (established 8192 bind 8192)647bob # [ 0.153974] NET: Registered PF_UNIX/PF_LOCAL protocol family648alice # [ 0.154377] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)649bob # [ 0.154002] NET: Registered PF_XDP protocol family650bob # [ 0.154024] PCI: CLS 0 bytes, default 64651alice # [ 0.154404] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)652bob # [ 0.154327] Trying to unpack rootfs image as initramfs...653alice # [ 0.154465] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)654alice # [ 0.154569] NET: Registered PF_UNIX/PF_LOCAL protocol family655alice # [ 0.154631] NET: Registered PF_XDP protocol family656alice # [ 0.154652] PCI: CLS 0 bytes, default 64657alice # [ 0.154947] Trying to unpack rootfs image as initramfs...658bob # [ 0.163268] kvm [1]: HYP mode not available659alice # [ 0.163977] kvm [1]: HYP mode not available660clare # [ 0.240734] Initialise system trusted keyrings661clare # [ 0.240868] workingset: timestamp_bits=42 max_order=18 bucket_order=0662clare # [ 0.241206] squashfs: version 4.0 (2009/01/31) Phillip Lougher663clare # [ 0.241243] 9p: Installing v9fs 9p2000 file system support664clare # [ 0.261856] Key type asymmetric registered665clare # [ 0.261874] Asymmetric key parser 'x509' registered666clare # [ 0.261936] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)667clare # [ 0.262072] io scheduler mq-deadline registered668clare # [ 0.262075] io scheduler kyber registered669clare # [ 0.272639] pl061_gpio 9030000.pl061: PL061 GPIO chip registered670clare # [ 0.272984] ledtrig-cpu: registered to indicate activity on CPUs671clare # [ 0.273331] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:672clare # [ 0.273349] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000673clare # [ 0.273361] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000674clare # [ 0.273365] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000675clare # [ 0.273392] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits676clare # [ 0.273414] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]677clare # [ 0.273482] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00678clare # [ 0.273503] pci_bus 0000:00: root bus resource [bus 00-ff]679clare # [ 0.273506] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]680clare # [ 0.273508] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]681clare # [ 0.273511] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]682clare # [ 0.273586] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint683clare # [ 0.274034] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint684alice # [ 0.234006] Initialise system trusted keyrings685alice # [ 0.234132] workingset: timestamp_bits=42 max_order=18 bucket_order=0686alice # [ 0.234459] squashfs: version 4.0 (2009/01/31) Phillip Lougher687alice # [ 0.234493] 9p: Installing v9fs 9p2000 file system support688clare # [ 0.274163] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]689clare # [ 0.274172] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]690clare # [ 0.274191] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]691clare # [ 0.274199] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]692clare # [ 0.274513] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint693clare # [ 0.274636] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]694clare # [ 0.274645] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]695clare # [ 0.274663] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]696clare # [ 0.274978] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint697clare # [ 0.275101] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]698clare # [ 0.275109] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]699clare # [ 0.275128] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]700clare # [ 0.275440] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint701clare # [ 0.275563] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]702bob # [ 0.237777] Initialise system trusted keyrings703clare # [ 0.275572] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]704bob # [ 0.237899] workingset: timestamp_bits=42 max_order=18 bucket_order=0705clare # [ 0.275591] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]706bob # [ 0.238242] squashfs: version 4.0 (2009/01/31) Phillip Lougher707clare # [ 0.275599] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]708bob # [ 0.238286] 9p: Installing v9fs 9p2000 file system support709bob # [ 0.249074] Key type asymmetric registered710bob # [ 0.249086] Asymmetric key parser 'x509' registered711bob # [ 0.249127] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)712clare # [ 0.300300] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint713clare # [ 0.300437] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]714clare # [ 0.300457] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]715clare # [ 0.300847] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint716clare # [ 0.300977] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]717clare # [ 0.300995] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]718clare # [ 0.301327] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint719clare # [ 0.301450] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]720clare # [ 0.301628] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint721clare # [ 0.301753] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]722clare # [ 0.301770] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]723clare # [ 0.302083] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint724clare # [ 0.302210] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]725clare # [ 0.302228] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]726clare # [ 0.302533] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint727clare # [ 0.302657] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]728alice # [ 0.253310] Key type asymmetric registered729alice # [ 0.253328] Asymmetric key parser 'x509' registered730clare # [ 0.302674] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]731alice # [ 0.253393] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)732clare # [ 0.302983] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint733clare # [ 0.303198] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]734clare # [ 0.303207] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]735clare # [ 0.303224] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]736clare # [ 0.303536] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint737clare # [ 0.303659] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]738clare # [ 0.303668] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]739alice # [ 0.262979] io scheduler mq-deadline registered740alice # [ 0.262986] io scheduler kyber registered741clare # [ 0.303685] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]742alice # [ 0.265430] pl061_gpio 9030000.pl061: PL061 GPIO chip registered743bob # [ 0.265237] io scheduler mq-deadline registered744bob # [ 0.265248] io scheduler kyber registered745bob # [ 0.267839] pl061_gpio 9030000.pl061: PL061 GPIO chip registered746bob # [ 0.268194] ledtrig-cpu: registered to indicate activity on CPUs747clare # [ 0.317185] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned748alice # [ 0.267014] ledtrig-cpu: registered to indicate activity on CPUs749bob # [ 0.268534] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:750clare # [ 0.317195] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned751alice # [ 0.267348] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:752bob # [ 0.268552] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000753clare # [ 0.317199] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned754alice # [ 0.267365] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000755bob # [ 0.268564] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000756clare # [ 0.317235] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned757alice # [ 0.267377] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000758bob # [ 0.268569] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000759clare # [ 0.317267] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned760alice # [ 0.267382] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000761bob # [ 0.268595] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits762clare # [ 0.317297] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned763alice # [ 0.267409] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits764bob # [ 0.268617] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]765clare # [ 0.317330] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned766alice # [ 0.267430] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]767bob # [ 0.268685] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00768clare # [ 0.317359] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned769bob # [ 0.268711] pci_bus 0000:00: root bus resource [bus 00-ff]770alice # [ 0.267505] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00771clare # [ 0.317391] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned772bob # [ 0.268714] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]773alice # [ 0.267536] pci_bus 0000:00: root bus resource [bus 00-ff]774alice # [ 0.267540] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]775bob # [ 0.268717] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]776clare # [ 0.317421] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned777alice # [ 0.267542] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]778bob # [ 0.268719] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]779clare # [ 0.317450] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned780alice # [ 0.267545] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]781clare # [ 0.317481] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned782bob # [ 0.268793] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint783alice # [ 0.267624] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint784clare # [ 0.317547] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned785alice # [ 0.268103] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint786clare # [ 0.317624] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned787alice # [ 0.268231] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]788clare # [ 0.317636] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned789alice # [ 0.268240] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]790clare # [ 0.317648] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned791alice # [ 0.268259] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]792clare # [ 0.317660] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned793alice # [ 0.268267] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]794clare # [ 0.317672] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned795alice # [ 0.268588] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint796clare # [ 0.317684] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned797alice # [ 0.268714] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]798clare # [ 0.317696] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned799alice # [ 0.268723] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]800clare # [ 0.317708] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned801alice # [ 0.268742] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]802clare # [ 0.317720] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned803alice # [ 0.269057] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint804clare # [ 0.317732] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned805alice # [ 0.269181] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]806clare # [ 0.317743] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned807alice # [ 0.269190] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]808clare # [ 0.317755] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned809alice # [ 0.269208] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]810clare # [ 0.317767] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned811alice # [ 0.269521] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint812clare # [ 0.317779] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned813clare # [ 0.317791] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned814clare # [ 0.317803] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned815clare # [ 0.317814] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned816clare # [ 0.317826] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned817clare # [ 0.317842] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]818clare # [ 0.317846] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]819clare # [ 0.317855] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]820clare # [ 0.318415] pci 0000:00:07.0: enabling device (0000 -> 0002)821bob # [ 0.285368] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint822bob # [ 0.285511] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]823bob # [ 0.285521] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]824bob # [ 0.285540] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]825bob # [ 0.285549] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]826bob # [ 0.285882] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint827bob # [ 0.286005] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]828bob # [ 0.286013] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]829bob # [ 0.286032] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]830bob # [ 0.286345] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint831bob # [ 0.286469] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]832alice # [ 0.289726] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]833bob # [ 0.286478] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]834clare # [ 0.343798] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)835alice # [ 0.289741] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]836bob # [ 0.286496] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]837alice # [ 0.289760] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]838bob # [ 0.286807] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint839alice # [ 0.289769] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]840bob # [ 0.286931] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]841bob # [ 0.286940] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]842alice # [ 0.290148] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint843alice # [ 0.290280] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]844bob # [ 0.286958] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]845bob # [ 0.286966] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]846alice # [ 0.290298] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]847bob # [ 0.287277] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint848alice # [ 0.290619] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint849bob # [ 0.287402] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]850alice # [ 0.290768] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]851bob # [ 0.287419] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]852alice # [ 0.290786] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]853bob # [ 0.287732] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint854alice # [ 0.291107] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint855bob # [ 0.287871] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]856alice # [ 0.291232] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]857bob # [ 0.287889] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]858alice # [ 0.291409] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint859alice # [ 0.291538] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]860bob # [ 0.288157] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint861bob # [ 0.288278] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]862alice # [ 0.291556] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]863bob # [ 0.288459] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint864alice # [ 0.291873] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint865bob # [ 0.288584] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]866alice # [ 0.292002] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]867bob # [ 0.288601] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]868alice # [ 0.292019] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]869bob # [ 0.288912] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint870alice # [ 0.292339] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint871bob # [ 0.289039] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]872alice # [ 0.292468] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]873bob # [ 0.289056] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]874alice # [ 0.292486] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]875alice # [ 0.292813] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint876alice # [ 0.293041] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]877alice # [ 0.293050] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]878clare # [ 0.353129] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)879alice # [ 0.293069] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]880clare # [ 0.354886] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)881alice # [ 0.293408] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint882alice # [ 0.293533] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]883alice # [ 0.293541] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]884alice # [ 0.293560] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]885bob # [ 0.305955] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint886bob # [ 0.306091] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]887bob # [ 0.306110] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]888alice # [ 0.309165] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned889bob # [ 0.306425] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint890bob # [ 0.306645] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]891alice # [ 0.309176] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned892bob # [ 0.306655] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]893alice # [ 0.309179] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned894bob # [ 0.306673] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]895alice # [ 0.309213] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned896bob # [ 0.306991] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint897alice # [ 0.309244] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned898bob # [ 0.307116] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]899bob # [ 0.307125] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]900alice # [ 0.309276] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned901bob # [ 0.307143] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]902alice # [ 0.309309] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned903bob # [ 0.307585] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned904alice # [ 0.309340] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned905bob # [ 0.307591] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned906alice # [ 0.309372] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned907bob # [ 0.307594] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned908alice # [ 0.309403] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned909bob # [ 0.307628] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned910alice # [ 0.309435] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned911bob # [ 0.307659] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned912alice # [ 0.309467] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned913bob # [ 0.307688] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned914alice # [ 0.309527] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned915bob # [ 0.307719] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned916clare # [ 0.365027] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)917alice # [ 0.309557] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned918bob # [ 0.307749] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned919alice # [ 0.309569] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned920bob # [ 0.307779] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned921alice # [ 0.309581] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned922bob # [ 0.307809] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned923alice # [ 0.309593] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned924alice # [ 0.309605] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned925bob # [ 0.307852] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned926bob # [ 0.307882] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned927bob # [ 0.307951] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned928bob # [ 0.307980] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned929bob # [ 0.307992] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned930bob # [ 0.308004] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned931bob # [ 0.308016] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned932bob # [ 0.308028] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned933bob # [ 0.308040] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned934bob # [ 0.308052] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned935bob # [ 0.308065] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned936bob # [ 0.308077] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned937bob # [ 0.308089] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned938bob # [ 0.308101] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned939bob # [ 0.308113] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned940bob # [ 0.308125] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned941bob # [ 0.308136] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned942bob # [ 0.308148] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned943bob # [ 0.308160] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned944bob # [ 0.308171] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned945clare # [ 0.376406] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)946alice # [ 0.325691] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned947bob # [ 0.308183] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned948clare # [ 0.378326] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)949alice # [ 0.325737] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned950bob # [ 0.308200] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]951alice # [ 0.325750] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned952bob # [ 0.308204] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]953alice # [ 0.325764] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned954bob # [ 0.308211] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]955bob # [ 0.308752] pci 0000:00:07.0: enabling device (0000 -> 0002)956alice # [ 0.325777] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned957alice # [ 0.325791] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned958alice # [ 0.325804] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned959alice # [ 0.325818] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned960clare # [ 0.380875] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)961alice # [ 0.325831] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned962clare # [ 0.382431] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)963alice # [ 0.325843] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned964alice # [ 0.325856] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned965alice # [ 0.325869] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned966alice # [ 0.325882] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned967alice # [ 0.325904] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]968alice # [ 0.325908] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]969alice # [ 0.325916] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]970alice # [ 0.326476] pci 0000:00:07.0: enabling device (0000 -> 0002)971clare # [ 0.384847] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)972clare # [ 0.386234] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)973bob # [ 0.347619] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)974clare # [ 0.397094] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)975alice # [ 0.349520] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)976alice # [ 0.351631] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)977alice # [ 0.353089] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)978bob # [ 0.357409] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)979bob # [ 0.359428] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)980clare # [ 0.408808] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled981clare # [ 0.409829] msm_serial: driver initialized982clare # [ 0.409909] SuperH (H)SCI(F) driver initialized983clare # [ 0.409949] STM32 USART driver initialized984bob # [ 0.362303] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)985bob # [ 0.364073] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)986alice # [ 0.362765] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)987alice # [ 0.364671] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)988alice # [ 0.367585] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)989alice # [ 0.368917] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)990bob # [ 0.373326] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)991bob # [ 0.374979] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)992bob # [ 0.376607] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)993bob # [ 0.379750] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)994alice # [ 0.378647] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)995alice # [ 0.380438] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)996clare # [ 0.434259] loop: module loaded997clare # [ 0.434399] virtio_blk virtio2: 1/0/0 default/read/poll queues998clare # [ 0.434995] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)999alice # [ 0.383085] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1000alice # [ 0.385241] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1001bob # [ 0.389331] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1002bob # [ 0.391529] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1003clare # [ 0.440344] megasas: 07.734.00.00-rc11004clare # [ 0.440856] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1005clare # [ 0.443172] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001006clare # [ 0.443200] Intel/Sharp Extended Query Table at 0x00311007clare # [ 0.447021] Using buffer write method1008alice # [ 0.396547] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1009clare # [ 0.447055] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1010alice # [ 0.397520] msm_serial: driver initialized1011alice # [ 0.397604] SuperH (H)SCI(F) driver initialized1012alice # [ 0.398840] STM32 USART driver initialized1013bob # [ 0.401894] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1014bob # [ 0.402956] msm_serial: driver initialized1015bob # [ 0.403046] SuperH (H)SCI(F) driver initialized1016bob # [ 0.403091] STM32 USART driver initialized1017clare # [ 0.457066] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001018clare # [ 0.457086] Intel/Sharp Extended Query Table at 0x00311019clare # [ 0.458759] Using buffer write method1020clare # [ 0.458775] Concatenating MTD devices:1021clare # [ 0.458776] (0): "0.flash"1022clare # [ 0.458778] (1): "0.flash"1023clare # [ 0.458780] into device "0.flash"1024alice # [ 0.422570] loop: module loaded1025alice # [ 0.422716] virtio_blk virtio2: 1/0/0 default/read/poll queues1026alice # [ 0.423418] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1027bob # [ 0.427575] loop: module loaded1028bob # [ 0.427720] virtio_blk virtio2: 1/0/0 default/read/poll queues1029bob # [ 0.428395] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1030alice # [ 0.427400] megasas: 07.734.00.00-rc11031alice # [ 0.427873] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1032bob # [ 0.433612] megasas: 07.734.00.00-rc11033bob # [ 0.434098] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1034alice # [ 0.438765] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001035alice # [ 0.438800] Intel/Sharp Extended Query Table at 0x00311036alice # [ 0.440634] Using buffer write method1037alice # [ 0.440677] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1038bob # [ 0.445710] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001039bob # [ 0.445747] Intel/Sharp Extended Query Table at 0x00311040bob # [ 0.448001] Using buffer write method1041bob # [ 0.448075] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1042bob # [ 0.451875] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001043bob # [ 0.451913] Intel/Sharp Extended Query Table at 0x00311044bob # [ 0.454841] Using buffer write method1045bob # [ 0.454854] Concatenating MTD devices:1046bob # [ 0.454856] (0): "0.flash"1047bob # [ 0.454858] (1): "0.flash"1048bob # [ 0.454859] into device "0.flash"1049alice # [ 0.455191] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001050alice # [ 0.455212] Intel/Sharp Extended Query Table at 0x00311051alice # [ 0.456759] Using buffer write method1052alice # [ 0.456775] Concatenating MTD devices:1053alice # [ 0.456777] (0): "0.flash"1054alice # [ 0.456778] (1): "0.flash"1055alice # [ 0.456780] into device "0.flash"1056clare # [ 0.688613] Freeing initrd memory: 26948K1057clare # [ 0.695523] tun: Universal TUN/TAP device driver, 1.61058clare # [ 0.698262] thunder_xcv, ver 1.01059clare # [ 0.698280] thunder_bgx, ver 1.01060clare # [ 0.698289] nicpf, ver 1.01061clare # [ 0.698616] e1000: Intel(R) PRO/1000 Network Driver1062clare # [ 0.698620] e1000: Copyright (c) 1999-2006 Intel Corporation.1063clare # [ 0.698632] e1000e: Intel(R) PRO/1000 Network Driver1064clare # [ 0.698637] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1065clare # [ 0.698649] igb: Intel(R) Gigabit Ethernet Network Driver1066clare # [ 0.698651] igb: Copyright (c) 2007-2014 Intel Corporation.1067clare # [ 0.698661] igbvf: Intel(R) Gigabit Virtual Function Network Driver1068clare # [ 0.698666] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1069clare # [ 0.698730] sky2: driver version 1.301070clare # [ 0.699579] usbcore: registered new interface driver usb-storage1071clare # [ 0.699661] usbcore: registered new interface driver usbserial_generic1072clare # [ 0.699667] usbserial: USB Serial support registered for generic1073clare # [ 0.700468] ehci-pci 0000:00:07.0: EHCI Host Controller1074clare # [ 0.700494] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11075clare # [ 0.700802] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001076clare # [ 0.708447] hv_vmbus: registering driver hyperv_keyboard1077clare # [ 0.709095] rtc-pl031 9010000.pl031: registered as rtc01078clare # [ 0.709124] rtc-pl031 9010000.pl031: setting system clock to 2026-10-05T15:30:37 UTC (1791214237)1079clare # [ 0.709339] i2c_dev: i2c /dev entries driver1080clare # [ 0.710926] sdhci: Secure Digital Host Controller Interface driver1081clare # [ 0.710931] sdhci: Copyright(c) Pierre Ossman1082clare # [ 0.711085] Synopsys Designware Multimedia Card Interface Driver1083clare # [ 0.711269] sdhci-pltfm: SDHCI platform and OF driver helper1084clare # [ 0.711917] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001085clare # [ 0.712323] hub 1-0:1.0: USB hub found1086clare # [ 0.716642] hub 1-0:1.0: 6 ports detected1087clare # [ 0.717518] hid: raw HID events driver (C) Jiri Kosina1088clare # [ 0.717666] usbcore: registered new interface driver usbhid1089clare # [ 0.717669] usbhid: USB HID core driver1090clare # [ 0.718427] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1091clare # [ 0.719262] drop_monitor: Initializing network drop monitor service1092clare # [ 0.719431] NET: Registered PF_INET6 protocol family1093clare # [ 0.723202] Segment Routing with IPv61094clare # [ 0.723221] In-situ OAM (IOAM) with IPv61095clare # [ 0.723279] NET: Registered PF_PACKET protocol family1096clare # [ 0.723362] 9pnet: Installing 9P2000 support1097clare # [ 0.723398] Key type dns_resolver registered1098clare # [ 0.728007] registered taskstats version 11099clare # [ 0.728162] Loading compiled-in X.509 certificates1100bob # [ 0.684438] Freeing initrd memory: 26928K1101clare # [ 0.733550] Demotion targets for Node 0: null1102clare # [ 0.733637] Key type .fscrypt registered1103clare # [ 0.733644] Key type fscrypt-provisioning registered1104clare # [ 0.733750] ima: No TPM chip found, activating TPM-bypass!1105clare # [ 0.733761] ima: Allocated hash algorithm: sha11106clare # [ 0.733820] ima: No architecture policies found1107clare # [ 0.734425] input: gpio-keys as /devices/platform/gpio-keys/input/input01108alice # [ 0.688864] Freeing initrd memory: 26944K1109bob # [ 0.691608] tun: Universal TUN/TAP device driver, 1.61110bob # [ 0.694412] thunder_xcv, ver 1.01111bob # [ 0.694429] thunder_bgx, ver 1.01112bob # [ 0.694440] nicpf, ver 1.01113bob # [ 0.694748] e1000: Intel(R) PRO/1000 Network Driver1114bob # [ 0.694752] e1000: Copyright (c) 1999-2006 Intel Corporation.1115clare # [ 0.747500] clk: Disabling unused clocks1116alice # [ 0.695854] tun: Universal TUN/TAP device driver, 1.61117bob # [ 0.694764] e1000e: Intel(R) PRO/1000 Network Driver1118clare # [ 0.747512] PM: genpd: Disabling unused power domains1119bob # [ 0.694769] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1120bob # [ 0.694781] igb: Intel(R) Gigabit Ethernet Network Driver1121bob # [ 0.694783] igb: Copyright (c) 2007-2014 Intel Corporation.1122bob # [ 0.694792] igbvf: Intel(R) Gigabit Virtual Function Network Driver1123bob # [ 0.694797] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1124bob # [ 0.694889] sky2: driver version 1.301125bob # [ 0.695758] usbcore: registered new interface driver usb-storage1126bob # [ 0.695888] usbcore: registered new interface driver usbserial_generic1127clare # [ 0.750499] Freeing unused kernel memory: 4736K1128alice # [ 0.698607] thunder_xcv, ver 1.01129clare # [ 0.750580] Run /init as init process1130alice # [ 0.698623] thunder_bgx, ver 1.01131bob # [ 0.695896] usbserial: USB Serial support registered for generic1132alice # [ 0.698632] nicpf, ver 1.01133bob # [ 0.696217] hv_vmbus: registering driver hyperv_keyboard1134alice # [ 0.698949] e1000: Intel(R) PRO/1000 Network Driver1135alice # [ 0.698953] e1000: Copyright (c) 1999-2006 Intel Corporation.1136alice # [ 0.698965] e1000e: Intel(R) PRO/1000 Network Driver1137alice # [ 0.698972] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1138alice # [ 0.698983] igb: Intel(R) Gigabit Ethernet Network Driver1139alice # [ 0.698986] igb: Copyright (c) 2007-2014 Intel Corporation.1140alice # [ 0.698999] igbvf: Intel(R) Gigabit Virtual Function Network Driver1141alice # [ 0.699004] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1142alice # [ 0.699068] sky2: driver version 1.301143alice # [ 0.699930] usbcore: registered new interface driver usb-storage1144alice # [ 0.700018] usbcore: registered new interface driver usbserial_generic1145alice # [ 0.700025] usbserial: USB Serial support registered for generic1146bob # [ 0.703792] ehci-pci 0000:00:07.0: EHCI Host Controller1147alice # [ 0.700333] hv_vmbus: registering driver hyperv_keyboard1148bob # [ 0.703835] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11149alice # [ 0.701402] ehci-pci 0000:00:07.0: EHCI Host Controller1150bob # [ 0.704079] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001151alice # [ 0.701432] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11152bob # [ 0.704282] rtc-pl031 9010000.pl031: registered as rtc01153bob # [ 0.704311] rtc-pl031 9010000.pl031: setting system clock to 2026-10-05T15:30:37 UTC (1791214237)1154alice # [ 0.709116] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001155bob # [ 0.704525] i2c_dev: i2c /dev entries driver1156alice # [ 0.709314] rtc-pl031 9010000.pl031: registered as rtc01157bob # [ 0.706267] sdhci: Secure Digital Host Controller Interface driver1158bob # [ 0.706273] sdhci: Copyright(c) Pierre Ossman1159alice # [ 0.709342] rtc-pl031 9010000.pl031: setting system clock to 2026-10-05T15:30:37 UTC (1791214237)1160alice # [ 0.709543] i2c_dev: i2c /dev entries driver1161bob # [ 0.706441] Synopsys Designware Multimedia Card Interface Driver1162bob # [ 0.706634] sdhci-pltfm: SDHCI platform and OF driver helper1163bob # [ 0.707560] hid: raw HID events driver (C) Jiri Kosina1164bob # [ 0.707722] usbcore: registered new interface driver usbhid1165bob # [ 0.707725] usbhid: USB HID core driver1166alice # [ 0.713102] sdhci: Secure Digital Host Controller Interface driver1167alice # [ 0.713108] sdhci: Copyright(c) Pierre Ossman1168alice # [ 0.713260] Synopsys Designware Multimedia Card Interface Driver1169alice # [ 0.713443] sdhci-pltfm: SDHCI platform and OF driver helper1170bob # [ 0.714291] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001171bob # [ 0.714694] hub 1-0:1.0: USB hub found1172bob # [ 0.714733] hub 1-0:1.0: 6 ports detected1173bob # [ 0.715022] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1174bob # [ 0.715914] drop_monitor: Initializing network drop monitor service1175bob # [ 0.716027] NET: Registered PF_INET6 protocol family1176alice # [ 0.716181] hid: raw HID events driver (C) Jiri Kosina1177bob # [ 0.716668] Segment Routing with IPv61178alice # [ 0.716319] usbcore: registered new interface driver usbhid1179bob # [ 0.716695] In-situ OAM (IOAM) with IPv61180alice # [ 0.716321] usbhid: USB HID core driver1181bob # [ 0.716750] NET: Registered PF_PACKET protocol family1182bob # [ 0.716813] 9pnet: Installing 9P2000 support1183alice # [ 0.717041] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1184bob # [ 0.716846] Key type dns_resolver registered1185alice # [ 0.717892] drop_monitor: Initializing network drop monitor service1186alice # [ 0.718050] NET: Registered PF_INET6 protocol family1187clare # [ 0.770427] systemd[1]: Successfully made /usr/ read-only.1188alice # [ 0.720982] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001189alice # [ 0.721372] hub 1-0:1.0: USB hub found1190alice # [ 0.721393] hub 1-0:1.0: 6 ports detected1191bob # [ 0.724066] registered taskstats version 11192bob # [ 0.724206] Loading compiled-in X.509 certificates1193alice # [ 0.723256] Segment Routing with IPv61194alice # [ 0.723274] In-situ OAM (IOAM) with IPv61195alice # [ 0.723330] NET: Registered PF_PACKET protocol family1196alice # [ 0.723394] 9pnet: Installing 9P2000 support1197alice # [ 0.723425] Key type dns_resolver registered1198alice # [ 0.727948] registered taskstats version 11199alice # [ 0.728092] Loading compiled-in X.509 certificates1200bob # [ 0.729560] Demotion targets for Node 0: null1201bob # [ 0.729647] Key type .fscrypt registered1202bob # [ 0.729653] Key type fscrypt-provisioning registered1203bob # [ 0.729762] ima: No TPM chip found, activating TPM-bypass!1204bob # [ 0.729773] ima: Allocated hash algorithm: sha11205alice # [ 0.733411] Demotion targets for Node 0: null1206bob # [ 0.729828] ima: No architecture policies found1207alice # [ 0.733496] Key type .fscrypt registered1208alice # [ 0.733502] Key type fscrypt-provisioning registered1209bob # [ 0.730353] input: gpio-keys as /devices/platform/gpio-keys/input/input01210alice # [ 0.733612] ima: No TPM chip found, activating TPM-bypass!1211alice # [ 0.735365] ima: Allocated hash algorithm: sha11212alice # [ 0.735433] ima: No architecture policies found1213alice # [ 0.735975] input: gpio-keys as /devices/platform/gpio-keys/input/input01214bob # [ 0.743029] clk: Disabling unused clocks1215bob # [ 0.743040] PM: genpd: Disabling unused power domains1216bob # [ 0.746073] Freeing unused kernel memory: 4736K1217bob # [ 0.746150] Run /init as init process1218alice # [ 0.746928] clk: Disabling unused clocks1219alice # [ 0.746939] PM: genpd: Disabling unused power domains1220alice # [ 0.749137] Freeing unused kernel memory: 4736K1221alice # [ 0.749214] Run /init as init process1222bob # [ 0.767655] systemd[1]: Successfully made /usr/ read-only.1223alice # [ 0.768186] systemd[1]: Successfully made /usr/ read-only.1224clare # [ 0.967916] usb 1-1: new high-speed USB device number 2 using ehci-pci1225bob # [ 0.965212] usb 1-1: new high-speed USB device number 2 using ehci-pci1226alice # [ 0.969833] usb 1-1: new high-speed USB device number 2 using ehci-pci1227clare # [ 1.104521] 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)1228clare # [ 1.104552] systemd[1]: Detected virtualization qemu.1229clare # [ 1.104591] systemd[1]: Detected architecture arm64.1230clare # [ 1.104600] systemd[1]: Running in initrd.1231clare # [ 1.105434] systemd[1]: Initializing machine ID from random generator.1232clare # [ 1.105700] systemd[1]: Hostname set to <clare>.1233clare # [ 1.134774] 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/input11234bob # [ 1.101866] 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)1235alice # [ 1.102264] 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)1236bob # [ 1.101896] systemd[1]: Detected virtualization qemu.1237alice # [ 1.102295] systemd[1]: Detected virtualization qemu.1238bob # [ 1.101935] systemd[1]: Detected architecture arm64.1239alice # [ 1.102337] systemd[1]: Detected architecture arm64.1240bob # [ 1.101944] systemd[1]: Running in initrd.1241bob # [ 1.102735] systemd[1]: Initializing machine ID from random generator.1242alice # [ 1.102347] systemd[1]: Running in initrd.1243bob # [ 1.103004] systemd[1]: Hostname set to <bob>.1244alice # [ 1.103255] systemd[1]: Initializing machine ID from random generator.1245alice # [ 1.103540] systemd[1]: Hostname set to <alice>.1246bob # [ 1.132258] 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.132461] 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.220075] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01249clare # [ 1.244298] systemd[1]: bpf-restrict-fs: LSM BPF program attached1250alice # [ 1.217806] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01251bob # [ 1.221337] 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.241975] systemd[1]: bpf-restrict-fs: LSM BPF program attached1253clare # [ 1.292622] systemd[1]: Queued start job for default target Initrd Default Target.1254clare # [ 1.297993] systemd[1]: Created slice Slice /system/modprobe.1255clare # [ 1.298136] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1256clare # [ 1.298165] systemd[1]: Expecting device /dev/disk/by-label/nixos...1257clare # [ 1.298184] systemd[1]: Reached target Path Units.1258clare # [ 1.298197] systemd[1]: Reached target Slice Units.1259clare # [ 1.298210] systemd[1]: Reached target Swaps.1260clare # [ 1.298221] systemd[1]: Reached target Timer Units.1261clare # [ 1.298355] systemd[1]: Listening on D-Bus System Message Bus Socket.1262clare # [ 1.298468] systemd[1]: Listening on Journal Socket (/dev/log).1263clare # [ 1.298579] systemd[1]: Listening on Journal Sockets.1264clare # [ 1.298649] systemd[1]: Listening on udev Control Socket.1265alice # [ 1.253178] systemd[1]: bpf-restrict-fs: LSM BPF program attached1266clare # [ 1.298694] systemd[1]: Listening on udev Kernel Socket.1267clare # [ 1.298708] systemd[1]: Reached target Socket Units.1268clare # [ 1.299770] systemd[1]: Starting Create List of Static Device Nodes...1269clare # [ 1.299819] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1270clare # [ 1.308846] systemd[1]: Mounting Kernel Configuration File System...1271clare # [ 1.319409] systemd[1]: Starting Journal Service...1272clare # [ 1.332161] systemd[1]: Starting Load Kernel Modules...1273clare # [ 1.332235] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1274clare # [ 1.339895] usb 1-2: new high-speed USB device number 3 using ehci-pci1275bob # [ 1.290598] systemd[1]: Queued start job for default target Initrd Default Target.1276bob # [ 1.298675] systemd[1]: Created slice Slice /system/modprobe.1277bob # [ 1.298821] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1278bob # [ 1.298853] systemd[1]: Expecting device /dev/disk/by-label/nixos...1279bob # [ 1.298875] systemd[1]: Reached target Path Units.1280bob # [ 1.298889] systemd[1]: Reached target Slice Units.1281bob # [ 1.298902] systemd[1]: Reached target Swaps.1282bob # [ 1.298914] systemd[1]: Reached target Timer Units.1283bob # [ 1.299048] systemd[1]: Listening on D-Bus System Message Bus Socket.1284bob # [ 1.299161] systemd[1]: Listening on Journal Socket (/dev/log).1285bob # [ 1.299275] systemd[1]: Listening on Journal Sockets.1286bob # [ 1.299344] systemd[1]: Listening on udev Control Socket.1287bob # [ 1.299387] systemd[1]: Listening on udev Kernel Socket.1288bob # [ 1.299400] systemd[1]: Reached target Socket Units.1289bob # [ 1.300489] systemd[1]: Starting Create List of Static Device Nodes...1290bob # [ 1.300539] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1291alice # [ 1.314911] systemd[1]: Queued start job for default target Initrd Default Target.1292clare # [ 1.360096] systemd[1]: Starting Coldplug All udev Devices...1293bob # [ 1.317296] systemd[1]: Mounting Kernel Configuration File System...1294clare # [ 1.368929] systemd[1]: Finished Create List of Static Device Nodes.1295alice # [ 1.319786] systemd[1]: Created slice Slice /system/modprobe.1296alice # [ 1.319933] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1297alice # [ 1.319965] systemd[1]: Expecting device /dev/disk/by-label/nixos...1298alice # [ 1.319989] systemd[1]: Reached target Path Units.1299alice # [ 1.320002] systemd[1]: Reached target Slice Units.1300alice # [ 1.320015] systemd[1]: Reached target Swaps.1301alice # [ 1.320026] systemd[1]: Reached target Timer Units.1302alice # [ 1.320159] systemd[1]: Listening on D-Bus System Message Bus Socket.1303alice # [ 1.320272] systemd[1]: Listening on Journal Socket (/dev/log).1304alice # [ 1.320386] systemd[1]: Listening on Journal Sockets.1305clare # [ 1.371917] systemd-journald[71]: Collecting audit messages is disabled.1306alice # [ 1.320454] systemd[1]: Listening on udev Control Socket.1307alice # [ 1.320499] systemd[1]: Listening on udev Kernel Socket.1308alice # [ 1.320513] systemd[1]: Reached target Socket Units.1309bob # [ 1.325322] systemd[1]: Starting Journal Service...1310alice # [ 1.327460] systemd[1]: Starting Create List of Static Device Nodes...1311alice # [ 1.327531] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1312clare # [ 1.376884] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1313clare # [ 1.377074] systemd[1]: Mounted Kernel Configuration File System.1314bob # [ 1.329662] systemd[1]: Starting Load Kernel Modules...1315bob # [ 1.329743] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1316alice # [ 1.333781] systemd[1]: Mounting Kernel Configuration File System...1317alice # [ 1.337662] usb 1-2: new high-speed USB device number 3 using ehci-pci1318bob # [ 1.339848] systemd[1]: Starting Coldplug All udev Devices...1319bob # [ 1.341191] usb 1-2: new high-speed USB device number 3 using ehci-pci1320clare # [ 1.390204] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1321alice # [ 1.341739] systemd[1]: Starting Journal Service...1322clare # [ 1.399949] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1323alice # [ 1.358479] systemd[1]: Starting Load Kernel Modules...1324alice # [ 1.358561] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1325bob # [ 1.365320] systemd[1]: Finished Create List of Static Device Nodes.1326clare # [ 1.425760] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01327alice # [ 1.374767] systemd[1]: Starting Coldplug All udev Devices...1328clare # [ 1.425988] [drm] features: -virgl +edid -resource_blob -host_visible1329alice # [ 1.377283] systemd-journald[71]: Collecting audit messages is disabled.1330clare # [ 1.425990] [drm] features: -context_init1331clare # [ 1.426491] [drm] number of scanouts: 11332clare # [ 1.426499] [drm] number of cap sets: 01333clare # [ 1.430171] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1334clare # [ 1.430179] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01335bob # [ 1.380868] systemd-journald[71]: Collecting audit messages is disabled.1336bob # [ 1.386308] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1337alice # [ 1.386672] systemd[1]: Finished Create List of Static Device Nodes.1338alice # [ 1.387384] systemd[1]: Mounted Kernel Configuration File System.1339clare # [ 1.440369] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1340clare # [ 1.441623] systemd[1]: Starting Create Static Device Nodes in /dev...1341bob # [ 1.393510] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1342alice # [ 1.394070] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1343bob # [ 1.401279] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1344clare # [ 1.453790] Console: switching to colour frame buffer device 160x501345clare # [ 1.454460] systemd-modules-load[73]: Inserted module 'dm_mod'1346clare # [ 1.461897] systemd[1]: Started Journal Service.1347clare # [ 1.456609] systemd-modules-load[73]: Module 'virtio_balloon' is built in1348bob # [ 1.413657] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1349bob # [ 1.418049] systemd[1]: Starting Create Static Device Nodes in /dev...1350bob # [ 1.418351] systemd[1]: Mounted Kernel Configuration File System.1351clare # [ 1.464674] systemd-modules-load[73]: Module 'virtio_console' is built in1352bob # [ 1.424261] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01353bob # [ 1.424485] [drm] features: -virgl +edid -resource_blob -host_visible1354bob # [ 1.424486] [drm] features: -context_init1355bob # [ 1.424936] [drm] number of scanouts: 11356bob # [ 1.424944] [drm] number of cap sets: 01357clare # [ 1.480441] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1358clare # [ 1.477036] systemd[1]: Finished Create Static Device Nodes in /dev.1359clare # [ 1.477885] systemd[1]: Reached target Preparation for Local File Systems.1360clare # [ 1.478495] systemd[1]: Reached target Local File Systems.1361bob # [ 1.433981] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1362bob # [ 1.433992] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01363alice # [ 1.434078] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1364alice # [ 1.435237] systemd[1]: Starting Create Static Device Nodes in /dev...1365clare # [ 1.480659] systemd[1]: Starting Create System Files and Directories...1366clare # [ 1.485180] systemd-modules-load[73]: Inserted module 'virtio_gpu'1367clare # [ 1.487748] systemd-modules-load[73]: Module 'virtio_rng' is built in1368alice # [ 1.443574] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1369clare # [ 1.496725] 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/input21370clare # [ 1.496901] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01371clare # [ 1.496109] systemd[1]: Starting Rule-based Manager for Device Events and Files...1372clare # [ 1.497049] systemd[1]: Finished Load Kernel Modules.1373bob # [ 1.452763] Console: switching to colour frame buffer device 160x501374alice # [ 1.462176] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1375alice # [ 1.461420] systemd-modules-load[73]: Inserted module 'dm_mod'1376bob # [ 1.468647] systemd[1]: Started Journal Service.1377alice # [ 1.467453] systemd[1]: Started Journal Service.1378alice # [ 1.464697] systemd-modules-load[73]: Module 'virtio_balloon' is built in1379alice # [ 1.468278] systemd-modules-load[73]: Module 'virtio_console' is built in1380bob # [ 1.476815] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1381alice # [ 1.477436] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01382bob # [ 1.472443] systemd-modules-load[72]: Inserted module 'dm_mod'1383bob # [ 1.473356] systemd-modules-load[72]: Module 'virtio_balloon' is built in1384clare # [ 1.524149] systemd[1]: Starting Apply Kernel Variables...1385alice # [ 1.476203] systemd[1]: Finished Create Static Device Nodes in /dev.1386bob # [ 1.476773] systemd-modules-load[72]: Module 'virtio_console' is built in1387alice # [ 1.481106] systemd[1]: Reached target Preparation for Local File Systems.1388bob # [ 1.479632] systemd[1]: Finished Create Static Device Nodes in /dev.1389alice # [ 1.482670] systemd[1]: Reached target Local File Systems.1390alice # [ 1.485884] [drm] features: -virgl +edid -resource_blob -host_visible1391alice # [ 1.485896] [drm] features: -context_init1392alice # [ 1.486470] [drm] number of scanouts: 11393alice # [ 1.486478] [drm] number of cap sets: 01394alice # [ 1.489275] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1395alice # [ 1.489285] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01396alice # [ 1.489461] systemd[1]: Starting Create System Files and Directories...1397bob # [ 1.489932] systemd[1]: Reached target Preparation for Local File Systems.1398bob # [ 1.490833] systemd[1]: Reached target Local File Systems.1399bob # [ 1.491495] systemd[1]: Starting Create System Files and Directories...1400bob # [ 1.497443] 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/input21401bob # [ 1.497631] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01402clare # [ 1.544334] systemd[1]: Finished Create System Files and Directories.1403clare # [ 1.546198] systemd[1]: Finished Apply Kernel Variables.1404alice # [ 1.503988] 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/input21405alice # [ 1.504091] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01406bob # [ 1.504527] systemd-modules-load[72]: Inserted module 'virtio_gpu'1407bob # [ 1.505366] systemd-modules-load[72]: Module 'virtio_rng' is built in1408bob # [ 1.505929] systemd[1]: Starting Rule-based Manager for Device Events and Files...1409bob # [ 1.506558] systemd[1]: Finished Load Kernel Modules.1410bob # [ 1.508592] systemd[1]: Finished Create System Files and Directories.1411alice # [ 1.513987] Console: switching to colour frame buffer device 160x501412alice # [ 1.516130] systemd[1]: Starting Rule-based Manager for Device Events and Files...1413clare # [ 1.566855] systemd-udevd[84]: Using default interface naming scheme 'v261'.1414bob # [ 1.521136] systemd[1]: Starting Apply Kernel Variables...1415alice # [ 1.530634] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1416clare # [ 1.584245] systemd[1]: Started Rule-based Manager for Device Events and Files.1417alice # [ 1.541668] systemd-modules-load[73]: Inserted module 'virtio_gpu'1418alice # [ 1.542351] systemd-modules-load[73]: Module 'virtio_rng' is built in1419bob # [ 1.545084] systemd[1]: Finished Apply Kernel Variables.1420alice # [ 1.547711] systemd[1]: Finished Load Kernel Modules.1421alice # [ 1.548363] systemd[1]: Starting Apply Kernel Variables...1422alice # [ 1.563394] systemd[1]: Finished Create System Files and Directories.1423alice # [ 1.564590] systemd[1]: Finished Apply Kernel Variables.1424bob # [ 1.569098] systemd-udevd[80]: Using default interface naming scheme 'v261'.1425alice # [ 1.586625] systemd-udevd[84]: Using default interface naming scheme 'v261'.1426bob # [ 1.588407] systemd[1]: Started Rule-based Manager for Device Events and Files.1427clare # [ 1.644478] systemd[1]: Starting Virtual Console Setup...1428alice # [ 1.604296] systemd[1]: Started Rule-based Manager for Device Events and Files.1429bob # [ 1.636078] systemd[1]: Starting Virtual Console Setup...1430clare # [ 1.688455] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1431clare # [ 1.690768] systemd[1]: Finished Virtual Console Setup.1432alice # [ 1.656744] systemd[1]: Starting Virtual Console Setup...1433bob # [ 1.682787] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1434bob # [ 1.685134] systemd[1]: Finished Virtual Console Setup.1435alice # [ 1.704327] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1436alice # [ 1.706750] systemd[1]: Finished Virtual Console Setup.1437clare # [ 1.905752] systemd[1]: Finished Coldplug All udev Devices.1438clare # [ 1.906336] systemd[1]: Reached target System Initialization.1439clare # [ 1.906852] systemd[1]: Reached target Basic System.1440bob # [ 1.904969] systemd[1]: Finished Coldplug All udev Devices.1441bob # [ 1.905550] systemd[1]: Reached target System Initialization.1442bob # [ 1.906068] systemd[1]: Reached target Basic System.1443alice # [ 1.914450] systemd[1]: Finished Coldplug All udev Devices.1444alice # [ 1.915054] systemd[1]: Reached target System Initialization.1445alice # [ 1.916191] systemd[1]: Reached target Basic System.1446clare # [ 2.005824] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1447clare # [ 2.019803] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.1448bob # [ 2.003051] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1449alice # [ 2.019818] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1450bob # [ 2.021144] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1451clare # [ 2.080417] systemd[1]: Found device /dev/disk/by-label/nixos.1452alice # [ 2.033709] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1453clare # [ 2.093056] systemd[1]: Reached target Initrd Root Device.1454clare # [ 2.098084] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1455clare # [ 2.134974] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1456alice # [ 2.098164] systemd[1]: Found device /dev/disk/by-label/nixos.1457clare # [ 2.147508] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1458bob # [ 2.109298] systemd[1]: Found device /dev/disk/by-label/nixos.1459alice # [ 2.112337] systemd[1]: Reached target Initrd Root Device.1460bob # [ 2.111430] systemd[1]: Reached target Initrd Root Device.1461alice # [ 2.116431] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1462bob # [ 2.116081] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1463bob # [ 2.152572] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1464alice # [ 2.158883] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1465bob # [ 2.167835] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1466alice # [ 2.170815] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1467clare # [ 2.362192] systemd[1]: Mounting /sysroot...1468bob # [ 2.336136] systemd[1]: Mounting /sysroot...1469clare # [ 2.398647] EXT4-fs (vda): mounted filesystem ac2a4e0d-e1d9-4b2f-95a2-3650b3b60bdc r/w with ordered data mode. Quota mode: none.1470clare # [ 2.395168] systemd[1]: Mounted /sysroot.1471clare # [ 2.396703] systemd[1]: Reached target Initrd Root File System.1472clare # [ 2.400161] systemd[1]: Starting Mountpoints Configured in the Real Root...1473bob # [ 2.370492] EXT4-fs (vda): mounted filesystem ca293e06-3a90-4536-8cd5-57b892a56c07 r/w with ordered data mode. Quota mode: none.1474bob # [ 2.365810] systemd[1]: Mounted /sysroot.1475bob # [ 2.367493] systemd[1]: Reached target Initrd Root File System.1476clare # [ 2.419475] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1477bob # [ 2.371092] systemd[1]: Starting Mountpoints Configured in the Real Root...1478clare # [ 2.426430] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1479clare # [ 2.428087] systemd[1]: Reloading...1480alice # [ 2.382576] systemd[1]: Mounting /sysroot...1481bob # [ 2.390923] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1482bob # [ 2.396793] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1483bob # [ 2.397841] systemd[1]: Reloading...1484alice # [ 2.411581] EXT4-fs (vda): mounted filesystem ca69e2fd-0d6e-4018-9de7-1c03a241e46b r/w with ordered data mode. Quota mode: none.1485alice # [ 2.410145] systemd[1]: Mounted /sysroot.1486alice # [ 2.411674] systemd[1]: Reached target Initrd Root File System.1487alice # [ 2.417857] systemd[1]: Mounting /sysroot/nix/.ro-store...1488alice # [ 2.427744] systemd[1]: Mounting /sysroot/nix/.rw-store...1489alice # [ 2.440094] systemd[1]: Mounting /sysroot/run...1490alice # [ 2.463612] systemd[1]: Mounting /sysroot/tmp/shared...1491alice # [ 2.492338] fuse: init (API version 7.45)1492alice # [ 2.489302] systemd[1]: Mounting /sysroot/tmp/xchg...1493alice # [ 2.499186] systemd[1]: Starting Mountpoints Configured in the Real Root...1494alice # [ 2.505775] systemd[1]: Mounted /sysroot/nix/.rw-store.1495alice # [ 2.510222] virtiofs virtio6: discovered new tag: nix-store1496alice # [ 2.510762] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1497alice # [ 2.527106] virtiofs virtio7: discovered new tag: shared1498alice # [ 2.527626] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1499alice # [ 2.529353] virtiofs virtio8: discovered new tag: xchg1500alice # [ 2.531314] systemd[1]: Starting rw-sysroot-nix-store.service...1501alice # [ 2.534840] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1502alice # [ 2.534012] systemd[1]: Mounted /sysroot/run.1503alice # [ 2.550414] systemd[1]: Mounted /sysroot/nix/.ro-store.1504clare # [ 2.606940] systemd[1]: Reloading finished in 178 ms.1505alice # [ 2.559259] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.1506alice # [ 2.565579] systemd[1]: Mounted /sysroot/tmp/xchg.1507alice # [ 2.567824] systemd[1]: Mounted /sysroot/tmp/shared.1508bob # [ 2.572785] systemd[1]: Reloading finished in 172 ms.1509alice # [ 2.575209] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...1510alice # [ 2.579094] systemd[1]: Reloading...1511clare # [ 2.628394] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1512clare # [ 2.631008] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1513clare # [ 2.633383] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1514clare # [ 2.635221] systemd[1]: Finished Mountpoints Configured in the Real Root.1515clare # [ 2.636777] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1516bob # [ 2.599344] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1517bob # [ 2.601732] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1518bob # [ 2.605345] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1519bob # [ 2.607617] systemd[1]: Finished Mountpoints Configured in the Real Root.1520bob # [ 2.609192] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1521alice # [ 2.776111] systemd[1]: Reloading finished in 199 ms.1522clare # [ 2.838288] fuse: init (API version 7.45)1523alice # [ 2.805025] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...1524alice # [ 2.807459] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1525alice # [ 2.809451] systemd[1]: Finished rw-sysroot-nix-store.service.1526alice # [ 2.812820] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...1527alice # [ 2.817884] systemd[1]: Starting rw-sysroot-nix-store.service...1528clare # [ 2.876971] virtiofs virtio6: discovered new tag: nix-store1529clare # [ 2.877526] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1530alice # [ 2.825701] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1531bob # [ 2.831644] fuse: init (API version 7.45)1532alice # [ 2.833949] systemd[1]: Finished Mountpoints Configured in the Real Root.1533alice # [ 2.834632] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1534alice # [ 2.836694] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1535alice # [ 2.837613] systemd[1]: Finished rw-sysroot-nix-store.service.1536clare # [ 2.886408] (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 directory1537clare # [ 2.891189] (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 directory1538clare # [ 2.902632] virtiofs virtio7: discovered new tag: shared1539clare # [ 2.903178] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1540bob # [ 2.861442] virtiofs virtio6: discovered new tag: nix-store1541bob # [ 2.861940] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1542clare # [ 2.916234] virtiofs virtio8: discovered new tag: xchg1543clare # [ 2.916728] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1544clare # [ 2.922103] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1545clare # [ 2.923406] systemd[1]: Stopped Virtual Console Setup.1546bob # [ 2.872707] (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 directory1547clare # [ 2.925078] systemd[1]: Stopping Virtual Console Setup...1548clare # [ 2.926633] systemd[1]: Starting Virtual Console Setup...1549bob # [ 2.884736] virtiofs virtio7: discovered new tag: shared1550bob # [ 2.877801] (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 directory1551clare # [ 2.938816] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1552bob # [ 2.896155] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1553clare # [ 2.940562] systemd[1]: Stopped Virtual Console Setup.1554clare # [ 2.941394] systemd[1]: Starting Virtual Console Setup...1555bob # [ 2.892260] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1556bob # [ 2.893575] systemd[1]: Stopped Virtual Console Setup.1557bob # [ 2.894324] systemd[1]: Stopping Virtual Console Setup...1558bob # [ 2.905115] virtiofs virtio8: discovered new tag: xchg1559bob # [ 2.898101] systemd[1]: Starting Virtual Console Setup...1560bob # [ 2.910611] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1561clare # [ 2.963374] systemd-vconsole-setup[139]: Configuration of first virtual console was skipped, ignoring remaining ones.1562clare # [ 2.965835] systemd[1]: Finished Virtual Console Setup.1563bob # [ 2.921406] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1564bob # [ 2.922128] systemd[1]: Stopped Virtual Console Setup.1565bob # [ 2.924154] systemd[1]: Starting Virtual Console Setup...1566bob # [ 2.937570] systemd-vconsole-setup[139]: Configuration of first virtual console was skipped, ignoring remaining ones.1567bob # [ 2.939761] systemd[1]: Finished Virtual Console Setup.1568alice # [ 3.026272] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1569alice # [ 3.031889] (udev-worker)[95]: 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 directory1570alice # [ 3.046150] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1571alice # [ 3.047859] systemd[1]: Stopped Virtual Console Setup.1572alice # [ 3.049952] systemd[1]: Stopping Virtual Console Setup...1573alice # [ 3.052120] systemd[1]: Starting Virtual Console Setup...1574alice # [ 3.075629] systemd-vconsole-setup[152]: Configuration of first virtual console was skipped, ignoring remaining ones.1575alice # [ 3.078346] systemd[1]: Finished Virtual Console Setup.1576clare # [ 3.364877] systemd[1]: Mounting /sysroot/nix/.ro-store...1577clare # [ 3.376379] systemd[1]: Mounting /sysroot/nix/.rw-store...1578clare # [ 3.379751] systemd[1]: Mounting /sysroot/run...1579bob # [ 3.334787] systemd[1]: Mounting /sysroot/nix/.ro-store...1580clare # [ 3.392350] systemd[1]: Mounting /sysroot/tmp/shared...1581bob # [ 3.343890] systemd[1]: Mounting /sysroot/nix/.rw-store...1582bob # [ 3.350087] systemd[1]: Mounting /sysroot/run...1583bob # [ 3.360215] systemd[1]: Mounting /sysroot/tmp/shared...1584clare # [ 3.411920] systemd[1]: Mounting /sysroot/tmp/xchg...1585bob # [ 3.372185] systemd[1]: Mounting /sysroot/tmp/xchg...1586bob # [ 3.377754] systemd[1]: Mounted /sysroot/nix/.rw-store.1587alice # [ 3.383735] systemd[1]: Mounting /sysroot/nix/store...1588clare # [ 3.446065] systemd[1]: Mounted /sysroot/nix/.ro-store.1589bob # [ 3.402785] systemd[1]: Starting rw-sysroot-nix-store.service...1590bob # [ 3.403753] systemd[1]: Mounted /sysroot/nix/.ro-store.1591clare # [ 3.454990] systemd[1]: Mounted /sysroot/nix/.rw-store.1592clare # [ 3.456736] systemd[1]: Mounted /sysroot/run.1593bob # [ 3.410313] systemd[1]: Mounted /sysroot/run.1594clare # [ 3.461647] systemd[1]: Mounted /sysroot/tmp/shared.1595clare # [ 3.463441] systemd[1]: Mounted /sysroot/tmp/xchg.1596bob # [ 3.413370] systemd[1]: Mounted /sysroot/tmp/shared.1597bob # [ 3.415388] systemd[1]: Mounted /sysroot/tmp/xchg.1598clare # [ 3.467769] systemd[1]: Starting rw-sysroot-nix-store.service...1599bob # [ 3.426815] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1600bob # [ 3.427947] systemd[1]: Finished rw-sysroot-nix-store.service.1601alice # [ 3.432417] systemd[1]: Mounted /sysroot/nix/store.1602alice # [ 3.434705] systemd[1]: Reached target Initrd File Systems.1603alice # [ 3.438765] systemd[1]: Starting Find NixOS closure...1604clare # [ 3.488969] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1605clare # [ 3.490486] systemd[1]: Finished rw-sysroot-nix-store.service.1606alice # [ 3.448302] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1607alice # [ 3.484374] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1608alice # [ 3.487546] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1609alice # [ 3.499829] systemd[1]: Finished Find NixOS closure.1610alice # [ 3.501968] systemd[1]: Reached target Initrd Default Target.1611alice # [ 3.503157] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1612alice # [ 3.532886] systemd[1]: initrd-cleanup.service: Deactivated successfully.1613alice # [ 3.534234] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1614alice # [ 3.537428] systemd[1]: Stopped target Initrd Default Target.1615alice # [ 3.539901] systemd[1]: Stopped target Basic System.1616alice # [ 3.540707] systemd[1]: Stopped target Initrd Root Device.1617alice # [ 3.542042] systemd[1]: Stopped target Path Units.1618alice # [ 3.543297] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1619alice # [ 3.546010] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1620alice # [ 3.552752] systemd[1]: Stopped target Slice Units.1621alice # [ 3.553491] systemd[1]: Stopped target Socket Units.1622alice # [ 3.554058] systemd[1]: Stopped target System Initialization.1623alice # [ 3.554751] systemd[1]: Stopped target Swaps.1624alice # [ 3.555252] systemd[1]: Stopped target Timer Units.1625alice # [ 3.555792] systemd[1]: dbus.socket: Deactivated successfully.1626alice # [ 3.559541] systemd[1]: Closed D-Bus System Message Bus Socket.1627alice # [ 3.560299] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1628alice # [ 3.561343] systemd[1]: Stopped Find NixOS closure.1629alice # [ 3.561882] systemd[1]: Starting rw-sysroot-nix-store.service...1630alice # [ 3.562500] systemd[1]: systemd-sysctl.service: Deactivated successfully.1631alice # [ 3.563172] systemd[1]: Stopped Apply Kernel Variables.1632alice # [ 3.563716] systemd[1]: systemd-modules-load.service: Deactivated successfully.1633alice # [ 3.569953] systemd[1]: Stopped Load Kernel Modules.1634alice # [ 3.570528] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1635alice # [ 3.574547] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1636alice # [ 3.576226] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1637alice # [ 3.580321] systemd[1]: Stopped Create System Files and Directories.1638alice # [ 3.580936] systemd[1]: Stopped target Local File Systems.1639alice # [ 3.581536] systemd[1]: Stopped target Preparation for Local File Systems.1640alice # [ 3.582116] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1641alice # [ 3.582744] systemd[1]: Stopped Coldplug All udev Devices.1642alice # [ 3.583231] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1643alice # [ 3.583854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1644alice # [ 3.586330] systemd[1]: Stopped Virtual Console Setup.1645alice # [ 3.586812] systemd[1]: systemd-udevd.service: Deactivated successfully.1646alice # [ 3.587404] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1647alice # [ 3.588081] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1648alice # [ 3.588707] systemd[1]: Closed udev Control Socket.1649alice # [ 3.589177] systemd[1]: Starting Cleanup udev Database...1650alice # [ 3.589680] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1651alice # [ 3.590350] systemd[1]: Stopped Create Static Device Nodes in /dev.1652alice # [ 3.590908] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1653alice # [ 3.591615] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1654alice # [ 3.595230] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1655alice # [ 3.596512] systemd[1]: Stopped Create List of Static Device Nodes.1656alice # [ 3.600189] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1657alice # [ 3.600840] systemd[1]: Finished rw-sysroot-nix-store.service.1658alice # [ 3.612569] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1659alice # [ 3.613304] systemd[1]: Finished Cleanup udev Database.1660alice # [ 3.617390] systemd[1]: Reached target Switch Root.1661alice # [ 3.617878] systemd[1]: Starting NixOS Activation...1662alice # [ 3.689326] initrd-nixos-activation-start[175]: booting system configuration /nix/store/0kxwi100mqm1947haa05cgfplxnszjgr-nixos-system-alice-test1663alice # [ 3.716982] initrd-nixos-activation-start[175]: running activation script...1664alice # [ 3.922613] initrd-nixos-activation-start[198]: setting up /etc...1665alice # [ 4.011248] initrd-nixos-activation-start[198]: setting up age secrets...1666alice # [ 4.070772] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1667alice # [ 4.072119] systemd[1]: Finished NixOS Activation.1668alice # [ 4.073378] systemd[1]: Starting Switch Root...1669alice # [ 4.088662] systemd[1]: Switching root.1670alice # [ 4.266165] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1671clare # [ 4.363203] systemd[1]: Mounting /sysroot/nix/store...1672bob # [ 4.333917] systemd[1]: Mounting /sysroot/nix/store...1673clare # [ 4.412294] systemd[1]: Mounted /sysroot/nix/store.1674clare # [ 4.414745] systemd[1]: Reached target Initrd File Systems.1675clare # [ 4.418562] systemd[1]: Starting Find NixOS closure...1676clare # [ 4.425724] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1677bob # [ 4.383596] systemd[1]: Mounted /sysroot/nix/store.1678bob # [ 4.385945] systemd[1]: Reached target Initrd File Systems.1679bob # [ 4.389880] systemd[1]: Starting Find NixOS closure...1680bob # [ 4.397231] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1681clare # [ 4.458852] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1682clare # [ 4.460247] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1683clare # [ 4.476521] systemd[1]: Finished Find NixOS closure.1684clare # [ 4.479036] systemd[1]: Reached target Initrd Default Target.1685clare # [ 4.484316] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1686bob # [ 4.442014] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1687bob # [ 4.448215] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1688bob # [ 4.461134] systemd[1]: Finished Find NixOS closure.1689bob # [ 4.463321] systemd[1]: Reached target Initrd Default Target.1690clare # [ 4.515472] systemd[1]: Stopped target Initrd Default Target.1691clare # [ 4.516436] systemd[1]: Stopped target Basic System.1692clare # [ 4.517148] systemd[1]: Stopped target Initrd Root Device.1693clare # [ 4.517980] systemd[1]: Stopped target Path Units.1694clare # [ 4.518636] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1695bob # [ 4.468282] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1696clare # [ 4.522138] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1697clare # [ 4.524760] systemd[1]: Stopped target Slice Units.1698clare # [ 4.528159] systemd[1]: Stopped target Socket Units.1699clare # [ 4.529625] systemd[1]: Stopped target System Initialization.1700clare # [ 4.531617] systemd[1]: Stopped target Swaps.1701clare # [ 4.533727] systemd[1]: Stopped target Timer Units.1702clare # [ 4.535276] systemd[1]: dbus.socket: Deactivated successfully.1703clare # [ 4.540198] systemd[1]: Closed D-Bus System Message Bus Socket.1704clare # [ 4.540911] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1705clare # [ 4.541968] systemd[1]: Stopped Find NixOS closure.1706clare # [ 4.542817] systemd[1]: Starting rw-sysroot-nix-store.service...1707clare # [ 4.543566] systemd[1]: systemd-sysctl.service: Deactivated successfully.1708bob # [ 4.495697] systemd[1]: Stopped target Initrd Default Target.1709bob # [ 4.497405] systemd[1]: Stopped target Basic System.1710bob # [ 4.500406] systemd[1]: Stopped target Initrd Root Device.1711bob # [ 4.501834] systemd[1]: Stopped target Path Units.1712bob # [ 4.504246] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1713clare # [ 4.556263] systemd[1]: Stopped Apply Kernel Variables.1714clare # [ 4.556898] systemd[1]: systemd-modules-load.service: Deactivated successfully.1715bob # [ 4.506325] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1716clare # [ 4.558352] systemd[1]: Stopped Load Kernel Modules.1717clare # [ 4.558931] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1718clare # [ 4.559745] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1719bob # [ 4.510266] systemd[1]: Stopped target Slice Units.1720clare # [ 4.561675] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1721clare # [ 4.562371] systemd[1]: Stopped Create System Files and Directories.1722clare # [ 4.562971] systemd[1]: Stopped target Local File Systems.1723bob # [ 4.512330] systemd[1]: Stopped target Socket Units.1724clare # [ 4.563499] systemd[1]: Stopped target Preparation for Local File Systems.1725bob # [ 4.516595] systemd[1]: Stopped target System Initialization.1726bob # [ 4.518337] systemd[1]: Stopped target Swaps.1727clare # [ 4.569076] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1728clare # [ 4.570005] systemd[1]: Stopped Coldplug All udev Devices.1729bob # [ 4.519917] systemd[1]: Stopped target Timer Units.1730clare # [ 4.572296] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1731clare # [ 4.572977] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1732bob # [ 4.522698] systemd[1]: dbus.socket: Deactivated successfully.1733clare # [ 4.576301] systemd[1]: Stopped Virtual Console Setup.1734clare # [ 4.576829] systemd[1]: initrd-cleanup.service: Deactivated successfully.1735clare # [ 4.577613] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1736clare # [ 4.578193] systemd[1]: systemd-udevd.service: Deactivated successfully.1737bob # [ 4.528314] systemd[1]: Closed D-Bus System Message Bus Socket.1738clare # [ 4.580102] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1739clare # [ 4.580763] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1740bob # [ 4.531790] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1741clare # [ 4.584617] systemd[1]: Closed udev Control Socket.1742bob # [ 4.534131] systemd[1]: Stopped Find NixOS closure.1743clare # [ 4.585118] systemd[1]: Starting Cleanup udev Database...1744bob # [ 4.534885] systemd[1]: Starting rw-sysroot-nix-store.service...1745clare # [ 4.585632] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1746clare # [ 4.586300] systemd[1]: Stopped Create Static Device Nodes in /dev.1747bob # [ 4.535652] systemd[1]: systemd-sysctl.service: Deactivated successfully.1748clare # [ 4.588827] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1749clare # [ 4.589599] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1750clare # [ 4.592154] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1751clare # [ 4.593018] systemd[1]: Stopped Create List of Static Device Nodes.1752clare # [ 4.593644] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1753bob # [ 4.544236] systemd[1]: Stopped Apply Kernel Variables.1754bob # [ 4.544967] systemd[1]: systemd-modules-load.service: Deactivated successfully.1755bob # [ 4.545882] systemd[1]: Stopped Load Kernel Modules.1756clare # [ 4.597220] systemd[1]: Finished rw-sysroot-nix-store.service.1757bob # [ 4.546469] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1758bob # [ 4.547388] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1759clare # [ 4.600392] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1760clare # [ 4.601103] systemd[1]: Finished Cleanup udev Database.1761clare # [ 4.601604] systemd[1]: Reached target Switch Root.1762clare # [ 4.602064] systemd[1]: Starting NixOS Activation...1763bob # [ 4.553280] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1764bob # [ 4.555164] systemd[1]: Stopped Create System Files and Directories.1765bob # [ 4.556110] systemd[1]: Stopped target Local File Systems.1766bob # [ 4.557714] systemd[1]: Stopped target Preparation for Local File Systems.1767bob # [ 4.560371] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1768bob # [ 4.561151] systemd[1]: Stopped Coldplug All udev Devices.1769bob # [ 4.562311] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1770bob # [ 4.564198] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1771bob # [ 4.566907] systemd[1]: Stopped Virtual Console Setup.1772bob # [ 4.567496] systemd[1]: systemd-udevd.service: Deactivated successfully.1773bob # [ 4.568406] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1774bob # [ 4.569138] systemd[1]: initrd-cleanup.service: Deactivated successfully.1775bob # [ 4.569791] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1776bob # [ 4.570421] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1777bob # [ 4.571151] systemd[1]: Closed udev Control Socket.1778bob # [ 4.571645] systemd[1]: Starting Cleanup udev Database...1779bob # [ 4.572265] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1780bob # [ 4.572973] systemd[1]: Stopped Create Static Device Nodes in /dev.1781bob # [ 4.573571] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1782bob # [ 4.574331] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1783bob # [ 4.575189] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1784bob # [ 4.579722] systemd[1]: Stopped Create List of Static Device Nodes.1785bob # [ 4.580647] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1786bob # [ 4.584227] systemd[1]: Finished rw-sysroot-nix-store.service.1787bob # [ 4.598389] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1788bob # [ 4.599609] systemd[1]: Finished Cleanup udev Database.1789bob # [ 4.604894] systemd[1]: Reached target Switch Root.1790bob # [ 4.605463] systemd[1]: Starting NixOS Activation...1791clare # [ 4.676380] initrd-nixos-activation-start[175]: booting system configuration /nix/store/6grzaynwk99q3ylk0nxx1cpv82nxyb56-nixos-system-clare-test1792clare # [ 4.704753] initrd-nixos-activation-start[175]: running activation script...1793bob # [ 4.681747] initrd-nixos-activation-start[174]: booting system configuration /nix/store/y4cm46pm38139pfhcscs8ifakphpsk33-nixos-system-bob-test1794bob # [ 4.710061] initrd-nixos-activation-start[174]: running activation script...1795clare # [ 4.934182] initrd-nixos-activation-start[198]: setting up /etc...1796bob # [ 4.940505] initrd-nixos-activation-start[197]: setting up /etc...1797clare # [ 5.025091] initrd-nixos-activation-start[198]: setting up age secrets...1798alice # [ 5.022491] 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)1799alice # [ 5.022588] systemd[1]: Detected virtualization qemu.1800alice # [ 5.022645] systemd[1]: Detected architecture arm64.1801alice # [ 5.022815] systemd[1]: Detected first boot.1802alice # [ 5.025121] systemd[1]: Initializing machine ID from random generator.1803bob # [ 5.036356] initrd-nixos-activation-start[197]: setting up age secrets...1804clare # [ 5.087141] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1805clare # [ 5.089019] systemd[1]: Finished NixOS Activation.1806clare # [ 5.089817] systemd[1]: Starting Switch Root...1807clare # [ 5.108869] systemd[1]: Switching root.1808bob # [ 5.114530] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1809bob # [ 5.116178] systemd[1]: Finished NixOS Activation.1810bob # [ 5.117258] systemd[1]: Starting Switch Root...1811bob # [ 5.132819] systemd[1]: Switching root.1812alice # [ 5.172646] systemd[1]: bpf-restrict-fs: LSM BPF program attached1813clare # [ 5.288467] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1814bob # [ 5.313635] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1815alice # [ 5.328802] systemd[1]: Applying preset policy.1816alice # [ 5.495838] systemd[1]: Populated /etc with preset unit settings.1817alice # [ 5.716699] systemd[1]: initrd-switch-root.service: Deactivated successfully.1818alice # [ 5.716989] systemd[1]: Stopped initrd-switch-root.service.1819alice # [ 5.719853] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1820alice # [ 5.720681] systemd[1]: Created slice Slice /system/getty.1821alice # [ 5.721224] systemd[1]: Created slice User and Session Slice.1822alice # [ 5.724029] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1823alice # [ 5.724585] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1824alice # [ 5.725136] systemd[1]: Expecting device /dev/hvc0...1825alice # [ 5.727801] systemd[1]: Expecting device /dev/ttyAMA0...1826alice # [ 5.728285] systemd[1]: Reached target Local Encrypted Volumes.1827alice # [ 5.728831] systemd[1]: Stopped target initrd-fs.target.1828alice # [ 5.729363] systemd[1]: Stopped target initrd-root-fs.target.1829alice # [ 5.732161] systemd[1]: Stopped target initrd-switch-root.target.1830alice # [ 5.732634] systemd[1]: Reached target Virtual Machines and Containers.1831alice # [ 5.733192] systemd[1]: Reached target Path Units.1832alice # [ 5.735624] systemd[1]: Reached target Remote File Systems.1833alice # [ 5.736073] systemd[1]: Reached target Slice Units.1834alice # [ 5.736607] systemd[1]: Reached target Swaps.1835alice # [ 5.739889] systemd[1]: Listening on Query the User Interactively for a Password.1836alice # [ 5.742808] systemd[1]: Listening on Process Core Dump Socket.1837alice # [ 5.744443] systemd[1]: Listening on Credential Encryption/Decryption.1838clare # [ 5.791238] 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)1839alice # [ 5.747292] systemd[1]: Listening on Factory Reset Management.1840clare # [ 5.791347] systemd[1]: Detected virtualization qemu.1841alice # [ 5.747832] systemd[1]: Listening on Hostname Service Socket.1842clare # [ 5.791407] systemd[1]: Detected architecture arm64.1843clare # [ 5.791518] systemd[1]: Detected first boot.1844alice # [ 5.751558] systemd[1]: Starting Journal Log Access Socket...1845alice # [ 5.752932] systemd[1]: Listening on Journal Audit Socket.1846clare # [ 5.805137] systemd[1]: Initializing machine ID from random generator.1847alice # [ 5.757668] systemd[1]: Listening on Console Output Muting Service Socket.1848alice # [ 5.758272] systemd[1]: Listening on Network Management Metrics Varlink Socket.1849alice # [ 5.758911] systemd[1]: Listening on Network Management Varlink Socket.1850alice # [ 5.759506] systemd[1]: Listening on Network Management Netlink Socket.1851alice # [ 5.760142] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1852alice # [ 5.760637] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1853alice # [ 5.761146] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1854alice # [ 5.769427] systemd[1]: Listening on Disk Repartitioning Service Socket.1855alice # [ 5.770543] systemd[1]: Listening on Resolve Monitor Varlink Socket.1856alice # [ 5.771248] systemd[1]: Listening on Resolve Service Varlink Socket.1857alice # [ 5.771846] systemd[1]: Listening on udev Control Socket.1858alice # [ 5.772392] systemd[1]: Listening on udev Varlink Socket.1859alice # [ 5.776500] systemd[1]: Mounting Huge Pages File System...1860alice # [ 5.779213] systemd[1]: Mounting POSIX Message Queue File System...1861alice # [ 5.790023] systemd[1]: Mounting Kernel Debug File System...1862alice # [ 5.797463] systemd[1]: Mounting Kernel Trace File System...1863alice # [ 5.808479] systemd[1]: Starting Create List of Static Device Nodes...1864alice # [ 5.808911] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1865alice # [ 5.818638] systemd[1]: Mounting Kernel Configuration File System...1866alice # [ 5.822241] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1867alice # [ 5.823433] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1868alice # [ 5.823878] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1869alice # [ 5.845949] systemd[1]: Mounting FUSE Control File System...1870alice # [ 5.846426] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671871bob # [ 5.849300] 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)1872bob # [ 5.849395] systemd[1]: Detected virtualization qemu.1873bob # [ 5.849453] systemd[1]: Detected architecture arm64.1874bob # [ 5.849565] systemd[1]: Detected first boot.1875bob # [ 5.852015] systemd[1]: Initializing machine ID from random generator.1876alice # [ 5.870394] systemd[1]: Starting Journal Service...1877alice # [ 5.885275] systemd[1]: Starting Load Kernel Modules...1878clare # [ 5.937712] systemd[1]: bpf-restrict-fs: LSM BPF program attached1879alice # [ 5.897118] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1880alice # [ 5.910705] systemd[1]: Starting Remount Root and Kernel File Systems...1881alice # [ 5.911086] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1882alice # [ 5.934497] systemd[1]: Starting Coldplug All udev Devices...1883alice # [ 5.936521] systemd[1]: Listening on Journal Log Access Socket.1884alice # [ 5.936927] systemd[1]: Mounted Huge Pages File System.1885alice # [ 5.937281] systemd[1]: Mounted POSIX Message Queue File System.1886alice # [ 5.943565] systemd-journald[283]: Collecting audit messages is enabled.1887alice # [ 5.947382] systemd[1]: Mounted Kernel Debug File System.1888alice # [ 5.947957] systemd[1]: Mounted Kernel Trace File System.1889alice # [ 5.952364] systemd[1]: Finished Create List of Static Device Nodes.1890alice # [ 5.952912] systemd[1]: Mounted Kernel Configuration File System.1891alice # [ 5.954010] systemd[1]: Queued start job for default target Multi-User System.1892alice # [ 5.955691] systemd[1]: systemd-journald.service: Deactivated successfully.1893alice # [ 5.968188] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1894alice # [ 5.968654] systemd[1]: Started Journal Service.1895bob # [ 5.992818] systemd[1]: bpf-restrict-fs: LSM BPF program attached1896alice # [ 5.989376] systemd-modules-load[284]: Module 'atkbd' is built in1897alice # [ 5.994471] systemd-modules-load[284]: Module 'loop' is built in1898alice # [ 6.004876] systemd[1]: Finished Load Kernel Modules.1899alice # [ 6.009652] systemd[1]: Starting Firewall...1900alice # [ 6.016168] systemd[1]: Starting Apply Kernel Variables...1901clare # [ 6.082680] systemd[1]: Applying preset policy.1902alice # [ 6.036391] EXT4-fs (vda): re-mounted ca69e2fd-0d6e-4018-9de7-1c03a241e46b.1903alice # [ 6.065564] systemd[1]: Finished Remount Root and Kernel File Systems.1904alice # [ 6.066216] systemd[1]: Listening on Disk Image Download Service Socket.1905alice # [ 6.071006] systemd[1]: Starting Flush Journal to Persistent Storage...1906alice # [ 6.071649] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1907bob # [ 6.079932] systemd[1]: Applying preset policy.1908alice # [ 6.075177] systemd[1]: Starting Load/Save OS Random Seed...1909alice # [ 6.075720] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1910alice # [ 6.084266] systemd[1]: Mounted FUSE Control File System.1911alice # [ 6.097913] systemd-oomd[285]: No swap; memory pressure usage will be degraded1912alice # [ 6.112372] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1913alice # [ 6.151719] systemd-journald[283]: Received client request to flush runtime journal.1914alice # [ 6.189964] systemd[1]: Finished Load/Save OS Random Seed.1915alice # [ 6.190559] systemd[1]: Reached target First Boot Complete.1916alice # [ 6.201263] systemd[1]: Finished Flush Journal to Persistent Storage.1917clare # [ 6.266257] systemd[1]: Populated /etc with preset unit settings.1918alice # [ 6.212686] systemd[1]: Finished Apply Kernel Variables.1919alice # [ 6.216662] systemd[1]: Starting Network Name Resolution...1920bob # [ 6.230280] systemd[1]: Populated /etc with preset unit settings.1921alice # [ 6.230582] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1922alice # [ 6.239109] systemd[1]: Starting Create Static Device Nodes in /dev...1923alice # [ 6.373929] systemd-resolved[313]: Positive Trust Anchors:1924alice # [ 6.374535] systemd-resolved[313]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1925alice # [ 6.375382] systemd-resolved[313]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161926alice # [ 6.384200] systemd-resolved[313]: 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 test1927clare # [ 6.483474] systemd[1]: initrd-switch-root.service: Deactivated successfully.1928clare # [ 6.483759] systemd[1]: Stopped initrd-switch-root.service.1929clare # [ 6.487265] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1930clare # [ 6.489840] systemd[1]: Created slice Slice /system/getty.1931clare # [ 6.490837] systemd[1]: Created slice User and Session Slice.1932clare # [ 6.491430] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1933clare # [ 6.494223] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1934clare # [ 6.494764] systemd[1]: Expecting device /dev/hvc0...1935clare # [ 6.495330] systemd[1]: Expecting device /dev/ttyAMA0...1936clare # [ 6.497861] systemd[1]: Reached target Local Encrypted Volumes.1937clare # [ 6.498371] systemd[1]: Stopped target initrd-fs.target.1938clare # [ 6.498961] systemd[1]: Stopped target initrd-root-fs.target.1939clare # [ 6.499576] systemd[1]: Stopped target initrd-switch-root.target.1940clare # [ 6.502583] systemd[1]: Reached target Virtual Machines and Containers.1941clare # [ 6.503085] systemd[1]: Reached target Path Units.1942clare # [ 6.503640] systemd[1]: Reached target Remote File Systems.1943clare # [ 6.506029] systemd[1]: Reached target Slice Units.1944clare # [ 6.506655] systemd[1]: Reached target Swaps.1945bob # [ 6.460393] systemd[1]: initrd-switch-root.service: Deactivated successfully.1946bob # [ 6.460710] systemd[1]: Stopped initrd-switch-root.service.1947clare # [ 6.509841] systemd[1]: Listening on Query the User Interactively for a Password.1948bob # [ 6.464087] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1949clare # [ 6.512731] systemd[1]: Listening on Process Core Dump Socket.1950clare # [ 6.514495] systemd[1]: Listening on Credential Encryption/Decryption.1951bob # [ 6.466672] systemd[1]: Created slice Slice /system/getty.1952clare # [ 6.517394] systemd[1]: Listening on Factory Reset Management.1953bob # [ 6.467878] systemd[1]: Created slice User and Session Slice.1954clare # [ 6.517979] systemd[1]: Listening on Hostname Service Socket.1955bob # [ 6.468515] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1956bob # [ 6.469144] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1957bob # [ 6.472342] systemd[1]: Expecting device /dev/hvc0...1958bob # [ 6.472878] systemd[1]: Expecting device /dev/ttyAMA0...1959clare # [ 6.521633] systemd[1]: Starting Journal Log Access Socket...1960clare # [ 6.522807] systemd[1]: Listening on Journal Audit Socket.1961bob # [ 6.474950] systemd[1]: Reached target Local Encrypted Volumes.1962bob # [ 6.475486] systemd[1]: Stopped target initrd-fs.target.1963clare # [ 6.526126] systemd[1]: Listening on Console Output Muting Service Socket.1964bob # [ 6.476047] systemd[1]: Stopped target initrd-root-fs.target.1965clare # [ 6.526872] systemd[1]: Listening on Network Management Metrics Varlink Socket.1966bob # [ 6.476586] systemd[1]: Stopped target initrd-switch-root.target.1967clare # [ 6.527651] systemd[1]: Listening on Network Management Varlink Socket.1968bob # [ 6.477136] systemd[1]: Reached target Virtual Machines and Containers.1969bob # [ 6.480576] systemd[1]: Reached target Path Units.1970bob # [ 6.481121] systemd[1]: Reached target Remote File Systems.1971clare # [ 6.530228] systemd[1]: Listening on Network Management Netlink Socket.1972alice # [ 6.476751] systemd[1]: Finished Create Static Device Nodes in /dev.1973alice # [ 6.477664] systemd[1]: Reached target Preparation for Local File Systems.1974bob # [ 6.482539] systemd[1]: Reached target Slice Units.1975bob # [ 6.483075] systemd[1]: Reached target Swaps.1976clare # [ 6.532558] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1977clare # [ 6.533244] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1978clare # [ 6.533713] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1979bob # [ 6.486131] systemd[1]: Listening on Query the User Interactively for a Password.1980bob # [ 6.488388] systemd[1]: Listening on Process Core Dump Socket.1981clare # [ 6.539782] systemd[1]: Listening on Disk Repartitioning Service Socket.1982bob # [ 6.491175] systemd[1]: Listening on Credential Encryption/Decryption.1983bob # [ 6.493033] systemd[1]: Listening on Factory Reset Management.1984clare # [ 6.540904] systemd[1]: Listening on Resolve Monitor Varlink Socket.1985clare # [ 6.541466] systemd[1]: Listening on Resolve Service Varlink Socket.1986clare # [ 6.542029] systemd[1]: Listening on udev Control Socket.1987clare # [ 6.542584] systemd[1]: Listening on udev Varlink Socket.1988alice # [ 6.489938] systemd[1]: Starting Rule-based Manager for Device Events and Files...1989bob # [ 6.495062] systemd[1]: Listening on Hostname Service Socket.1990clare # [ 6.546698] systemd[1]: Mounting Huge Pages File System...1991bob # [ 6.498354] systemd[1]: Starting Journal Log Access Socket...1992bob # [ 6.499779] systemd[1]: Listening on Journal Audit Socket.1993clare # [ 6.549242] systemd[1]: Mounting POSIX Message Queue File System...1994bob # [ 6.503196] systemd[1]: Listening on Console Output Muting Service Socket.1995bob # [ 6.503924] systemd[1]: Listening on Network Management Metrics Varlink Socket.1996bob # [ 6.504685] systemd[1]: Listening on Network Management Varlink Socket.1997bob # [ 6.507673] systemd[1]: Listening on Network Management Netlink Socket.1998bob # [ 6.509390] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1999bob # [ 6.511451] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2000bob # [ 6.511931] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2001clare # [ 6.560269] systemd[1]: Mounting Kernel Debug File System...2002bob # [ 6.517102] systemd[1]: Listening on Disk Repartitioning Service Socket.2003bob # [ 6.518339] systemd[1]: Listening on Resolve Monitor Varlink Socket.2004bob # [ 6.518923] systemd[1]: Listening on Resolve Service Varlink Socket.2005bob # [ 6.519508] systemd[1]: Listening on udev Control Socket.2006clare # [ 6.567957] systemd[1]: Mounting Kernel Trace File System...2007bob # [ 6.520117] systemd[1]: Listening on udev Varlink Socket.2008bob # [ 6.524464] systemd[1]: Mounting Huge Pages File System...2009bob # [ 6.527575] systemd[1]: Mounting POSIX Message Queue File System...2010clare # [ 6.578392] systemd[1]: Starting Create List of Static Device Nodes...2011clare # [ 6.581310] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2012bob # [ 6.537625] systemd[1]: Mounting Kernel Debug File System...2013alice # [ 6.536448] systemd-resolved[313]: Using system hostname 'alice'.2014clare # [ 6.592339] systemd[1]: Mounting Kernel Configuration File System...2015clare # [ 6.594521] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2016bob # [ 6.545577] systemd[1]: Mounting Kernel Trace File System...2017alice # [ 6.546054] systemd[1]: Started Network Name Resolution.2018clare # [ 6.600362] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2019clare # [ 6.601709] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2020bob # [ 6.560631] systemd[1]: Starting Create List of Static Device Nodes...2021bob # [ 6.563452] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2022alice # [ 6.567379] systemd[1]: Finished Coldplug All udev Devices.2023bob # [ 6.573225] systemd[1]: Mounting Kernel Configuration File System...2024bob # [ 6.574753] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2025bob # [ 6.579618] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2026clare # [ 6.629689] systemd[1]: Mounting FUSE Control File System...2027clare # [ 6.630133] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672028bob # [ 6.584946] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2029alice # [ 6.588737] systemd-udevd[323]: Using default interface naming scheme 'v261'.2030clare # [ 6.651116] systemd[1]: Starting Journal Service...2031bob # [ 6.602474] systemd[1]: Mounting FUSE Control File System...2032bob # [ 6.602918] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672033clare # [ 6.663605] systemd[1]: Starting Load Kernel Modules...2034clare # [ 6.673410] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2035bob # [ 6.629542] systemd[1]: Starting Journal Service...2036clare # [ 6.683416] systemd[1]: Starting Remount Root and Kernel File Systems...2037clare # [ 6.683824] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2038bob # [ 6.640617] systemd[1]: Starting Load Kernel Modules...2039alice # [ 6.640932] systemd[1]: Started Rule-based Manager for Device Events and Files.2040bob # [ 6.657427] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2041clare # [ 6.712304] systemd[1]: Starting Coldplug All udev Devices...2042clare # [ 6.714349] systemd[1]: Listening on Journal Log Access Socket.2043clare # [ 6.714806] systemd[1]: Mounted Huge Pages File System.2044clare # [ 6.715179] systemd[1]: Mounted POSIX Message Queue File System.2045clare # [ 6.715525] systemd[1]: Mounted Kernel Debug File System.2046bob # [ 6.666608] systemd[1]: Starting Remount Root and Kernel File Systems...2047bob # [ 6.675355] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2048clare # [ 6.726753] systemd[1]: Mounted Kernel Trace File System.2049clare # [ 6.732681] systemd[1]: Finished Create List of Static Device Nodes.2050bob # [ 6.691589] systemd-journald[290]: Collecting audit messages is enabled.2051clare # [ 6.746781] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2052bob # [ 6.691281] systemd[1]: Queued start job for default target Multi-User System.2053bob # [ 6.701583] systemd[1]: Starting Coldplug All udev Devices...2054bob # [ 6.703492] systemd[1]: Started Journal Service.2055bob # [ 6.697772] systemd[1]: systemd-journald.service: Deactivated successfully.2056bob # [ 6.698563] systemd[1]: Listening on Journal Log Access Socket.2057bob # [ 6.699282] systemd[1]: Mounted Huge Pages File System.2058bob # [ 6.699913] systemd[1]: Mounted POSIX Message Queue File System.2059clare # [ 6.760722] systemd[1]: Finished Load Kernel Modules.2060clare # [ 6.761342] systemd[1]: Mounted Kernel Configuration File System.2061bob # [ 6.706753] systemd[1]: Mounted Kernel Debug File System.2062bob # [ 6.707395] systemd[1]: Mounted Kernel Trace File System.2063clare # [ 6.769434] systemd-journald[283]: Collecting audit messages is enabled.2064clare # [ 6.773927] systemd[1]: Starting Firewall...2065bob # [ 6.717653] systemd[1]: Finished Create List of Static Device Nodes.2066alice # [ 6.724190] systemd[1]: Mounting /run/wrappers...2067clare # [ 6.780517] systemd[1]: Starting Apply Kernel Variables...2068clare # [ 6.779731] systemd[1]: Queued start job for default target Multi-User System.2069clare # [ 6.785150] systemd[1]: Started Journal Service.2070bob # [ 6.746459] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2071bob # [ 6.763588] systemd-modules-load[291]: Module 'atkbd' is built in2072bob # [ 6.773430] EXT4-fs (vda): re-mounted ca293e06-3a90-4536-8cd5-57b892a56c07.2073bob # [ 6.769297] systemd-modules-load[291]: Module 'loop' is built in2074clare # [ 6.824282] EXT4-fs (vda): re-mounted ac2a4e0d-e1d9-4b2f-95a2-3650b3b60bdc.2075alice # [ 6.773211] systemd[1]: Mounted /run/wrappers.2076alice # [ 6.774979] systemd[1]: Reached target Local File Systems.2077alice # [ 6.779898] systemd[1]: Listening on Boot Loader Control Service Socket.2078bob # [ 6.779846] systemd[1]: Finished Remount Root and Kernel File Systems.2079alice # [ 6.784115] systemd[1]: Starting register-nix-paths.service...2080bob # [ 6.784227] systemd[1]: Listening on Disk Image Download Service Socket.2081alice # [ 6.789608] systemd[1]: Starting Create SUID/SGID Wrappers...2082bob # [ 6.787287] systemd[1]: Starting Flush Journal to Persistent Storage...2083alice # [ 6.790196] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2084bob # [ 6.787947] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2085alice # [ 6.793916] systemd[1]: Starting Save Transient machine-id to Disk...2086bob # [ 6.794149] systemd[1]: Starting Load/Save OS Random Seed...2087bob # [ 6.794759] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2088bob # [ 6.795532] systemd[1]: Mounted Kernel Configuration File System.2089bob # [ 6.800295] systemd[1]: Finished Load Kernel Modules.2090bob # [ 6.806008] systemd[1]: Starting Firewall...2091alice # [ 6.813417] systemd[1]: Starting Create System Files and Directories...2092alice # [ 6.814104] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2093alice # [ 6.824626] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2094bob # [ 6.823952] systemd[1]: Starting Apply Kernel Variables...2095bob # [ 6.824644] systemd[1]: Mounted FUSE Control File System.2096bob # [ 6.830413] systemd-oomd[292]: No swap; memory pressure usage will be degraded2097bob # [ 6.847248] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2098bob # [ 6.907311] systemd-journald[290]: Received client request to flush runtime journal.2099alice # [ 6.919955] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2100alice # [ 6.926433] systemd[1]: Finished Save Transient machine-id to Disk.2101bob # [ 6.944784] systemd[1]: Finished Load/Save OS Random Seed.2102bob # [ 6.945430] systemd[1]: Reached target First Boot Complete.2103bob # [ 6.948801] systemd[1]: Finished Flush Journal to Persistent Storage.2104alice # [ 6.984281] systemd[1]: Finished Create System Files and Directories.2105bob # [ 6.983271] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2106alice # [ 6.993583] systemd[1]: Starting Rebuild Journal Catalog...2107bob # [ 6.993051] systemd[1]: Starting Create Static Device Nodes in /dev...2108alice # [ 6.999007] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2109bob # [ 7.036090] systemd[1]: Finished Apply Kernel Variables.2110bob # [ 7.045763] systemd[1]: Starting Network Name Resolution...2111alice # [ 7.130347] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2112alice # [ 7.137787] systemd[1]: Finished Rebuild Journal Catalog.2113alice # [ 7.145507] systemd[1]: Starting Update is Completed...2114alice # [ 7.148371] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2115alice # [ 7.208190] systemd[1]: Finished Update is Completed.2116bob # [ 7.208973] systemd-resolved[321]: Positive Trust Anchors:2117bob # [ 7.209569] systemd-resolved[321]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2118bob # [ 7.210467] systemd-resolved[321]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162119bob # [ 7.211352] systemd-resolved[321]: 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 test2120alice # [ 7.220474] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2121bob # [ 7.252104] systemd[1]: Finished Create Static Device Nodes in /dev.2122bob # [ 7.252798] systemd[1]: Reached target Preparation for Local File Systems.2123bob # [ 7.256073] systemd[1]: Starting Rule-based Manager for Device Events and Files...2124bob # [ 7.302584] systemd[1]: Finished Coldplug All udev Devices.2125bob # [ 7.346924] systemd-resolved[321]: Using system hostname 'bob'.2126bob # [ 7.350312] systemd[1]: Started Network Name Resolution.2127clare # [ 6.781147] systemd[1]: systemd-journald.service: Deactivated successfully.2128clare # [ 7.412698] systemd-journald[283]: Received client request to flush runtime journal.2129bob # [ 7.365708] systemd-udevd[329]: Using default interface naming scheme 'v261'.2130clare # [ 7.448485] systemd-modules-load[284]: Module 'atkbd' is built in2131clare # [ 7.449218] systemd-modules-load[284]: Module 'loop' is built in2132clare # [ 7.450119] systemd-oomd[285]: No swap; memory pressure usage will be degraded2133clare # [ 7.451062] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2134clare # [ 7.451747] systemd[1]: Mounted FUSE Control File System.2135clare # [ 7.460651] systemd[1]: Finished Remount Root and Kernel File Systems.2136alice # [ 7.412297] (udev-worker)[343]: Network interface NamePolicy= disabled on kernel command line.2137clare # [ 7.461386] systemd[1]: Listening on Disk Image Download Service Socket.2138clare # [ 7.462088] systemd[1]: Starting Flush Journal to Persistent Storage...2139clare # [ 7.462762] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2140clare # [ 7.463840] systemd[1]: Starting Load/Save OS Random Seed...2141bob # [ 7.420156] systemd[1]: Started Rule-based Manager for Device Events and Files.2142clare # [ 7.472404] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2143alice # [ 7.424251] (udev-worker)[344]: Network interface NamePolicy= disabled on kernel command line.2144clare # [ 7.473317] systemd[1]: Finished Load/Save OS Random Seed.2145clare # [ 7.473925] systemd[1]: Reached target First Boot Complete.2146clare # [ 7.474517] systemd[1]: Finished Apply Kernel Variables.2147clare # [ 7.475145] systemd[1]: Starting Network Name Resolution...2148clare # [ 7.475751] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2149clare # [ 7.482363] systemd[1]: Starting Create Static Device Nodes in /dev...2150clare # [ 7.483230] systemd-resolved[301]: Positive Trust Anchors:2151clare # [ 7.483866] systemd-resolved[301]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2152clare # [ 7.490649] systemd-resolved[301]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162153clare # [ 7.491539] systemd-resolved[301]: 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 test2154bob # [ 7.460734] systemd[1]: Mounting /run/wrappers...2155clare # [ 7.513388] systemd[1]: Finished Create Static Device Nodes in /dev.2156clare # [ 7.514038] systemd[1]: Reached target Preparation for Local File Systems.2157clare # [ 7.515982] systemd[1]: Starting Rule-based Manager for Device Events and Files...2158clare # [ 7.517426] systemd-resolved[301]: Using system hostname 'clare'.2159clare # [ 7.517992] systemd[1]: Started Network Name Resolution.2160clare # [ 7.518473] systemd[1]: Finished Coldplug All udev Devices.2161clare # [ 7.519216] systemd-udevd[309]: Using default interface naming scheme 'v261'.2162clare # [ 7.519841] systemd[1]: Started Rule-based Manager for Device Events and Files.2163clare # [ 7.524829] systemd[1]: Finished Flush Journal to Persistent Storage.2164clare # [ 7.525415] systemd[1]: Mounting /run/wrappers...2165clare # [ 7.550654] systemd[1]: Mounted /run/wrappers.2166clare # [ 7.551162] systemd[1]: Reached target Local File Systems.2167clare # [ 7.554935] systemd[1]: Listening on Boot Loader Control Service Socket.2168clare # [ 7.560458] systemd[1]: Starting register-nix-paths.service...2169clare # [ 7.564422] systemd[1]: Starting Create SUID/SGID Wrappers...2170clare # [ 7.567307] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2171clare # [ 7.570914] systemd[1]: Starting Save Transient machine-id to Disk...2172clare # [ 7.587646] systemd[1]: Starting Create System Files and Directories...2173clare # [ 7.589954] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2174bob # [ 7.541337] systemd[1]: Mounted /run/wrappers.2175bob # [ 7.542351] systemd[1]: Reached target Local File Systems.2176bob # [ 7.545762] systemd[1]: Listening on Boot Loader Control Service Socket.2177clare # [ 7.596696] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2178bob # [ 7.552108] systemd[1]: Starting register-nix-paths.service...2179bob # [ 7.555578] systemd[1]: Starting Create SUID/SGID Wrappers...2180bob # [ 7.556924] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2181bob # [ 7.570724] systemd[1]: Starting Save Transient machine-id to Disk...2182bob # [ 7.587242] systemd[1]: Starting Create System Files and Directories...2183bob # [ 7.587948] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2184bob # [ 7.596767] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2185clare # [ 7.679164] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2186clare # [ 7.688549] systemd[1]: Finished Save Transient machine-id to Disk.2187alice # [ 7.671060] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2188alice # [ 7.673725] systemd[1]: Finished Create SUID/SGID Wrappers.2189bob # [ 7.680124] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2190bob # [ 7.686372] systemd[1]: Finished Save Transient machine-id to Disk.2191alice # [ 7.695800] systemd[1]: Finished register-nix-paths.service.2192alice # [ 7.697847] systemd[1]: Reached target System Initialization.2193alice # [ 7.698392] systemd[1]: Started Discard unused filesystem blocks once a week.2194alice # [ 7.699025] systemd[1]: Started Daily Cleanup of Temporary Directories.2195alice # [ 7.699608] systemd[1]: Reached target Timer Units.2196clare # [ 7.748232] systemd[1]: Finished Create System Files and Directories.2197alice # [ 7.706447] systemd[1]: Listening on D-Bus System Message Bus Socket.2198alice # [ 7.707027] systemd[1]: Listening on Nix Daemon Socket.2199alice # [ 7.707518] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2200clare # [ 7.756615] systemd[1]: Starting Rebuild Journal Catalog...2201alice # [ 7.713123] systemd[1]: Reached target Socket Units.2202alice # [ 7.713610] systemd[1]: Reached target Basic System.2203alice # [ 7.714074] systemd[1]: Started backdoor.service.2204alice # [ 7.714522] systemd[1]: Starting Import lastlog data into lastlog2 database...2205clare # [ 7.763181] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2206alice # [ 7.721409] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2207alice # [ 7.728167] mousedev: PS/2 mouse device common for all mice2208alice # [ 7.728428] systemd[1]: Starting Post-Boot Actions...2209alice # [ 7.739007] systemd[1]: Started Reset console on configuration changes.2210bob # [ 7.757782] systemd[1]: Finished Create System Files and Directories.2211bob # [ 7.770116] systemd[1]: Starting Rebuild Journal Catalog...2212alice # [ 7.774223] systemd[1]: Starting D-Bus System Message Bus...2213bob # [ 7.774193] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2214clare # [ 7.872716] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2215alice # [ 7.828779] systemd[1]: Finished Post-Boot Actions.2216clare # [ 7.907699] systemd[1]: Finished Rebuild Journal Catalog.2217clare # [ 7.910302] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2218clare # [ 7.916528] systemd[1]: Starting Update is Completed...2219alice # connecting to host...2220alice # [ 7.887833] systemd[1]: Started Name Service Cache Daemon (nsncd).2221alice # [ 7.890464] nsncd[474]: Oct 05 15:30:44.682 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2222bob # [ 7.893155] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2223alice # [ 7.898622] systemd[1]: Reached target Host and Network Name Lookups.2224alice # [ 7.899253] systemd[1]: Reached target User and Group Name Lookups.2225alice # [ 7.909145] systemd[1]: Starting User Login Management...2226bob # [ 7.919005] systemd[1]: Finished Rebuild Journal Catalog.2227bob # [ 7.925758] systemd[1]: Starting Update is Completed...2228clare # [ 7.981823] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2229bob # [ 7.947701] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2230alice # [ 7.964704] systemd[1]: Finished Import lastlog data into lastlog2 database.2231clare # [ 8.027221] systemd[1]: Finished Update is Completed.2232bob # [ 7.977888] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2233alice # [ 8.012619] dbus-broker-launch[478]: Looking up NSS user entry for 'systemd-timesync'...2234alice # [ 8.023573] dbus-broker-launch[478]: NSS returned no entry for 'systemd-timesync'2235alice # [ 8.025439] dbus-broker-launch[478]: Invalid user-name in /nix/store/1hq4agwd3q80lb722fxb35wmyzlnrk6q-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2236bob # [ 8.037550] systemd[1]: Finished Update is Completed.2237alice # [ 8.044839] systemd-logind[498]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2238alice # [ 8.049921] systemd-logind[498]: Watching system buttons on /dev/input/event0 (gpio-keys)2239alice # [ 8.051572] systemd-logind[498]: New seat seat0.2240alice # [ 8.055339] systemd[1]: Started User Login Management.2241alice # [ 8.058728] systemd[1]: Starting linger-users.service...2242alice # [ 8.073406] systemd[1]: Started D-Bus System Message Bus.2243alice # [ 8.106442] dbus-broker-launch[478]: Ready2244alice # [ 8.124533] systemd[1]: linger-users.service: Deactivated successfully.2245alice # [ 8.126999] systemd[1]: Finished linger-users.service.2246clare # [ 8.195762] (udev-worker)[345]: Network interface NamePolicy= disabled on kernel command line.2247clare # [ 8.223836] (udev-worker)[350]: Network interface NamePolicy= disabled on kernel command line.2248bob # [ 8.218015] (udev-worker)[355]: Network interface NamePolicy= disabled on kernel command line.2249alice # [ 8.227565] systemd[1]: Finished Firewall.2250alice # [ 8.228118] systemd[1]: Reached target Preparation for Network.2251alice # [ 8.228654] systemd[1]: Listening on Network Management Resolve Hook Socket.2252alice # [ 8.232597] systemd[1]: Starting Network Management...2253bob # [ 8.230088] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line.2254bob # [ 8.392111] mousedev: PS/2 mouse device common for all mice2255clare # [ 8.447636] systemd[1]: Finished register-nix-paths.service.2256clare # [ 8.461906] mousedev: PS/2 mouse device common for all mice2257alice # [ 8.412117] cfg80211: Loading compiled-in X.509 certificates for regulatory database2258clare # [ 8.466705] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2259clare # [ 8.469742] systemd[1]: Finished Create SUID/SGID Wrappers.2260clare # [ 8.471917] systemd[1]: Reached target System Initialization.2261clare # [ 8.476302] systemd[1]: Started Discard unused filesystem blocks once a week.2262clare # [ 8.476967] systemd[1]: Started Daily Cleanup of Temporary Directories.2263clare # [ 8.477573] systemd[1]: Reached target Timer Units.2264clare # [ 8.478037] systemd[1]: Listening on D-Bus System Message Bus Socket.2265clare # [ 8.482605] systemd[1]: Listening on harmonia binary cache socket.2266clare # [ 8.483209] systemd[1]: Listening on Nix Daemon Socket.2267clare # [ 8.483905] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2268clare # [ 8.489158] systemd[1]: Reached target Socket Units.2269clare # [ 8.489653] systemd[1]: Reached target Basic System.2270clare # [ 8.490120] systemd[1]: Started backdoor.service.2271clare # [ 8.496051] systemd[1]: Starting Import lastlog data into lastlog2 database...2272clare # [ 8.496749] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2273alice # [ 8.454058] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2274alice # [ 8.454582] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2275alice # [ 8.456388] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22276alice # [ 8.456786] cfg80211: failed to load regulatory.db2277clare # [ 8.514614] systemd[1]: Starting Post-Boot Actions...2278clare # [ 8.521970] systemd[1]: Started Reset console on configuration changes.2279alice # [ 8.485566] systemd-networkd[539]: lo: Link UP2280alice # [ 8.486072] systemd-networkd[539]: lo: Gained carrier2281bob # [ 8.489173] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2282bob # [ 8.490618] systemd[1]: Finished Create SUID/SGID Wrappers.2283alice # [ 8.493970] systemd-networkd[539]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2284alice # [ 8.495331] systemd-networkd[539]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2285clare # [ 8.545789] systemd[1]: Starting D-Bus System Message Bus...2286bob # [ 8.501512] systemd[1]: Finished register-nix-paths.service.2287bob # [ 8.502105] systemd[1]: Reached target System Initialization.2288bob # [ 8.502632] systemd[1]: Started Discard unused filesystem blocks once a week.2289bob # [ 8.503249] systemd[1]: Started Daily Cleanup of Temporary Directories.2290alice # [ 8.505868] systemd[1]: Started Network Management.2291alice # [ 8.506350] systemd[1]: Reached target Network.2292bob # [ 8.503825] systemd[1]: Reached target Timer Units.2293alice # [ 8.506756] systemd-networkd[539]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2294alice # [ 8.507596] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2295bob # [ 8.510846] systemd[1]: Listening on D-Bus System Message Bus Socket.2296bob # [ 8.511447] systemd[1]: Listening on Nix Daemon Socket.2297bob # [ 8.511922] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2298alice # [ 8.514967] systemd-networkd[539]: eth1: Link UP2299alice # [ 8.515454] systemd-networkd[539]: eth1: Gained carrier2300alice # [ 8.515902] systemd-networkd[539]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2301bob # [ 8.516318] systemd[1]: Reached target Socket Units.2302bob # [ 8.516801] systemd[1]: Reached target Basic System.2303bob # [ 8.517255] systemd[1]: Started backdoor.service.2304bob # [ 8.517690] systemd[1]: Starting Import lastlog data into lastlog2 database...2305alice # [ 8.526558] systemd[1]: Starting Permit User Sessions...2306bob # [ 8.524192] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2307alice # [ 8.527072] systemd-networkd[539]: eth0: Link UP2308alice # [ 8.527474] systemd-networkd[539]: eth0: Gained carrier2309bob # [ 8.527451] systemd[1]: Starting Post-Boot Actions...2310alice # [ 8.533416] systemd-networkd[539]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22311bob # [ 8.548988] systemd[1]: Started Reset console on configuration changes.2312clare # connecting to host...2313clare # [ 8.635741] systemd[1]: Finished Post-Boot Actions.2314alice # [ 8.590835] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2315alice # [ 8.593735] systemd[1]: Finished Permit User Sessions.2316bob # [ 8.594525] systemd[1]: Starting D-Bus System Message Bus...2317alice # [ 8.597861] systemd[1]: Started Getty on tty1.2318alice # [ 8.599565] systemd[1]: Reached target Login Prompts.2319alice # [ 8.601425] systemd[1]: Reached target Multi-User System.2320alice # [ 8.603103] systemd[1]: Startup finished in 750ms (kernel) + 3.837s (initrd) + 4.013s (userspace) = 8.602s.2321clare # [ 8.658924] systemd[1]: Started Name Service Cache Daemon (nsncd).2322clare # [ 8.659565] systemd[1]: Reached target Host and Network Name Lookups.2323clare # [ 8.665994] nsncd[473]: Oct 05 15:30:45.459 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2324clare # [ 8.667226] systemd[1]: Reached target User and Group Name Lookups.2325clare # [ 8.678945] systemd[1]: Starting User Login Management...2326bob # connecting to host...2327bob # [ 8.669541] systemd[1]: Finished Post-Boot Actions.2328clare # [ 8.740088] systemd[1]: Finished Import lastlog data into lastlog2 database.2329bob: Guest shell says: b'Spawning backdoor root shell...\n'2330bob # [ 8.699641] systemd[1]: Started Name Service Cache Daemon (nsncd).2331bob # [ 8.708191] systemd[1]: Finished Import lastlog data into lastlog2 database.2332bob # [ 8.708983] nsncd[474]: Oct 05 15:30:45.506 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2333bob # [ 8.710110] systemd[1]: Reached target Host and Network Name Lookups.2334bob # [ 8.710632] systemd[1]: Reached target User and Group Name Lookups.2335bob # [ 8.719367] systemd[1]: Starting User Login Management...2336clare # [ 8.803901] dbus-broker-launch[477]: Looking up NSS user entry for 'systemd-timesync'...2337clare # [ 8.808892] systemd-logind[492]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2338clare # [ 8.811325] systemd-logind[492]: Watching system buttons on /dev/input/event0 (gpio-keys)2339clare # [ 8.816985] systemd-logind[492]: New seat seat0.2340clare # [ 8.817630] systemd[1]: Started User Login Management.2341clare # [ 8.821040] systemd[1]: Starting linger-users.service...2342alice # [ 8.793336] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32343clare # [ 8.821547] dbus-broker-launch[477]: NSS returned no entry for 'systemd-timesync'2344clare # [ 8.822117] dbus-broker-launch[477]: Invalid user-name in /nix/store/16ww7sz86177drhs17kx18vlbhkmib53-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2345clare # [ 8.851923] systemd[1]: Started D-Bus System Message Bus.2346bob: connected to guest root shell2347bob: (connecting took 9.11 seconds)2348bob: (finished: waiting for the VM to finish booting, in 9.11 seconds)2349bob # [ 8.836579] dbus-broker-launch[480]: Looking up NSS user entry for 'systemd-timesync'...2350clare # [ 8.889481] systemd[1]: linger-users.service: Deactivated successfully.2351clare # [ 8.890146] systemd[1]: Finished linger-users.service.2352clare # [ 8.894229] dbus-broker-launch[477]: Ready2353bob # [ 8.855155] systemd-logind[501]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2354bob # [ 8.859099] systemd-logind[501]: Watching system buttons on /dev/input/event0 (gpio-keys)2355bob # [ 8.864179] dbus-broker-launch[480]: NSS returned no entry for 'systemd-timesync'2356bob # [ 8.864827] dbus-broker-launch[480]: Invalid user-name in /nix/store/c19cl6mgva5ipipijba7s905fspc9svi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2357bob # [ 8.866141] systemd-logind[501]: New seat seat0.2358bob # [ 8.866661] systemd[1]: Started User Login Management.2359bob # [ 8.877530] systemd[1]: Starting linger-users.service...2360bob # [ 8.905349] systemd[1]: Started D-Bus System Message Bus.2361bob # [ 8.952902] dbus-broker-launch[480]: Ready2362bob # [ 8.955886] systemd[1]: linger-users.service: Deactivated successfully.2363bob # [ 8.959970] systemd[1]: Finished linger-users.service.2364clare # [ 9.058604] systemd[1]: Finished Firewall.2365clare # [ 9.060449] systemd[1]: Reached target Preparation for Network.2366clare # [ 9.063412] systemd[1]: Listening on Network Management Resolve Hook Socket.2367clare # [ 9.067311] systemd[1]: Starting Network Management...2368alice # [ 9.092154] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2369alice # [ 9.097599] systemd[1]: Starting Virtual Console Setup...2370bob # [ 9.111653] systemd[1]: Finished Firewall.2371bob # [ 9.114844] systemd[1]: Reached target Preparation for Network.2372bob # [ 9.115388] systemd[1]: Listening on Network Management Resolve Hook Socket.2373bob # [ 9.119436] systemd[1]: Starting Network Management...2374alice # [ 9.122309] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2375alice # [ 9.123627] systemd[1]: Stopped Virtual Console Setup.2376alice # [ 9.127394] systemd-logind[498]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2377alice # [ 9.131301] systemd[1]: Starting Virtual Console Setup...2378clare # [ 9.240796] cfg80211: Loading compiled-in X.509 certificates for regulatory database2379alice # [ 9.230158] systemd-vconsole-setup[559]: Configuration of first virtual console was skipped, ignoring remaining ones.2380alice # [ 9.232854] systemd[1]: Finished Virtual Console Setup.2381clare # [ 9.288233] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2382clare # [ 9.288743] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2383clare # [ 9.290653] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22384clare # [ 9.291047] cfg80211: failed to load regulatory.db2385clare # [ 9.323237] systemd-networkd[543]: lo: Link UP2386clare # [ 9.324969] systemd-networkd[543]: lo: Gained carrier2387clare # [ 9.331141] systemd[1]: Started Network Management.2388clare # [ 9.333464] systemd-networkd[543]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2389clare # [ 9.341472] systemd-networkd[543]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2390clare # [ 9.342199] systemd[1]: Reached target Network.2391clare # [ 9.342610] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2392clare # [ 9.349385] systemd-networkd[543]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2393clare # [ 9.350246] systemd-networkd[543]: eth1: Link UP2394clare # [ 9.350682] systemd-networkd[543]: eth1: Gained carrier2395bob # [ 9.308041] cfg80211: Loading compiled-in X.509 certificates for regulatory database2396clare # [ 9.351137] systemd-networkd[543]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2397clare # [ 9.363458] systemd[1]: Starting Permit User Sessions...2398clare # [ 9.363979] systemd-networkd[543]: eth0: Link UP2399clare # [ 9.366062] systemd-networkd[543]: eth0: Gained carrier2400clare # [ 9.368605] systemd-networkd[543]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22401bob # [ 9.344424] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2402bob # [ 9.344937] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2403bob # [ 9.348029] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22404bob # [ 9.348409] cfg80211: failed to load regulatory.db2405bob # [ 9.369759] systemd-networkd[557]: lo: Link UP2406bob # [ 9.370675] systemd-networkd[557]: lo: Gained carrier2407clare # [ 9.421236] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2408clare # [ 9.424623] systemd[1]: Finished Permit User Sessions.2409clare # [ 9.428599] systemd[1]: Started Getty on tty1.2410bob # [ 9.377927] systemd-networkd[557]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2411clare # [ 9.430311] systemd[1]: Reached target Login Prompts.2412clare # [ 9.432313] systemd[1]: Reached target Multi-User System.2413clare # [ 9.432843] systemd[1]: Startup finished in 748ms (kernel) + 4.609s (initrd) + 4.073s (userspace) = 9.431s.2414bob # [ 9.383954] systemd[1]: Started Network Management.2415bob # [ 9.384553] systemd[1]: Reached target Network.2416bob # [ 9.384955] systemd[1]: Reached target Network is Online.2417bob # [ 9.390163] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2418bob # [ 9.391462] systemd-networkd[557]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2419bob # [ 9.397992] systemd-networkd[557]: eth0: Link UP2420bob # [ 9.398439] systemd-networkd[557]: eth0: Gained carrier2421bob # [ 9.398899] systemd[1]: Starting ncps binary cache proxy service...2422bob # [ 9.404408] systemd-networkd[557]: eth1: Link UP2423bob # [ 9.404860] systemd-networkd[557]: eth1: Gained carrier2424bob # [ 9.405304] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2425bob # [ 9.406556] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2426bob # [ 9.414074] systemd[1]: Starting Permit User Sessions...2427bob # [ 9.417427] systemd-networkd[557]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22428bob # [ 9.506170] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2429bob # [ 9.509815] systemd[1]: Finished Permit User Sessions.2430bob # [ 9.513871] systemd[1]: Started Getty on tty1.2431bob # [ 9.515145] systemd[1]: Reached target Login Prompts.2432clare # [ 9.585322] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32433bob # [ 9.548286] ncps-pre-start[564]: /nix/store/z27dji5sjdkkdpzjlm37nq6d5cwbgl8i-ncps-0.9.4/bin/dbmate-ncps up2434bob # [ 9.698840] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32435clare # [ 9.860331] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2436bob # [ 9.813725] ncps-pre-start[579]: Creating: /var/lib/ncps/db/db.sqlite2437clare # [ 9.864419] systemd[1]: Starting Virtual Console Setup...2438clare # [ 9.887080] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2439clare # [ 9.890548] systemd[1]: Stopped Virtual Console Setup.2440clare # [ 9.893386] systemd[1]: Starting Virtual Console Setup...2441bob # [ 9.843525] ncps-pre-start[579]: Applying: 20241210054814_create-narinfos-table.sql2442clare # [ 9.901448] systemd-logind[492]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2443bob # [ 9.853916] ncps-pre-start[579]: Applied: 20241210054814_create-narinfos-table.sql in 10.36492ms2444bob # [ 9.854867] ncps-pre-start[579]: Applying: 20241210054829_create-nars-table.sql2445alice # [ 9.857559] systemd-networkd[539]: eth1: Gained IPv6LL2446bob # [ 9.871408] ncps-pre-start[579]: Applied: 20241210054829_create-nars-table.sql in 17.4596ms2447bob # [ 9.873214] ncps-pre-start[579]: Applying: 20241213014846_add-query-to-nars-table.sql2448bob # [ 9.884132] ncps-pre-start[579]: Applied: 20241213014846_add-query-to-nars-table.sql in 12.72488ms2449bob # [ 9.885034] ncps-pre-start[579]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2450bob # [ 9.902948] ncps-pre-start[579]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 18.7996ms2451bob # [ 9.905071] ncps-pre-start[579]: Applying: 20260101000000_add-config-table.sql2452bob # [ 9.908220] ncps-pre-start[579]: Applied: 20260101000000_add-config-table.sql in 5.26188ms2453bob # [ 9.910678] ncps-pre-start[579]: Applying: 20260105025735_remove-redundant-indexes.sql2454bob # [ 9.920274] ncps-pre-start[579]: Applied: 20260105025735_remove-redundant-indexes.sql in 11.9734ms2455bob # [ 9.921161] ncps-pre-start[579]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2456bob # [ 9.932262] ncps-pre-start[579]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 12.00632ms2457bob # [ 9.933142] ncps-pre-start[579]: Applying: 20260117195000_add_narinfo_de_normalized.sql2458clare # [ 9.994806] systemd-vconsole-setup[562]: Configuration of first virtual console was skipped, ignoring remaining ones.2459clare # [ 9.997467] systemd[1]: Finished Virtual Console Setup.2460bob # [ 9.948264] ncps-pre-start[579]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 15.96196ms2461bob # [ 9.952111] ncps-pre-start[579]: Applying: 20260127223000_allow_multiple_nar_representations.sql2462bob # [ 9.960271] ncps-pre-start[579]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 11.99524ms2463bob # [ 9.964726] ncps-pre-start[579]: Applying: 20260131021850_add_chunks.sql2464bob # [ 9.969855] ncps-pre-start[579]: Applied: 20260131021850_add_chunks.sql in 9.66772ms2465bob # [ 9.970591] ncps-pre-start[579]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2466bob # [ 9.977853] ncps-pre-start[579]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 6.38888ms2467bob # [ 9.980302] ncps-pre-start[579]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2468bob # [ 9.988166] ncps-pre-start[579]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 10.32076ms2469bob # [ 9.989257] ncps-pre-start[579]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2470bob # [ 9.995383] ncps-pre-start[579]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 6.85276ms2471alice # [ 10.049913] systemd-networkd[539]: eth0: Gained IPv6LL2472bob # [ 10.098231] systemd[1]: Started ncps binary cache proxy service.2473bob # [ 10.098822] systemd[1]: Reached target Multi-User System.2474bob # [ 10.103111] systemd[1]: Startup finished in 742ms (kernel) + 4.636s (initrd) + 4.721s (userspace) = 10.100s.2475bob # [ 10.147464] systemd[1]: Starting Virtual Console Setup...2476bob # [ 10.184256] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2477bob # [ 10.198718] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2478bob # [ 10.202635] systemd[1]: Stopped Virtual Console Setup.2479bob # [ 10.203301] systemd-logind[501]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2480bob # [ 10.210632] systemd[1]: Starting Virtual Console Setup...2481bob # [ 10.436693] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","log_level":"info","time":"2026-10-05T15:30:47Z","message":"logger created"}2482bob # [ 10.438252] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","xz-binary-path":"/nix/store/csrwf31hprwghnbyiglxa3p787lgrl67-xz-5.8.4-bin/bin/xz","time":"2026-10-05T15:30:47Z","message":"Using xz binary for xz decompression"}2483bob # [ 10.447582] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-10-05T15:30:47Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2484bob # [ 10.466396] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","time":"2026-10-05T15:30:47Z","message":"using local locks (single-instance mode)"}2485bob # [ 10.476937] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-05T15:30:47Z","message":"setting up tracer provider to discard traces"}2486bob # [ 10.480035] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-05T15:30:47Z","message":"setting up meter provider to discard metrics"}2487bob # [ 10.484088] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-05T15:30:47Z","message":"setting up logger provider to discard logs"}2488bob # [ 10.488375] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-10-05T15:30:47Z","message":"Reporting anonymous metrics to the project maintainers"}2489bob # [ 10.491535] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-10-05T15:30:47Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2490bob # [ 10.494288] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-10-05T15:30:47Z","message":"using local storage"}2491clare # [ 10.574488] systemd[1]: Starting harmonia binary cache service...2492bob # [ 10.525757] systemd-vconsole-setup[600]: Configuration of first virtual console was skipped, ignoring remaining ones.2493bob # [ 10.528256] systemd[1]: Finished Virtual Console Setup.2494clare # [ 10.625457] systemd-networkd[543]: eth0: Gained IPv6LL2495clare # [ 10.719763] harmonia-cache[565]: 2026-10-05T15:30:47.517821Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2496clare # [ 10.725199] harmonia-cache[565]: 2026-10-05T15:30:47.522330Z INFO actix_server::builder: starting 4 workers2497clare # [ 10.733318] harmonia-cache[565]: 2026-10-05T15:30:47.526995Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2498clare # [ 10.742933] harmonia-cache[565]: 2026-10-05T15:30:47.527078Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2499clare # [ 10.745072] harmonia-cache[565]: 2026-10-05T15:30:47.527182Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002500clare # [ 10.747481] systemd[1]: Started harmonia binary cache service.2501bob # [ 10.712167] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-10-05T15:30:47Z","message":"upstream became healthy and is now available for requests"}2502bob # [ 10.718429] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-10-05T15:30:47Z","message":"Server started"}2503bob # [ 10.946609] systemd-networkd[557]: eth0: Gained IPv6LL2504clare # [ 11.008971] systemd-networkd[543]: eth1: Gained IPv6LL2505bob: (finished: waiting for unit ncps, in 11.45 seconds)2506bob: must succeed: systemctl status ncps2507bob: (finished: must succeed: systemctl status ncps, in 0.04 seconds)2508clare: waiting for unit harmonia.socket2509clare: waiting for the VM to finish booting2510clare: Guest shell says: b'Spawning backdoor root shell...\n'2511clare: connected to guest root shell2512clare: (connecting took 0.00 seconds)2513clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2514clare: (finished: waiting for unit harmonia.socket, in 0.05 seconds)2515alice: waiting for success: curl bob:8502/nix-cache-info2516alice: waiting for the VM to finish booting2517alice: Guest shell says: b'Spawning backdoor root shell...\n'2518alice: connected to guest root shell2519alice: (connecting took 0.00 seconds)2520alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2521bob # [ 11.329203] systemd-networkd[557]: eth1: Gained IPv6LL2522alice # % Total % Received % Xferd Average Speed Time Time Time Current2523alice # Dload Upload Total Spent Left Speed2524bob # [ 11.354778] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:60886","trace_id":"89124f5a67685075fb196a3a8d9a1133","span_id":"db23eee5da4a7658","status":200,"elapsed":0.07076,"bytes":50,"time":"2026-10-05T15:30:48Z","message":"handled request"}2525alice # 0 0 0 0 0 0 0 0 0100 50 100 50 0 0 1133 0 0100 50 100 50 0 0 1040 0 0100 50 100 50 0 0 964 0 02526alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 0.12 seconds)2527bob: waiting for success: curl clare:5000/nix-cache-info2528bob # % Total % Received % Xferd Average Speed Time Time Time Current2529bob # Dload Upload Total Spent Left Speed2530bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 2625 0 0100 51 100 51 0 0 2253 0 0100 51 100 51 0 0 1979 0 02531bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.09 seconds)2532clare: waiting for unit harmonia2533bob # [ 11.498222] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: 2026/10/05 15:30:48 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2534clare: (finished: waiting for unit harmonia, in 0.07 seconds)2535clare: must succeed: systemctl status harmonia2536clare: (finished: must succeed: systemctl status harmonia, in 0.04 seconds)2537clare: must succeed: nix-build --expr '2538 builtins.derivation {2539 name = "hi";2540 builder = "/bin/sh";2541 args = [ "-c" "echo hi > $out" ];2542 system = "aarch64-linux";2543 }2544' 2>&125452546clare # [ 11.998628] systemd-resolved[301]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2547clare # [ 12.507835] systemd-resolved[301]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2548clare # [ 12.512993] systemd-resolved[301]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2549clare # [ 12.518404] systemd-resolved[301]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2550clare # [ 12.521318] systemd-resolved[301]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2551clare # [ 13.627728] systemd-resolved[301]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2552clare # [ 13.631823] systemd-resolved[301]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2553clare # [ 15.844672] systemd-resolved[301]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2554clare # [ 15.848972] systemd-resolved[301]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2555clare: (finished: must succeed: nix-build --expr '2556 builtins.derivation {2557 name = "hi";2558 builder = "/bin/sh";2559 args = [ "-c" "echo hi > $out" ];2560 system = "aarch64-linux";2561 }2562' 2>&12563, in 4.37 seconds)2564alice: must succeed: nix-build --expr '2565 builtins.derivation {2566 name = "hi";2567 builder = "/bin/sh";2568 args = [ "-c" "echo hi > $out" ];2569 system = "aarch64-linux";2570 }2571' 2>&125722573alice # [ 16.002590] systemd-resolved[313]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2574bob # [ 15.997268] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:60888","trace_id":"cb92d3483ec2fcd1c14115ee72577305","span_id":"983ecbec09cf2c53","status":200,"elapsed":0.03076,"bytes":50,"time":"2026-10-05T15:30:52Z","message":"handled request"}2575alice # [ 16.290235] systemd-resolved[313]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2576alice # [ 16.293990] systemd-resolved[313]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2577alice # [ 16.984594] systemd-resolved[313]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2578alice # [ 16.988731] systemd-resolved[313]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2579alice # [ 18.155538] systemd-resolved[313]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2580alice # [ 18.158647] systemd-resolved[313]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2581alice # [ 20.794122] systemd-resolved[313]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2582alice # [ 20.798163] systemd-resolved[313]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2583bob # [ 20.803562] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","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-05T15:30:57Z","message":"download the narinfo from upstream"}2584bob # [ 20.833536] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-05T15:30:57Z","message":"downloading the nar from upstream"}2585bob # [ 20.854707] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","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-05T15:30:57Z","message":"download the nar from upstream"}2586bob # [ 20.883686] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-05T15:30:57Z","message":"storing narinfo and nar_file record in the database"}2587bob # [ 20.898612] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":61.35096,"time":"2026-10-05T15:30:57Z","message":"download of nar complete"}2588bob # [ 20.910537] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":94.34508,"time":"2026-10-05T15:30:57Z","message":"download of narinfo complete"}2589bob # [ 20.919811] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60888","trace_id":"6cb60a8f0474b35e52b25369adacd195","span_id":"86210915a0e4771b","status":200,"elapsed":97.55588,"bytes":532,"time":"2026-10-05T15:30:57Z","message":"handled request"}2590bob # [ 20.925570] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[587]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:60888","trace_id":"14daad5a2803c419ce1c64ec21c4e733","span_id":"2f889bca2e67a980","status":200,"elapsed":0.69076,"bytes":95,"time":"2026-10-05T15:30:57Z","message":"handled request"}2591alice: (finished: must succeed: nix-build --expr '2592 builtins.derivation {2593 name = "hi";2594 builder = "/bin/sh";2595 args = [ "-c" "echo hi > $out" ];2596 system = "aarch64-linux";2597 }2598' 2>&12599, in 5.01 seconds)2600(finished: run the VM test script, in 21.86 seconds)2601test script finished in 22.14s2602cleanup2603kill QemuMachine (pid 48)2604alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2605alice # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2606alice # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2607alice # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2608kill QemuMachine (pid 49)2609bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2610bob # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2611bob # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2612bob # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2613kill QemuMachine (pid 50)2614clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2615clare # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2616clare # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2617clare # [2026-10-05T15:30:58Z INFO virtiofsd] Client disconnected, shutting down2618(finished: cleanup, in 0.48 seconds)