vm-test-run-ncps
checks.aarch64-linux.ncps
· build #805
· raw
1build01: building 03dp3nnj9b1b6i575zrlwqhjbsihm0d7-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: QEMU running (pid 48)16clare: QEMU running (pid 50)17alice # Disk image does not exist, creating the virtualisation disk image...18clare # Disk image does not exist, creating the virtualisation disk image...19bob # Disk image does not exist, creating the virtualisation disk image...20bob: QEMU running (pid 49)21clare # Formatting '/build/vm-state-clare/tmp.QlJhrQZ0pJ', fmt=raw size=107374182422alice # Formatting '/build/vm-state-alice/tmp.FpbhCoROZB', fmt=raw size=107374182423clare # mke2fs 1.47.4 (6-Mar-2025)24alice # mke2fs 1.47.4 (6-Mar-2025)25clare # Discarding device blocks: 0/262144 done26alice # Discarding device blocks: 0/262144 done27clare # Creating filesystem with 262144 4k blocks and 65536 inodes28alice # Creating filesystem with 262144 4k blocks and 65536 inodes29bob # Formatting '/build/vm-state-bob/tmp.QfJJskwKXw', fmt=raw size=107374182430(finished: start all VMs, in 0.53 seconds)31clare # Filesystem UUID: b0907bf0-909a-4a59-a898-264bb9a2d8a432clare # Superblock backups stored on blocks:33alice # Filesystem UUID: 24a2eb0e-d708-4a3b-8abc-89e28b0e455c34bob: waiting for unit ncps35alice # Superblock backups stored on blocks:36bob # mke2fs 1.47.4 (6-Mar-2025)37bob: waiting for the VM to finish booting38clare # 32768, 98304, 163840, 22937639alice # 32768, 98304, 163840, 22937640clare # 41alice # 42clare # Allocating group tables: 0/8 done43alice # Allocating group tables: 0/8 done44clare # Writing inode tables: 0/8 done45alice # Writing inode tables: 0/8 done46clare # Creating journal (8192 blocks): done47alice # Creating journal (8192 blocks): done48clare # Writing superblocks and filesystem accounting information: 0/8 done49alice # Writing superblocks and filesystem accounting information: 0/8 done50clare # 51alice # 52clare # Virtualisation disk image created.53alice # Virtualisation disk image created.54clare # Starting virtiofs daemons...55alice # Starting virtiofs daemons...56clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)57alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)58clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether59alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether60clare # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...61alice # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...62clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)63alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)64clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether65alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether66clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)67bob # Discarding device blocks: 0/262144 done68clare # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether69bob # Creating filesystem with 262144 4k blocks and 65536 inodes70clare # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...71bob # Filesystem UUID: 645812f6-01fd-4217-af76-a5305169bf6472clare # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...73bob # Superblock backups stored on blocks:74clare # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests75bob # 32768, 98304, 163840, 22937676clare # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests77bob # 78clare # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests79bob # Allocating group tables: 0/8 done80alice # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...81bob # Writing inode tables: 0/8 done82alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)83bob # Creating journal (8192 blocks): done84alice # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether85bob # Writing superblocks and filesystem accounting information: 0/8 done86alice # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...87bob # 88alice # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests89bob # Virtualisation disk image created.90alice # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests91bob # Starting virtiofs daemons...92alice # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests93bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)94bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether95bob # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...96bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)97bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether98bob # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...99bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)100bob # [2026-09-29T10:26:50Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether101bob # [2026-09-29T10:26:50Z INFO virtiofsd] Waiting for vhost-user socket connection...102bob # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests103bob # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests104bob # [2026-09-29T10:26:50Z INFO virtiofsd] Client connected, servicing requests105alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]106alice # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026107alice # [ 0.000000] KASLR enabled108alice # [ 0.000000] random: crng init done109alice # [ 0.000000] Machine model: linux,dummy-virt110alice # [ 0.000000] efi: UEFI not found.111alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT112alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]113alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]114alice # [ 0.000000] Zone ranges:115alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]116alice # [ 0.000000] DMA32 empty117alice # [ 0.000000] Normal empty118alice # [ 0.000000] Device empty119alice # [ 0.000000] Movable zone start for each node120alice # [ 0.000000] Early memory node ranges121alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]122alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]123alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000124alice # [ 0.000000] psci: probing for conduit method from DT.125alice # [ 0.000000] psci: PSCIv1.3 detected in firmware.126alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs127alice # [ 0.000000] psci: Trusted OS migration not required128alice # [ 0.000000] psci: SMC Calling Convention v1.1129clare # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]130alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)131clare # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026132alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296133clare # [ 0.000000] KASLR enabled134alice # [ 0.000000] Detected PIPT I-cache on CPU0135clare # [ 0.000000] random: crng init done136alice # [ 0.000000] CPU features: detected: GICv3 CPU interface137clare # [ 0.000000] Machine model: linux,dummy-virt138alice # [ 0.000000] CPU features: detected: Spectre-v4139clare # [ 0.000000] efi: UEFI not found.140bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]141alice # [ 0.000000] CPU features: detected: Spectre-BHB142clare # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT143alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR144bob # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026145clare # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]146bob # [ 0.000000] KASLR enabled147alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)148bob # [ 0.000000] random: crng init done149clare # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]150alice # [ 0.000000] CPU features: detected: ARM erratum 1418040151clare # [ 0.000000] Zone ranges:152bob # [ 0.000000] Machine model: linux,dummy-virt153bob # [ 0.000000] efi: UEFI not found.154alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion155clare # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]156clare # [ 0.000000] DMA32 empty157clare # [ 0.000000] Normal empty158alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing159bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT160clare # [ 0.000000] Device empty161alice # [ 0.000000] alternatives: applying boot alternatives162clare # [ 0.000000] Movable zone start for each node163bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]164clare # [ 0.000000] Early memory node ranges165bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]166bob # [ 0.000000] Zone ranges:167clare # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]168bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]169clare # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]170bob # [ 0.000000] DMA32 empty171bob # [ 0.000000] Normal empty172clare # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000173bob # [ 0.000000] Device empty174clare # [ 0.000000] psci: probing for conduit method from DT.175bob # [ 0.000000] Movable zone start for each node176alice # [ 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/mbbrg5s2mrrqc9df28k7m3g5hyfypvzz-nixos-system-alice-test/init regInfo=/nix/.ro-store/z6zx5awv08jarwl2q1wl0kkicviq8iia-closure-info/registration console=ttyAMA0,115200n8 console=tty0177bob # [ 0.000000] Early memory node ranges178clare # [ 0.000000] psci: PSCIv1.3 detected in firmware.179clare # [ 0.000000] psci: Using standard PSCI v0.2 function IDs180bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]181clare # [ 0.000000] psci: Trusted OS migration not required182alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/z6zx5awv08jarwl2q1wl0kkicviq8iia-closure-info/registration", will be passed to user space.183bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]184clare # [ 0.000000] psci: SMC Calling Convention v1.1185bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000186alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes187clare # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)188bob # [ 0.000000] psci: probing for conduit method from DT.189alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)190bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.191clare # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296192bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs193clare # [ 0.000000] Detected PIPT I-cache on CPU0194alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)195bob # [ 0.000000] psci: Trusted OS migration not required196clare # [ 0.000000] CPU features: detected: GICv3 CPU interface197alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB198bob # [ 0.000000] psci: SMC Calling Convention v1.1199clare # [ 0.000000] CPU features: detected: Spectre-v4200alice # [ 0.000000] software IO TLB: area num 1.201clare # [ 0.000000] CPU features: detected: Spectre-BHB202bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)203alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)204clare # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR205alice # [ 0.000000] Fallback order for Node 0: 0206bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296207clare # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)208bob # [ 0.000000] Detected PIPT I-cache on CPU0209alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144210clare # [ 0.000000] CPU features: detected: ARM erratum 1418040211bob # [ 0.000000] CPU features: detected: GICv3 CPU interface212alice # [ 0.000000] Policy zone: DMA213bob # [ 0.000000] CPU features: detected: Spectre-v4214clare # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion215alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off216bob # [ 0.000000] CPU features: detected: Spectre-BHB217alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1218clare # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing219bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR220clare # [ 0.000000] alternatives: applying boot alternatives221alice # [ 0.000000] allocated 2097152 bytes of page_ext222bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)223alice # [ 0.000000] ftrace: allocating 74966 entries in 294 pages224alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups225bob # [ 0.000000] CPU features: detected: ARM erratum 1418040226alice # [ 0.000000] rcu: Hierarchical RCU implementation.227bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion228alice # [ 0.000000] rcu: RCU event tracing is enabled.229bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing230alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.231bob # [ 0.000000] alternatives: applying boot alternatives232alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.233clare # [ 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/8xdhh15jdy0rs5a0nffgvrq0i3g11hdq-nixos-system-clare-test/init regInfo=/nix/.ro-store/0p8v6k329h145msw8jgycck3pmv2gkwv-closure-info/registration console=ttyAMA0,115200n8 console=tty0234alice # [ 0.000000] Rude variant of Tasks RCU enabled.235alice # [ 0.000000] Tracing variant of Tasks RCU enabled.236clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/0p8v6k329h145msw8jgycck3pmv2gkwv-closure-info/registration", will be passed to user space.237alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.238alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1239clare # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes240bob # [ 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/zw49rrmqsf4zgvxr3ds5l8yxjdiw3yc9-nixos-system-bob-test/init regInfo=/nix/.ro-store/yzzk70zv0r6gnmirfgvrkwsv14h7jdpf-closure-info/registration console=ttyAMA0,115200n8 console=tty0241clare # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)242alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.243clare # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)244alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.245bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/yzzk70zv0r6gnmirfgvrkwsv14h7jdpf-closure-info/registration", will be passed to user space.246clare # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB247clare # [ 0.000000] software IO TLB: area num 1.248alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.249bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes250alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0251clare # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)252bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)253alice # [ 0.000000] GICv3: 256 SPIs implemented254clare # [ 0.000000] Fallback order for Node 0: 0255alice # [ 0.000000] GICv3: 0 Extended SPIs implemented256bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)257clare # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144258alice # [ 0.000000] Root IRQ handler: gic_handle_irq259clare # [ 0.000000] Policy zone: DMA260bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB261alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI262bob # [ 0.000000] software IO TLB: area num 1.263clare # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off264alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0265clare # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1266bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)267alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000268clare # [ 0.000000] allocated 2097152 bytes of page_ext269bob # [ 0.000000] Fallback order for Node 0: 0270alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]271clare # [ 0.000000] ftrace: allocating 74966 entries in 294 pages272bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144273clare # [ 0.000000] ftrace: allocated 294 pages with 4 groups274bob # [ 0.000000] Policy zone: DMA275alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)276clare # [ 0.000000] rcu: Hierarchical RCU implementation.277bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off278clare # [ 0.000000] rcu: RCU event tracing is enabled.279alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)280bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1281clare # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.282alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000283bob # [ 0.000000] allocated 2097152 bytes of page_ext284clare # [ 0.000000] Trampoline variant of Tasks RCU enabled.285bob # [ 0.000000] ftrace: allocating 74966 entries in 294 pages286alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000287clare # [ 0.000000] Rude variant of Tasks RCU enabled.288bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups289alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.290clare # [ 0.000000] Tracing variant of Tasks RCU enabled.291bob # [ 0.000000] rcu: Hierarchical RCU implementation.292bob # [ 0.000000] rcu: RCU event tracing is enabled.293clare # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.294alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns295bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.296clare # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1297alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040298bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.299alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).300clare # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.301bob # [ 0.000000] Rude variant of Tasks RCU enabled.302bob # [ 0.000000] Tracing variant of Tasks RCU enabled.303clare # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.304alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns305bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.306clare # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.307alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns308bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1309alice # [ 0.000056] arm-pv: using stolen time PV310clare # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0311bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.312clare # [ 0.000000] GICv3: 256 SPIs implemented313clare # [ 0.000000] GICv3: 0 Extended SPIs implemented314alice # [ 0.000411] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)315bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.316clare # [ 0.000000] Root IRQ handler: gic_handle_irq317alice # [ 0.000690] Console: colour dummy device 80x25318alice # [ 0.000710] printk: legacy console [tty0] enabled319clare # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI320bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.321clare # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0322bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0323alice # [ 0.000973] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)324clare # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000325bob # [ 0.000000] GICv3: 256 SPIs implemented326alice # [ 0.000978] pid_max: default: 32768 minimum: 301327clare # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]328bob # [ 0.000000] GICv3: 0 Extended SPIs implemented329alice # [ 0.001064] LSM: initializing lsm=capability,landlock,yama,bpf,ima330bob # [ 0.000000] Root IRQ handler: gic_handle_irq331clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)332alice # [ 0.001196] landlock: Up and running.333bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI334alice # [ 0.001198] Yama: becoming mindful.335bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0336alice # [ 0.001628] LSM support for eBPF active337clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)338bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000339alice # [ 0.001802] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)340clare # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000341bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]342alice # [ 0.001823] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)343clare # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000344bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)345alice # [ 0.004644] rcu: Hierarchical SRCU implementation.346clare # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.347alice # [ 0.004649] rcu: Max phase no-delay instances is 1000.348bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)349alice # [ 0.005613] fsl-mc MSI: its@8080000 domain created350clare # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns351alice # [ 0.005802] EFI services will not be available.352bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000353clare # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040354alice # [ 0.005885] smp: Bringing up secondary CPUs ...355bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000356alice # [ 0.005913] smp: Brought up 1 node, 1 CPU357clare # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).358alice # [ 0.005916] SMP: Total of 1 processors activated.359bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.360alice # [ 0.005918] CPU: All CPU(s) started at EL1361clare # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns362alice # [ 0.005929] CPU features: detected: 32-bit EL0 Support363bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns364clare # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns365alice # [ 0.005931] CPU features: detected: Data cache clean to the PoU not required for I/D coherence366bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040367clare # [ 0.000045] arm-pv: using stolen time PV368alice # [ 0.005935] CPU features: detected: Common not Private translations369bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).370alice # [ 0.005937] CPU features: detected: CRC32 instructions371clare # [ 0.000357] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)372clare # [ 0.000622] Console: colour dummy device 80x25373bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns374alice # [ 0.005938] CPU features: detected: Data cache clean to Point of Persistence375clare # [ 0.000643] printk: legacy console [tty0] enabled376alice # [ 0.005941] CPU features: detected: Enhanced Virtualization Traps377bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns378bob # [ 0.000053] arm-pv: using stolen time PV379clare # [ 0.000877] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)380alice # [ 0.005951] CPU features: detected: RCpc load-acquire (LDAPR)381clare # [ 0.000882] pid_max: default: 32768 minimum: 301382alice # [ 0.005953] CPU features: detected: LSE atomic instructions383bob # [ 0.000367] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)384clare # [ 0.000968] LSM: initializing lsm=capability,landlock,yama,bpf,ima385alice # [ 0.005956] CPU features: detected: Privileged Access Never386bob # [ 0.000635] Console: colour dummy device 80x25387clare # [ 0.001100] landlock: Up and running.388alice # [ 0.005958] CPU features: detected: PMUv3389bob # [ 0.000657] printk: legacy console [tty0] enabled390clare # [ 0.001102] Yama: becoming mindful.391alice # [ 0.005960] CPU features: detected: RAS Extension Support392clare # [ 0.001528] LSM support for eBPF active393alice # [ 0.005963] CPU features: detected: Speculative Store Bypassing Safe (SSBS)394bob # [ 0.000888] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)395clare # [ 0.001710] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)396bob # [ 0.000893] pid_max: default: 32768 minimum: 301397alice # [ 0.005984] alternatives: applying system-wide alternatives398bob # [ 0.000975] LSM: initializing lsm=capability,landlock,yama,bpf,ima399clare # [ 0.001728] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)400alice # [ 0.007403] CPU features: detected: Hardware dirty bit management on CPU0401bob # [ 0.001111] landlock: Up and running.402clare # [ 0.004435] rcu: Hierarchical SRCU implementation.403bob # [ 0.001113] Yama: becoming mindful.404clare # [ 0.004441] rcu: Max phase no-delay instances is 1000.405bob # [ 0.001486] LSM support for eBPF active406clare # [ 0.005386] fsl-mc MSI: its@8080000 domain created407alice # [ 0.007617] Memory: 891260K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 116024K reserved, 32768K cma-reserved)408bob # [ 0.001646] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)409clare # [ 0.005630] EFI services will not be available.410alice # [ 0.008063] devtmpfs: initialized411clare # [ 0.005715] smp: Bringing up secondary CPUs ...412bob # [ 0.001666] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)413alice # [ 0.009528] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)414clare # [ 0.005742] smp: Brought up 1 node, 1 CPU415bob # [ 0.004354] rcu: Hierarchical SRCU implementation.416clare # [ 0.005745] SMP: Total of 1 processors activated.417alice # [ 0.009550] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).418bob # [ 0.004360] rcu: Max phase no-delay instances is 1000.419clare # [ 0.005747] CPU: All CPU(s) started at EL1420bob # [ 0.005305] fsl-mc MSI: its@8080000 domain created421clare # [ 0.005761] CPU features: detected: 32-bit EL0 Support422alice # [ 0.009665] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL423bob # [ 0.005512] EFI services will not be available.424alice # [ 0.009670] 0 pages in range for non-PLT usage425bob # [ 0.005595] smp: Bringing up secondary CPUs ...426alice # [ 0.009670] 508224 pages in range for PLT usage427clare # [ 0.005764] CPU features: detected: Data cache clean to the PoU not required for I/D coherence428bob # [ 0.005620] smp: Brought up 1 node, 1 CPU429alice # [ 0.009779] pinctrl core: initialized pinctrl subsystem430clare # [ 0.005767] CPU features: detected: Common not Private translations431bob # [ 0.005623] SMP: Total of 1 processors activated.432alice # [ 0.010582] DMI not present or invalid.433clare # [ 0.005769] CPU features: detected: CRC32 instructions434bob # [ 0.005625] CPU: All CPU(s) started at EL1435alice # [ 0.013917] NET: Registered PF_NETLINK/PF_ROUTE protocol family436bob # [ 0.005636] CPU features: detected: 32-bit EL0 Support437clare # [ 0.005771] CPU features: detected: Data cache clean to Point of Persistence438alice # [ 0.016538] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations439clare # [ 0.005774] CPU features: detected: Enhanced Virtualization Traps440bob # [ 0.005639] CPU features: detected: Data cache clean to the PoU not required for I/D coherence441alice # [ 0.016675] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations442clare # [ 0.005786] CPU features: detected: RCpc load-acquire (LDAPR)443bob # [ 0.005642] CPU features: detected: Common not Private translations444clare # [ 0.005788] CPU features: detected: LSE atomic instructions445bob # [ 0.005644] CPU features: detected: CRC32 instructions446alice # [ 0.016828] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations447clare # [ 0.005790] CPU features: detected: Privileged Access Never448alice # [ 0.016843] audit: initializing netlink subsys (disabled)449bob # [ 0.005646] CPU features: detected: Data cache clean to Point of Persistence450clare # [ 0.005792] CPU features: detected: PMUv3451alice # [ 0.017456] thermal_sys: Registered thermal governor 'fair_share'452bob # [ 0.005648] CPU features: detected: Enhanced Virtualization Traps453clare # [ 0.005794] CPU features: detected: RAS Extension Support454alice # [ 0.017458] thermal_sys: Registered thermal governor 'bang_bang'455bob # [ 0.005658] CPU features: detected: RCpc load-acquire (LDAPR)456clare # [ 0.005798] CPU features: detected: Speculative Store Bypassing Safe (SSBS)457alice # [ 0.017461] thermal_sys: Registered thermal governor 'step_wise'458bob # [ 0.005660] CPU features: detected: LSE atomic instructions459clare # [ 0.005818] alternatives: applying system-wide alternatives460alice # [ 0.017464] thermal_sys: Registered thermal governor 'user_space'461bob # [ 0.005662] CPU features: detected: Privileged Access Never462clare # [ 0.007199] CPU features: detected: Hardware dirty bit management on CPU0463bob # [ 0.005664] CPU features: detected: PMUv3464alice # [ 0.017466] thermal_sys: Registered thermal governor 'power_allocator'465bob # [ 0.005665] CPU features: detected: RAS Extension Support466alice # [ 0.017509] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1467bob # [ 0.005669] CPU features: detected: Speculative Store Bypassing Safe (SSBS)468clare # [ 0.007351] Memory: 891248K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 116024K reserved, 32768K cma-reserved)469alice # [ 0.017529] cpuidle: using governor ladder470clare # [ 0.007804] devtmpfs: initialized471bob # [ 0.005690] alternatives: applying system-wide alternatives472alice # [ 0.017534] cpuidle: using governor menu473clare # [ 0.009258] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)474bob # [ 0.007170] CPU features: detected: Hardware dirty bit management on CPU0475alice # [ 0.017658] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.476alice # [ 0.017679] ASID allocator initialised with 32768 entries477clare # [ 0.009279] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).478alice # [ 0.018337] Serial: AMBA PL011 UART driver479clare # [ 0.009404] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL480bob # [ 0.007349] Memory: 891244K/1048576K available (24448K kernel code, 7094K rwdata, 26596K rodata, 4736K init, 1107K bss, 116000K reserved, 32768K cma-reserved)481bob # [ 0.007803] devtmpfs: initialized482clare # [ 0.009408] 0 pages in range for non-PLT usage483alice # [ 0.021922] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1484clare # [ 0.009409] 508224 pages in range for PLT usage485alice # [ 0.022098] printk: console [ttyAMA0] enabled486bob # [ 0.009231] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)487clare # [ 0.009491] pinctrl core: initialized pinctrl subsystem488clare # [ 0.010293] DMI not present or invalid.489bob # [ 0.009254] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).490clare # [ 0.013591] NET: Registered PF_NETLINK/PF_ROUTE protocol family491bob # [ 0.009389] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL492bob # [ 0.009394] 0 pages in range for non-PLT usage493clare # [ 0.016019] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations494bob # [ 0.009395] 508224 pages in range for PLT usage495clare # [ 0.016173] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations496bob # [ 0.009501] pinctrl core: initialized pinctrl subsystem497bob # [ 0.010260] DMI not present or invalid.498clare # [ 0.016327] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations499bob # [ 0.013483] NET: Registered PF_NETLINK/PF_ROUTE protocol family500clare # [ 0.016344] audit: initializing netlink subsys (disabled)501bob # [ 0.015921] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations502clare # [ 0.016918] thermal_sys: Registered thermal governor 'fair_share'503bob # [ 0.016056] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations504clare # [ 0.016920] thermal_sys: Registered thermal governor 'bang_bang'505clare # [ 0.016923] thermal_sys: Registered thermal governor 'step_wise'506bob # [ 0.016233] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations507clare # [ 0.016925] thermal_sys: Registered thermal governor 'user_space'508bob # [ 0.016250] audit: initializing netlink subsys (disabled)509clare # [ 0.016927] thermal_sys: Registered thermal governor 'power_allocator'510bob # [ 0.016791] thermal_sys: Registered thermal governor 'fair_share'511bob # [ 0.016793] thermal_sys: Registered thermal governor 'bang_bang'512clare # [ 0.016960] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1513clare # [ 0.016974] cpuidle: using governor ladder514bob # [ 0.016797] thermal_sys: Registered thermal governor 'step_wise'515clare # [ 0.016979] cpuidle: using governor menu516bob # [ 0.016799] thermal_sys: Registered thermal governor 'user_space'517clare # [ 0.017091] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.518bob # [ 0.016801] thermal_sys: Registered thermal governor 'power_allocator'519clare # [ 0.017110] ASID allocator initialised with 32768 entries520clare # [ 0.017787] Serial: AMBA PL011 UART driver521bob # [ 0.016840] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1522bob # [ 0.016854] cpuidle: using governor ladder523clare # [ 0.021522] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1524bob # [ 0.016859] cpuidle: using governor menu525clare # [ 0.021708] printk: console [ttyAMA0] enabled526bob # [ 0.016965] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.527bob # [ 0.016985] ASID allocator initialised with 32768 entries528bob # [ 0.017638] Serial: AMBA PL011 UART driver529alice # [ 0.093015] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages530alice # [ 0.093029] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page531bob # [ 0.021039] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1532bob # [ 0.021209] printk: console [ttyAMA0] enabled533alice # [ 0.093032] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages534alice # [ 0.093036] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page535alice # [ 0.093039] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages536alice # [ 0.093040] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page537alice # [ 0.093043] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages538alice # [ 0.093044] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page539alice # [ 0.094046] fbcon: Taking over console540alice # [ 0.094063] ACPI: Interpreter disabled.541alice # [ 0.096716] iommu: Default domain type: Translated542alice # [ 0.096721] iommu: DMA domain TLB invalidation policy: strict mode543alice # [ 0.097029] SCSI subsystem initialized544alice # [ 0.103119] usbcore: registered new interface driver usbfs545alice # [ 0.103150] usbcore: registered new interface driver hub546alice # [ 0.103162] usbcore: registered new device driver usb547alice # [ 0.103416] pps_core: LinuxPPS API ver. 1 registered548alice # [ 0.103419] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>549alice # [ 0.103423] PTP clock support registered550alice # [ 0.103456] EDAC MC: Ver: 3.0.0551clare # [ 0.094286] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages552alice # [ 0.103656] scmi_core: SCMI protocol bus registered553clare # [ 0.094299] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page554alice # [ 0.103931] FPGA manager framework555clare # [ 0.094302] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages556alice # [ 0.108749] vgaarb: loaded557clare # [ 0.094306] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page558bob # [ 0.093323] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages559clare # [ 0.094308] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages560bob # [ 0.093336] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page561clare # [ 0.094310] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page562bob # [ 0.093339] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages563clare # [ 0.094312] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages564bob # [ 0.093343] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page565clare # [ 0.094314] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page566bob # [ 0.093345] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages567clare # [ 0.095282] fbcon: Taking over console568clare # [ 0.095299] ACPI: Interpreter disabled.569bob # [ 0.093347] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page570clare # [ 0.095999] iommu: Default domain type: Translated571bob # [ 0.093349] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages572clare # [ 0.096003] iommu: DMA domain TLB invalidation policy: strict mode573bob # [ 0.093351] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page574clare # [ 0.096291] SCSI subsystem initialized575bob # [ 0.094341] fbcon: Taking over console576clare # [ 0.096537] usbcore: registered new interface driver usbfs577bob # [ 0.094357] ACPI: Interpreter disabled.578clare # [ 0.096568] usbcore: registered new interface driver hub579bob # [ 0.094998] iommu: Default domain type: Translated580clare # [ 0.096577] usbcore: registered new device driver usb581bob # [ 0.095014] iommu: DMA domain TLB invalidation policy: strict mode582clare # [ 0.096817] pps_core: LinuxPPS API ver. 1 registered583bob # [ 0.095309] SCSI subsystem initialized584bob # [ 0.095528] usbcore: registered new interface driver usbfs585clare # [ 0.096820] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>586bob # [ 0.095562] usbcore: registered new interface driver hub587clare # [ 0.096825] PTP clock support registered588bob # [ 0.095571] usbcore: registered new device driver usb589clare # [ 0.096853] EDAC MC: Ver: 3.0.0590bob # [ 0.095793] pps_core: LinuxPPS API ver. 1 registered591clare # [ 0.106669] scmi_core: SCMI protocol bus registered592bob # [ 0.095796] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>593alice # [ 0.109458] clocksource: Switched to clocksource arch_sys_counter594bob # [ 0.095800] PTP clock support registered595bob # [ 0.095826] EDAC MC: Ver: 3.0.0596bob # [ 0.105441] scmi_core: SCMI protocol bus registered597clare # [ 0.107432] FPGA manager framework598clare # [ 0.110583] vgaarb: loaded599bob # [ 0.106466] FPGA manager framework600clare # [ 0.111306] clocksource: Switched to clocksource arch_sys_counter601alice # [ 0.121972] VFS: Disk quotas dquot_6.6.0602alice # [ 0.121998] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)603bob # [ 0.109678] vgaarb: loaded604alice # [ 0.123493] netfs: FS-Cache loaded605alice # [ 0.123614] pnp: PnP ACPI: disabled606bob # [ 0.109902] clocksource: Switched to clocksource arch_sys_counter607alice # [ 0.126959] NET: Registered PF_INET protocol family608alice # [ 0.127152] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)609clare # [ 0.121273] VFS: Disk quotas dquot_6.6.0610clare # [ 0.121297] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)611clare # [ 0.122723] netfs: FS-Cache loaded612clare # [ 0.122887] pnp: PnP ACPI: disabled613bob # [ 0.120431] VFS: Disk quotas dquot_6.6.0614bob # [ 0.120456] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)615bob # [ 0.121823] netfs: FS-Cache loaded616clare # [ 0.126209] NET: Registered PF_INET protocol family617clare # [ 0.126385] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)618bob # [ 0.123119] pnp: PnP ACPI: disabled619bob # [ 0.124992] NET: Registered PF_INET protocol family620bob # [ 0.125166] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)621alice # [ 0.152067] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)622alice # [ 0.152090] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)623bob # [ 0.149401] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)624alice # [ 0.152103] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)625bob # [ 0.149424] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)626alice # [ 0.152137] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)627bob # [ 0.149437] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)628alice # [ 0.152204] TCP: Hash tables configured (established 8192 bind 8192)629bob # [ 0.149478] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)630alice # [ 0.152336] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)631bob # [ 0.149544] TCP: Hash tables configured (established 8192 bind 8192)632alice # [ 0.152363] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)633bob # [ 0.149658] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)634alice # [ 0.152419] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)635bob # [ 0.149721] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)636alice # [ 0.152529] NET: Registered PF_UNIX/PF_LOCAL protocol family637alice # [ 0.152568] NET: Registered PF_XDP protocol family638bob # [ 0.149746] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)639alice # [ 0.152589] PCI: CLS 0 bytes, default 64640bob # [ 0.149864] NET: Registered PF_UNIX/PF_LOCAL protocol family641alice # [ 0.152788] Trying to unpack rootfs image as initramfs...642clare # [ 0.150517] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)643clare # [ 0.150541] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)644clare # [ 0.150552] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)645clare # [ 0.150589] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)646clare # [ 0.150655] TCP: Hash tables configured (established 8192 bind 8192)647clare # [ 0.150755] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)648clare # [ 0.150815] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)649clare # [ 0.150836] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)650clare # [ 0.150962] NET: Registered PF_UNIX/PF_LOCAL protocol family651clare # [ 0.151027] NET: Registered PF_XDP protocol family652clare # [ 0.151052] PCI: CLS 0 bytes, default 64653clare # [ 0.151352] Trying to unpack rootfs image as initramfs...654clare # [ 0.165347] kvm [1]: HYP mode not available655alice # [ 0.167357] kvm [1]: HYP mode not available656bob # [ 0.155113] NET: Registered PF_XDP protocol family657bob # [ 0.155150] PCI: CLS 0 bytes, default 64658bob # [ 0.155356] Trying to unpack rootfs image as initramfs...659bob # [ 0.157998] kvm [1]: HYP mode not available660alice # [ 0.233632] Initialise system trusted keyrings661alice # [ 0.233943] workingset: timestamp_bits=42 max_order=18 bucket_order=0662alice # [ 0.234294] squashfs: version 4.0 (2009/01/31) Phillip Lougher663alice # [ 0.234329] 9p: Installing v9fs 9p2000 file system support664clare # [ 0.231918] Initialise system trusted keyrings665clare # [ 0.232035] workingset: timestamp_bits=42 max_order=18 bucket_order=0666clare # [ 0.232368] squashfs: version 4.0 (2009/01/31) Phillip Lougher667bob # [ 0.230410] Initialise system trusted keyrings668clare # [ 0.232401] 9p: Installing v9fs 9p2000 file system support669bob # [ 0.230532] workingset: timestamp_bits=42 max_order=18 bucket_order=0670bob # [ 0.230859] squashfs: version 4.0 (2009/01/31) Phillip Lougher671bob # [ 0.230903] 9p: Installing v9fs 9p2000 file system support672clare # [ 0.251223] Key type asymmetric registered673clare # [ 0.251243] Asymmetric key parser 'x509' registered674alice # [ 0.261149] Key type asymmetric registered675alice # [ 0.261168] Asymmetric key parser 'x509' registered676alice # [ 0.261237] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)677bob # [ 0.251495] Key type asymmetric registered678alice # [ 0.261333] io scheduler mq-deadline registered679bob # [ 0.251513] Asymmetric key parser 'x509' registered680alice # [ 0.261336] io scheduler kyber registered681bob # [ 0.251576] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)682alice # [ 0.263736] pl061_gpio 9030000.pl061: PL061 GPIO chip registered683bob # [ 0.251673] io scheduler mq-deadline registered684alice # [ 0.264086] ledtrig-cpu: registered to indicate activity on CPUs685bob # [ 0.251677] io scheduler kyber registered686alice # [ 0.264380] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:687alice # [ 0.264396] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000688alice # [ 0.264415] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000689alice # [ 0.264419] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000690alice # [ 0.264450] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits691alice # [ 0.264469] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]692alice # [ 0.264548] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00693alice # [ 0.264569] pci_bus 0000:00: root bus resource [bus 00-ff]694alice # [ 0.264572] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]695clare # [ 0.259361] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)696clare # [ 0.259487] io scheduler mq-deadline registered697alice # [ 0.264575] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]698clare # [ 0.259490] io scheduler kyber registered699alice # [ 0.264577] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]700clare # [ 0.261979] pl061_gpio 9030000.pl061: PL061 GPIO chip registered701clare # [ 0.262327] ledtrig-cpu: registered to indicate activity on CPUs702alice # [ 0.264689] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint703clare # [ 0.262627] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:704clare # [ 0.262644] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000705clare # [ 0.262662] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000706alice # [ 0.275335] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint707clare # [ 0.262667] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000708alice # [ 0.275476] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]709clare # [ 0.262703] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits710alice # [ 0.275485] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]711bob # [ 0.262035] pl061_gpio 9030000.pl061: PL061 GPIO chip registered712alice # [ 0.275505] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]713bob # [ 0.262404] ledtrig-cpu: registered to indicate activity on CPUs714clare # [ 0.262725] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]715alice # [ 0.275514] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]716clare # [ 0.262797] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00717bob # [ 0.262711] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:718clare # [ 0.262818] pci_bus 0000:00: root bus resource [bus 00-ff]719alice # [ 0.275854] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint720bob # [ 0.262727] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000721clare # [ 0.262821] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]722alice # [ 0.275984] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]723clare # [ 0.262823] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]724bob # [ 0.262746] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000725alice # [ 0.275993] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]726clare # [ 0.262826] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]727bob # [ 0.262751] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000728alice # [ 0.276013] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]729alice # [ 0.276339] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint730clare # [ 0.262894] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint731bob # [ 0.262782] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits732alice # [ 0.276469] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]733bob # [ 0.262806] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]734alice # [ 0.276478] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]735bob # [ 0.262874] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00736alice # [ 0.276497] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]737bob # [ 0.262894] pci_bus 0000:00: root bus resource [bus 00-ff]738alice # [ 0.276818] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint739bob # [ 0.262898] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]740alice # [ 0.276949] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]741bob # [ 0.262900] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]742alice # [ 0.276958] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]743bob # [ 0.262903] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]744alice # [ 0.276977] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]745bob # [ 0.262983] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint746alice # [ 0.276986] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]747bob # [ 0.263468] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint748bob # [ 0.263600] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]749bob # [ 0.263610] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]750bob # [ 0.263629] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]751bob # [ 0.263638] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]752bob # [ 0.263967] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint753bob # [ 0.264096] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]754bob # [ 0.264106] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]755bob # [ 0.264125] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]756bob # [ 0.264457] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint757bob # [ 0.264585] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]758bob # [ 0.264595] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]759bob # [ 0.264614] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]760bob # [ 0.264948] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint761clare # [ 0.279422] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint762bob # [ 0.265080] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]763clare # [ 0.279565] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]764bob # [ 0.265089] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]765clare # [ 0.279575] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]766bob # [ 0.265109] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]767clare # [ 0.279595] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]768bob # [ 0.265118] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]769clare # [ 0.279604] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]770bob # [ 0.265446] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint771clare # [ 0.279974] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint772bob # [ 0.265580] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]773clare # [ 0.280103] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]774bob # [ 0.265598] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]775clare # [ 0.280112] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]776clare # [ 0.280130] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]777alice # [ 0.293435] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint778alice # [ 0.293574] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]779clare # [ 0.280458] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint780clare # [ 0.280592] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]781alice # [ 0.293594] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]782bob # [ 0.284659] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint783clare # [ 0.280601] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]784bob # [ 0.284798] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]785alice # [ 0.293934] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint786clare # [ 0.280621] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]787bob # [ 0.284817] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]788alice # [ 0.294065] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]789clare # [ 0.280946] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint790alice # [ 0.294083] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]791bob # [ 0.285153] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint792clare # [ 0.281077] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]793bob # [ 0.285280] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]794alice # [ 0.294376] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint795clare # [ 0.281085] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]796alice # [ 0.294502] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]797bob # [ 0.285456] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint798clare # [ 0.281104] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]799bob # [ 0.285585] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]800clare # [ 0.281113] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]801alice # [ 0.294714] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint802bob # [ 0.285604] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]803alice # [ 0.294843] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]804clare # [ 0.281437] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint805alice # [ 0.294861] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]806clare # [ 0.281568] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]807clare # [ 0.281598] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]808alice # [ 0.295188] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint809alice # [ 0.295331] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]810clare # [ 0.281940] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint811alice # [ 0.295350] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]812clare # [ 0.282070] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]813clare # [ 0.282088] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]814alice # [ 0.295677] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint815alice # [ 0.295808] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]816clare # [ 0.282378] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint817alice # [ 0.295826] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]818clare # [ 0.282502] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]819alice # [ 0.296172] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint820clare # [ 0.282692] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint821alice # [ 0.296410] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]822clare # [ 0.282821] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]823alice # [ 0.296421] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]824clare # [ 0.282839] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]825alice # [ 0.296439] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]826clare # [ 0.283163] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint827alice # [ 0.296789] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint828clare # [ 0.283292] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]829alice # [ 0.296918] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]830clare # [ 0.299199] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]831alice # [ 0.296927] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]832alice # [ 0.296945] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]833alice # [ 0.310602] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned834clare # [ 0.300110] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint835alice # [ 0.310610] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned836clare # [ 0.300242] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]837alice # [ 0.310613] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned838bob # [ 0.298010] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint839clare # [ 0.300261] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]840bob # [ 0.298150] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]841alice # [ 0.310649] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned842clare # [ 0.300589] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint843bob # [ 0.298169] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]844clare # [ 0.300853] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]845alice # [ 0.310681] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned846clare # [ 0.300863] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]847bob # [ 0.298527] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint848alice # [ 0.310713] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned849bob # [ 0.298656] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]850clare # [ 0.300882] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]851alice # [ 0.310744] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned852bob # [ 0.298674] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]853clare # [ 0.301216] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint854alice # [ 0.310774] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned855bob # [ 0.299013] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint856clare # [ 0.301343] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]857bob # [ 0.299229] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]858clare # [ 0.301352] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]859alice # [ 0.310806] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned860bob # [ 0.299239] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]861clare # [ 0.301371] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]862alice # [ 0.310836] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned863bob # [ 0.299257] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]864clare # [ 0.301854] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned865alice # [ 0.310867] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned866clare # [ 0.301861] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned867bob # [ 0.299591] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint868alice # [ 0.310897] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned869bob # [ 0.299717] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]870clare # [ 0.301864] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned871bob # [ 0.299726] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]872alice # [ 0.310980] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned873clare # [ 0.301899] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned874bob # [ 0.299745] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]875alice # [ 0.311012] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned876clare # [ 0.301931] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned877bob # [ 0.300188] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned878alice # [ 0.311024] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned879bob # [ 0.300196] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned880clare # [ 0.301963] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned881alice # [ 0.311036] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned882alice # [ 0.311048] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned883bob # [ 0.300199] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned884clare # [ 0.301996] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned885alice # [ 0.311061] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned886bob # [ 0.300233] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned887clare # [ 0.302027] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned888alice # [ 0.311073] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned889bob # [ 0.300265] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned890clare # [ 0.302059] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned891alice # [ 0.311086] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned892bob # [ 0.300298] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned893clare # [ 0.302090] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned894alice # [ 0.311099] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned895bob # [ 0.300331] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned896clare # [ 0.302121] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned897alice # [ 0.311111] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned898bob # [ 0.300362] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned899alice # [ 0.311123] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned900clare # [ 0.302152] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned901alice # [ 0.311136] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned902bob # [ 0.300394] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned903clare # [ 0.302352] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned904alice # [ 0.311148] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned905bob # [ 0.300425] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned906clare # [ 0.302389] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned907alice # [ 0.311160] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned908clare # [ 0.302402] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned909bob # [ 0.300455] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned910alice # [ 0.311172] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned911clare # [ 0.302415] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned912bob # [ 0.300487] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned913alice # [ 0.311184] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned914clare # [ 0.302427] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned915alice # [ 0.311196] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned916bob # [ 0.300546] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned917clare # [ 0.302440] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned918alice # [ 0.311217] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned919bob # [ 0.300602] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned920clare # [ 0.302453] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned921alice # [ 0.311229] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned922bob # [ 0.300615] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned923alice # [ 0.311254] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]924clare # [ 0.302465] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned925bob # [ 0.300628] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned926alice # [ 0.311262] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]927clare # [ 0.302478] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned928bob # [ 0.300640] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned929alice # [ 0.311264] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]930clare # [ 0.302491] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned931bob # [ 0.300652] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned932alice # [ 0.311823] pci 0000:00:07.0: enabling device (0000 -> 0002)933clare # [ 0.302503] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned934bob # [ 0.300664] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned935clare # [ 0.302515] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned936bob # [ 0.300676] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned937clare # [ 0.302527] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned938bob # [ 0.300689] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned939clare # [ 0.302539] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned940bob # [ 0.300701] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned941clare # [ 0.302551] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned942bob # [ 0.300713] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned943clare # [ 0.302563] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned944bob # [ 0.300724] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned945clare # [ 0.302575] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned946bob # [ 0.300737] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned947clare # [ 0.302587] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned948bob # [ 0.300749] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned949clare # [ 0.302598] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned950clare # [ 0.302625] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]951bob # [ 0.300760] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned952clare # [ 0.302633] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]953bob # [ 0.300772] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned954clare # [ 0.302635] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]955bob # [ 0.300784] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned956clare # [ 0.303200] pci 0000:00:07.0: enabling device (0000 -> 0002)957bob # [ 0.300797] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned958bob # [ 0.300808] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned959bob # [ 0.300833] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]960bob # [ 0.300842] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]961bob # [ 0.300844] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]962bob # [ 0.301408] pci 0000:00:07.0: enabling device (0000 -> 0002)963alice # [ 0.342639] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)964alice # [ 0.344567] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)965bob # [ 0.333444] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)966clare # [ 0.335435] pci 0000:00:07.0: quirk_usb_early_handoff+0x0/0xa60 took 31491 usecs967clare # [ 0.342785] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)968alice # [ 0.355342] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)969bob # [ 0.343222] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)970clare # [ 0.352482] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)971clare # [ 0.356096] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)972alice # [ 0.365192] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)973clare # [ 0.357903] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)974alice # [ 0.368472] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)975bob # [ 0.354416] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)976bob # [ 0.356188] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)977alice # [ 0.371185] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)978alice # [ 0.372702] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)979bob # [ 0.359210] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)980bob # [ 0.361220] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)981clare # [ 0.367791] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)982clare # [ 0.369486] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)983clare # [ 0.371013] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)984alice # [ 0.382199] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)985alice # [ 0.383929] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)986bob # [ 0.371087] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)987bob # [ 0.372834] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)988bob # [ 0.375452] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)989bob # [ 0.377279] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)990clare # [ 0.380937] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)991clare # [ 0.382607] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)992alice # [ 0.394442] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)993clare # [ 0.385200] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)994alice # [ 0.396607] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)995clare # [ 0.387274] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)996bob # [ 0.387200] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)997bob # [ 0.391219] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled998clare # [ 0.398111] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled999clare # [ 0.399126] msm_serial: driver initialized1000clare # [ 0.399222] SuperH (H)SCI(F) driver initialized1001bob # [ 0.395244] msm_serial: driver initialized1002clare # [ 0.399278] STM32 USART driver initialized1003bob # [ 0.395323] SuperH (H)SCI(F) driver initialized1004bob # [ 0.395361] STM32 USART driver initialized1005alice # [ 0.409533] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1006alice # [ 0.410634] msm_serial: driver initialized1007alice # [ 0.410718] SuperH (H)SCI(F) driver initialized1008alice # [ 0.410758] STM32 USART driver initialized1009bob # [ 0.419924] loop: module loaded1010bob # [ 0.420063] virtio_blk virtio2: 1/0/0 default/read/poll queues1011bob # [ 0.420693] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1012alice # [ 0.433462] loop: module loaded1013alice # [ 0.433600] virtio_blk virtio2: 1/0/0 default/read/poll queues1014alice # [ 0.434262] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1015clare # [ 0.427498] loop: module loaded1016clare # [ 0.427636] virtio_blk virtio2: 1/0/0 default/read/poll queues1017clare # [ 0.428271] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1018alice # [ 0.438812] megasas: 07.734.00.00-rc11019alice # [ 0.439319] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1020clare # [ 0.433103] megasas: 07.734.00.00-rc11021clare # [ 0.433684] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1022clare # [ 0.436774] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001023clare # [ 0.436787] Intel/Sharp Extended Query Table at 0x00311024bob # [ 0.434367] megasas: 07.734.00.00-rc11025clare # [ 0.438367] Using buffer write method1026clare # [ 0.438415] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1027bob # [ 0.434872] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1028bob # [ 0.436997] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001029bob # [ 0.437011] Intel/Sharp Extended Query Table at 0x00311030bob # [ 0.440799] Using buffer write method1031bob # [ 0.440851] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1032alice # [ 0.453962] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001033alice # [ 0.453980] Intel/Sharp Extended Query Table at 0x00311034alice # [ 0.456278] Using buffer write method1035alice # [ 0.456340] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1036bob # [ 0.443573] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001037bob # [ 0.443586] Intel/Sharp Extended Query Table at 0x00311038bob # [ 0.445394] Using buffer write method1039bob # [ 0.445405] Concatenating MTD devices:1040bob # [ 0.445407] (0): "0.flash"1041bob # [ 0.445409] (1): "0.flash"1042bob # [ 0.445410] into device "0.flash"1043clare # [ 0.448238] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001044alice # [ 0.460082] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001045clare # [ 0.448253] Intel/Sharp Extended Query Table at 0x00311046clare # [ 0.450019] Using buffer write method1047alice # [ 0.460095] Intel/Sharp Extended Query Table at 0x00311048clare # [ 0.450031] Concatenating MTD devices:1049clare # [ 0.450033] (0): "0.flash"1050clare # [ 0.450035] (1): "0.flash"1051clare # [ 0.450037] into device "0.flash"1052alice # [ 0.469588] Using buffer write method1053alice # [ 0.469602] Concatenating MTD devices:1054alice # [ 0.469604] (0): "0.flash"1055alice # [ 0.469606] (1): "0.flash"1056alice # [ 0.469607] into device "0.flash"1057clare # [ 0.665223] Freeing initrd memory: 26968K1058alice # [ 0.679655] Freeing initrd memory: 26968K1059bob # [ 0.668934] Freeing initrd memory: 26944K1060clare # [ 0.672424] tun: Universal TUN/TAP device driver, 1.61061clare # [ 0.674814] thunder_xcv, ver 1.01062clare # [ 0.674829] thunder_bgx, ver 1.01063clare # [ 0.674838] nicpf, ver 1.01064clare # [ 0.675227] e1000: Intel(R) PRO/1000 Network Driver1065clare # [ 0.675231] e1000: Copyright (c) 1999-2006 Intel Corporation.1066clare # [ 0.675244] e1000e: Intel(R) PRO/1000 Network Driver1067clare # [ 0.675249] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1068clare # [ 0.675261] igb: Intel(R) Gigabit Ethernet Network Driver1069clare # [ 0.675265] igb: Copyright (c) 2007-2014 Intel Corporation.1070clare # [ 0.675276] igbvf: Intel(R) Gigabit Virtual Function Network Driver1071alice # [ 0.687645] tun: Universal TUN/TAP device driver, 1.61072clare # [ 0.675278] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1073bob # [ 0.676760] tun: Universal TUN/TAP device driver, 1.61074alice # [ 0.690465] thunder_xcv, ver 1.01075clare # [ 0.680271] sky2: driver version 1.301076alice # [ 0.690480] thunder_bgx, ver 1.01077alice # [ 0.690489] nicpf, ver 1.01078clare # [ 0.681203] usbcore: registered new interface driver usb-storage1079alice # [ 0.690819] e1000: Intel(R) PRO/1000 Network Driver1080bob # [ 0.679437] thunder_xcv, ver 1.01081clare # [ 0.681290] usbcore: registered new interface driver usbserial_generic1082alice # [ 0.690823] e1000: Copyright (c) 1999-2006 Intel Corporation.1083bob # [ 0.679452] thunder_bgx, ver 1.01084bob # [ 0.679460] nicpf, ver 1.01085alice # [ 0.690836] e1000e: Intel(R) PRO/1000 Network Driver1086clare # [ 0.681298] usbserial: USB Serial support registered for generic1087bob # [ 0.679792] e1000: Intel(R) PRO/1000 Network Driver1088clare # [ 0.681682] hv_vmbus: registering driver hyperv_keyboard1089alice # [ 0.690840] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1090bob # [ 0.679796] e1000: Copyright (c) 1999-2006 Intel Corporation.1091clare # [ 0.682646] ehci-pci 0000:00:07.0: EHCI Host Controller1092alice # [ 0.690852] igb: Intel(R) Gigabit Ethernet Network Driver1093bob # [ 0.679808] e1000e: Intel(R) PRO/1000 Network Driver1094alice # [ 0.690853] igb: Copyright (c) 2007-2014 Intel Corporation.1095clare # [ 0.682680] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11096bob # [ 0.679813] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1097alice # [ 0.690866] igbvf: Intel(R) Gigabit Virtual Function Network Driver1098clare # [ 0.682969] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001099bob # [ 0.679824] igb: Intel(R) Gigabit Ethernet Network Driver1100clare # [ 0.683140] rtc-pl031 9010000.pl031: registered as rtc01101alice # [ 0.690868] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1102bob # [ 0.679826] igb: Copyright (c) 2007-2014 Intel Corporation.1103alice # [ 0.690937] sky2: driver version 1.301104bob # [ 0.679838] igbvf: Intel(R) Gigabit Virtual Function Network Driver1105clare # [ 0.683166] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T10:26:51 UTC (1790677611)1106alice # [ 0.691802] usbcore: registered new interface driver usb-storage1107clare # [ 0.683387] i2c_dev: i2c /dev entries driver1108bob # [ 0.679840] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1109alice # [ 0.691888] usbcore: registered new interface driver usbserial_generic1110bob # [ 0.679906] sky2: driver version 1.301111alice # [ 0.691894] usbserial: USB Serial support registered for generic1112bob # [ 0.680736] usbcore: registered new interface driver usb-storage1113alice # [ 0.692207] hv_vmbus: registering driver hyperv_keyboard1114bob # [ 0.680815] usbcore: registered new interface driver usbserial_generic1115bob # [ 0.680822] usbserial: USB Serial support registered for generic1116bob # [ 0.681120] hv_vmbus: registering driver hyperv_keyboard1117clare # [ 0.690043] sdhci: Secure Digital Host Controller Interface driver1118clare # [ 0.690048] sdhci: Copyright(c) Pierre Ossman1119clare # [ 0.690222] Synopsys Designware Multimedia Card Interface Driver1120clare # [ 0.690422] sdhci-pltfm: SDHCI platform and OF driver helper1121clare # [ 0.691363] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001122clare # [ 0.691692] hub 1-0:1.0: USB hub found1123clare # [ 0.691711] hub 1-0:1.0: 6 ports detected1124alice # [ 0.699575] ehci-pci 0000:00:07.0: EHCI Host Controller1125alice # [ 0.699611] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11126clare # [ 0.694858] hid: raw HID events driver (C) Jiri Kosina1127bob # [ 0.688503] ehci-pci 0000:00:07.0: EHCI Host Controller1128alice # [ 0.699853] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001129clare # [ 0.695004] usbcore: registered new interface driver usbhid1130alice # [ 0.700032] rtc-pl031 9010000.pl031: registered as rtc01131bob # [ 0.688538] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11132clare # [ 0.695007] usbhid: USB HID core driver1133bob # [ 0.688750] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001134alice # [ 0.700059] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T10:26:51 UTC (1790677611)1135bob # [ 0.688945] rtc-pl031 9010000.pl031: registered as rtc01136alice # [ 0.700239] i2c_dev: i2c /dev entries driver1137alice # [ 0.701887] sdhci: Secure Digital Host Controller Interface driver1138bob # [ 0.688972] rtc-pl031 9010000.pl031: setting system clock to 2026-09-29T10:26:51 UTC (1790677611)1139alice # [ 0.701892] sdhci: Copyright(c) Pierre Ossman1140bob # [ 0.689146] i2c_dev: i2c /dev entries driver1141alice # [ 0.702047] Synopsys Designware Multimedia Card Interface Driver1142bob # [ 0.690745] sdhci: Secure Digital Host Controller Interface driver1143alice # [ 0.702232] sdhci-pltfm: SDHCI platform and OF driver helper1144bob # [ 0.690750] sdhci: Copyright(c) Pierre Ossman1145alice # [ 0.703115] hid: raw HID events driver (C) Jiri Kosina1146bob # [ 0.690897] Synopsys Designware Multimedia Card Interface Driver1147alice # [ 0.703286] usbcore: registered new interface driver usbhid1148bob # [ 0.691090] sdhci-pltfm: SDHCI platform and OF driver helper1149clare # [ 0.696968] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1150alice # [ 0.703289] usbhid: USB HID core driver1151bob # [ 0.692003] hid: raw HID events driver (C) Jiri Kosina1152clare # [ 0.697878] drop_monitor: Initializing network drop monitor service1153bob # [ 0.692134] usbcore: registered new interface driver usbhid1154clare # [ 0.698043] NET: Registered PF_INET6 protocol family1155bob # [ 0.692137] usbhid: USB HID core driver1156clare # [ 0.698649] Segment Routing with IPv61157clare # [ 0.698660] In-situ OAM (IOAM) with IPv61158clare # [ 0.698723] NET: Registered PF_PACKET protocol family1159clare # [ 0.698789] 9pnet: Installing 9P2000 support1160clare # [ 0.698824] Key type dns_resolver registered1161alice # [ 0.709711] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001162alice # [ 0.710079] hub 1-0:1.0: USB hub found1163alice # [ 0.710099] hub 1-0:1.0: 6 ports detected1164bob # [ 0.698501] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001165alice # [ 0.710396] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1166bob # [ 0.698859] hub 1-0:1.0: USB hub found1167bob # [ 0.698915] hub 1-0:1.0: 6 ports detected1168alice # [ 0.711275] drop_monitor: Initializing network drop monitor service1169alice # [ 0.711398] NET: Registered PF_INET6 protocol family1170bob # [ 0.699232] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1171alice # [ 0.712059] Segment Routing with IPv61172alice # [ 0.712070] In-situ OAM (IOAM) with IPv61173bob # [ 0.700070] drop_monitor: Initializing network drop monitor service1174alice # [ 0.712122] NET: Registered PF_PACKET protocol family1175bob # [ 0.700229] NET: Registered PF_INET6 protocol family1176alice # [ 0.712187] 9pnet: Installing 9P2000 support1177bob # [ 0.700865] Segment Routing with IPv61178bob # [ 0.700875] In-situ OAM (IOAM) with IPv61179clare # [ 0.704896] registered taskstats version 11180alice # [ 0.712226] Key type dns_resolver registered1181bob # [ 0.700940] NET: Registered PF_PACKET protocol family1182clare # [ 0.705057] Loading compiled-in X.509 certificates1183bob # [ 0.701005] 9pnet: Installing 9P2000 support1184bob # [ 0.701044] Key type dns_resolver registered1185alice # [ 0.719463] registered taskstats version 11186clare # [ 0.710430] Demotion targets for Node 0: null1187alice # [ 0.719601] Loading compiled-in X.509 certificates1188clare # [ 0.710502] Key type .fscrypt registered1189clare # [ 0.710505] Key type fscrypt-provisioning registered1190bob # [ 0.708168] registered taskstats version 11191clare # [ 0.710606] ima: No TPM chip found, activating TPM-bypass!1192bob # [ 0.708304] Loading compiled-in X.509 certificates1193clare # [ 0.710617] ima: Allocated hash algorithm: sha11194clare # [ 0.710675] ima: No architecture policies found1195clare # [ 0.711161] input: gpio-keys as /devices/platform/gpio-keys/input/input01196bob # [ 0.713717] Demotion targets for Node 0: null1197bob # [ 0.713795] Key type .fscrypt registered1198bob # [ 0.713798] Key type fscrypt-provisioning registered1199bob # [ 0.713944] ima: No TPM chip found, activating TPM-bypass!1200bob # [ 0.713955] ima: Allocated hash algorithm: sha11201bob # [ 0.714023] ima: No architecture policies found1202alice # [ 0.725359] Demotion targets for Node 0: null1203alice # [ 0.725441] Key type .fscrypt registered1204alice # [ 0.725444] Key type fscrypt-provisioning registered1205alice # [ 0.725546] ima: No TPM chip found, activating TPM-bypass!1206bob # [ 0.716927] input: gpio-keys as /devices/platform/gpio-keys/input/input01207alice # [ 0.725558] ima: Allocated hash algorithm: sha11208alice # [ 0.725613] ima: No architecture policies found1209alice # [ 0.726116] input: gpio-keys as /devices/platform/gpio-keys/input/input01210clare # [ 0.723708] clk: Disabling unused clocks1211clare # [ 0.723719] PM: genpd: Disabling unused power domains1212clare # [ 0.726023] Freeing unused kernel memory: 4736K1213clare # [ 0.726105] Run /init as init process1214alice # [ 0.738763] clk: Disabling unused clocks1215alice # [ 0.738775] PM: genpd: Disabling unused power domains1216bob # [ 0.727109] clk: Disabling unused clocks1217bob # [ 0.727121] PM: genpd: Disabling unused power domains1218bob # [ 0.729440] Freeing unused kernel memory: 4736K1219bob # [ 0.729533] Run /init as init process1220alice # [ 0.741958] Freeing unused kernel memory: 4736K1221alice # [ 0.742072] Run /init as init process1222clare # [ 0.746121] systemd[1]: Successfully made /usr/ read-only.1223alice # [ 0.763528] systemd[1]: Successfully made /usr/ read-only.1224bob # [ 0.752462] systemd[1]: Successfully made /usr/ read-only.1225clare # [ 0.943386] usb 1-1: new high-speed USB device number 2 using ehci-pci1226alice # [ 0.961076] usb 1-1: new high-speed USB device number 2 using ehci-pci1227bob # [ 0.949974] usb 1-1: new high-speed USB device number 2 using ehci-pci1228clare # [ 1.080264] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1229clare # [ 1.080297] systemd[1]: Detected virtualization qemu.1230clare # [ 1.080338] systemd[1]: Detected architecture arm64.1231clare # [ 1.080347] systemd[1]: Running in initrd.1232clare # [ 1.081157] systemd[1]: Initializing machine ID from random generator.1233clare # [ 1.081464] systemd[1]: Hostname set to <clare>.1234alice # [ 1.097733] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1235alice # [ 1.097763] systemd[1]: Detected virtualization qemu.1236bob # [ 1.086590] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1237alice # [ 1.097806] systemd[1]: Detected architecture arm64.1238bob # [ 1.086621] systemd[1]: Detected virtualization qemu.1239alice # [ 1.097816] systemd[1]: Running in initrd.1240bob # [ 1.086662] systemd[1]: Detected architecture arm64.1241bob # [ 1.086670] systemd[1]: Running in initrd.1242alice # [ 1.098620] systemd[1]: Initializing machine ID from random generator.1243alice # [ 1.098907] systemd[1]: Hostname set to <alice>.1244bob # [ 1.087604] systemd[1]: Initializing machine ID from random generator.1245bob # [ 1.088012] systemd[1]: Hostname set to <bob>.1246clare # [ 1.106159] 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.121592] 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/input11248bob # [ 1.118546] 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/input11249clare # [ 1.191498] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01250alice # [ 1.209192] 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.208709] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01252clare # [ 1.311459] usb 1-2: new high-speed USB device number 3 using ehci-pci1253alice # [ 1.329243] usb 1-2: new high-speed USB device number 3 using ehci-pci1254bob # [ 1.326104] usb 1-2: new high-speed USB device number 3 using ehci-pci1255clare # [ 1.378575] systemd[1]: bpf-restrict-fs: LSM BPF program attached1256alice # [ 1.395254] systemd[1]: bpf-restrict-fs: LSM BPF program attached1257bob # [ 1.387270] systemd[1]: bpf-restrict-fs: LSM BPF program attached1258clare # [ 1.446541] systemd[1]: Queued start job for default target Initrd Default Target.1259clare # [ 1.453026] systemd[1]: Created slice Slice /system/modprobe.1260clare # [ 1.453201] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1261clare # [ 1.453239] systemd[1]: Expecting device /dev/disk/by-label/nixos...1262clare # [ 1.453262] systemd[1]: Reached target Path Units.1263clare # [ 1.453277] systemd[1]: Reached target Slice Units.1264clare # [ 1.453290] systemd[1]: Reached target Swaps.1265clare # [ 1.453304] systemd[1]: Reached target Timer Units.1266clare # [ 1.453450] systemd[1]: Listening on D-Bus System Message Bus Socket.1267clare # [ 1.453607] systemd[1]: Listening on Journal Socket (/dev/log).1268clare # [ 1.453751] systemd[1]: Listening on Journal Sockets.1269clare # [ 1.453837] systemd[1]: Listening on udev Control Socket.1270clare # [ 1.453890] systemd[1]: Listening on udev Kernel Socket.1271clare # [ 1.453909] systemd[1]: Reached target Socket Units.1272clare # [ 1.455034] systemd[1]: Starting Create List of Static Device Nodes...1273clare # [ 1.455095] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1274bob # [ 1.460473] systemd[1]: Queued start job for default target Initrd Default Target.1275clare # [ 1.467240] systemd[1]: Mounting Kernel Configuration File System...1276clare # [ 1.470732] 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/input21277bob # [ 1.468910] systemd[1]: Created slice Slice /system/modprobe.1278bob # [ 1.469163] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1279bob # [ 1.469211] systemd[1]: Expecting device /dev/disk/by-label/nixos...1280bob # [ 1.469244] systemd[1]: Reached target Path Units.1281clare # [ 1.472917] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01282bob # [ 1.469269] systemd[1]: Reached target Slice Units.1283bob # [ 1.469290] systemd[1]: Reached target Swaps.1284bob # [ 1.469309] systemd[1]: Reached target Timer Units.1285bob # [ 1.469508] systemd[1]: Listening on D-Bus System Message Bus Socket.1286bob # [ 1.469691] systemd[1]: Listening on Journal Socket (/dev/log).1287alice # [ 1.488171] 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/input21288bob # [ 1.469874] systemd[1]: Listening on Journal Sockets.1289alice # [ 1.488320] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01290bob # [ 1.478620] systemd[1]: Listening on udev Control Socket.1291bob # [ 1.478733] systemd[1]: Listening on udev Kernel Socket.1292bob # [ 1.478761] systemd[1]: Reached target Socket Units.1293clare # [ 1.483435] systemd[1]: Starting Journal Service...1294bob # [ 1.484285] systemd[1]: Starting Create List of Static Device Nodes...1295bob # [ 1.484366] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1296clare # [ 1.488579] systemd[1]: Starting Load Kernel Modules...1297alice # [ 1.498266] systemd[1]: Queued start job for default target Initrd Default Target.1298clare # [ 1.488661] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1299bob # [ 1.491035] systemd[1]: Mounting Kernel Configuration File System...1300bob # [ 1.491845] 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/input21301alice # [ 1.507866] systemd[1]: Created slice Slice /system/modprobe.1302alice # [ 1.508166] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1303bob # [ 1.497417] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01304alice # [ 1.508224] systemd[1]: Expecting device /dev/disk/by-label/nixos...1305alice # [ 1.508265] systemd[1]: Reached target Path Units.1306alice # [ 1.508291] systemd[1]: Reached target Slice Units.1307alice # [ 1.508315] systemd[1]: Reached target Swaps.1308alice # [ 1.508339] systemd[1]: Reached target Timer Units.1309alice # [ 1.508629] systemd[1]: Listening on D-Bus System Message Bus Socket.1310alice # [ 1.508833] systemd[1]: Listening on Journal Socket (/dev/log).1311alice # [ 1.513747] systemd[1]: Listening on Journal Sockets.1312alice # [ 1.513941] systemd[1]: Listening on udev Control Socket.1313alice # [ 1.514032] systemd[1]: Listening on udev Kernel Socket.1314alice # [ 1.514063] systemd[1]: Reached target Socket Units.1315clare # [ 1.512961] systemd[1]: Starting Coldplug All udev Devices...1316bob # [ 1.512590] systemd[1]: Starting Journal Service...1317alice # [ 1.525165] systemd[1]: Starting Create List of Static Device Nodes...1318alice # [ 1.525262] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1319clare # [ 1.527420] systemd[1]: Finished Create List of Static Device Nodes.1320alice # [ 1.537189] systemd[1]: Mounting Kernel Configuration File System...1321bob # [ 1.526213] systemd[1]: Starting Load Kernel Modules...1322bob # [ 1.526309] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1323alice # [ 1.549262] systemd[1]: Starting Journal Service...1324alice # [ 1.565183] systemd[1]: Starting Load Kernel Modules...1325clare # [ 1.547606] systemd-journald[71]: Collecting audit messages is disabled.1326clare # [ 1.551474] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1327alice # [ 1.565273] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1328clare # [ 1.551897] systemd[1]: Mounted Kernel Configuration File System.1329bob # [ 1.558120] systemd[1]: Starting Coldplug All udev Devices...1330bob # [ 1.562002] systemd[1]: Finished Create List of Static Device Nodes.1331bob # [ 1.567813] systemd-journald[71]: Collecting audit messages is disabled.1332alice # [ 1.577161] systemd[1]: Starting Coldplug All udev Devices...1333clare # [ 1.573565] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1334clare # [ 1.574112] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1335clare # [ 1.579610] systemd[1]: Starting Create Static Device Nodes in /dev...1336alice # [ 1.593163] systemd[1]: Finished Create List of Static Device Nodes.1337alice # [ 1.594068] systemd[1]: Mounted Kernel Configuration File System.1338clare # [ 1.587370] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1339alice # [ 1.601353] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1340bob # [ 1.594050] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1341clare # [ 1.601376] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01342clare # [ 1.601609] [drm] features: -virgl +edid -resource_blob -host_visible1343clare # [ 1.601611] [drm] features: -context_init1344bob # [ 1.599105] systemd[1]: Mounted Kernel Configuration File System.1345clare # [ 1.602086] [drm] number of scanouts: 11346clare # [ 1.602095] [drm] number of cap sets: 01347bob # [ 1.606365] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1348bob # [ 1.607461] systemd[1]: Starting Create Static Device Nodes in /dev...1349alice # [ 1.628616] systemd-journald[71]: Collecting audit messages is disabled.1350clare # [ 1.619487] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1351clare # [ 1.619498] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01352clare # [ 1.619180] systemd-modules-load[72]: Inserted module 'dm_mod'1353clare # [ 1.627294] systemd[1]: Started Journal Service.1354clare # [ 1.621955] systemd-modules-load[72]: Module 'virtio_balloon' is built in1355alice # [ 1.638254] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1356clare # [ 1.632171] Console: switching to colour frame buffer device 160x501357clare # [ 1.632344] systemd-modules-load[72]: Module 'virtio_console' is built in1358clare # [ 1.640267] systemd[1]: Finished Create Static Device Nodes in /dev.1359clare # [ 1.641027] systemd[1]: Reached target Preparation for Local File Systems.1360bob # [ 1.643631] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1361clare # [ 1.641740] systemd[1]: Reached target Local File Systems.1362bob # [ 1.643772] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1363clare # [ 1.642394] systemd[1]: Starting Create System Files and Directories...1364bob # [ 1.642913] systemd-modules-load[73]: Inserted module 'dm_mod'1365clare # [ 1.644069] systemd[1]: Starting Rule-based Manager for Device Events and Files...1366alice # [ 1.657067] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1367alice # [ 1.658516] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1368bob # [ 1.648383] systemd[1]: Started Journal Service.1369alice # [ 1.659662] systemd[1]: Starting Create Static Device Nodes in /dev...1370bob # [ 1.654927] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01371bob # [ 1.655149] [drm] features: -virgl +edid -resource_blob -host_visible1372bob # [ 1.655151] [drm] features: -context_init1373bob # [ 1.655657] [drm] number of scanouts: 11374bob # [ 1.655665] [drm] number of cap sets: 01375bob # [ 1.654195] systemd-modules-load[73]: Module 'virtio_balloon' is built in1376clare # [ 1.659853] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1377bob # [ 1.656437] systemd-modules-load[73]: Module 'virtio_console' is built in1378alice # [ 1.674102] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01379alice # [ 1.674416] [drm] features: -virgl +edid -resource_blob -host_visible1380alice # [ 1.674418] [drm] features: -context_init1381alice # [ 1.674896] [drm] number of scanouts: 11382alice # [ 1.674905] [drm] number of cap sets: 01383clare # [ 1.661648] systemd-modules-load[72]: Inserted module 'virtio_gpu'1384clare # [ 1.662388] systemd-modules-load[72]: Module 'virtio_rng' is built in1385bob # [ 1.663254] systemd[1]: Finished Create Static Device Nodes in /dev.1386bob # [ 1.663970] systemd[1]: Reached target Preparation for Local File Systems.1387bob # [ 1.668324] systemd[1]: Reached target Local File Systems.1388bob # [ 1.668956] systemd[1]: Starting Create System Files and Directories...1389clare # [ 1.676076] systemd[1]: Finished Load Kernel Modules.1390alice # [ 1.689430] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1391alice # [ 1.689441] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01392clare # [ 1.677718] systemd[1]: Starting Apply Kernel Variables...1393bob # [ 1.678199] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1394bob # [ 1.678211] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01395bob # [ 1.685242] systemd[1]: Starting Rule-based Manager for Device Events and Files...1396alice # [ 1.711515] Console: switching to colour frame buffer device 160x501397bob # [ 1.702260] Console: switching to colour frame buffer device 160x501398alice # [ 1.711768] systemd-modules-load[72]: Inserted module 'dm_mod'1399alice # [ 1.718990] systemd[1]: Started Journal Service.1400clare # [ 1.705076] systemd[1]: Finished Create System Files and Directories.1401alice # [ 1.713130] systemd-modules-load[72]: Module 'virtio_balloon' is built in1402alice # [ 1.713905] systemd-modules-load[72]: Module 'virtio_console' is built in1403alice # [ 1.714697] systemd[1]: Finished Create Static Device Nodes in /dev.1404alice # [ 1.715419] systemd[1]: Reached target Preparation for Local File Systems.1405bob # [ 1.712709] systemd[1]: Finished Create System Files and Directories.1406clare # [ 1.716921] systemd-udevd[79]: Using default interface naming scheme 'v261'.1407clare # [ 1.718312] systemd[1]: Finished Apply Kernel Variables.1408alice # [ 1.733533] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1409bob # [ 1.722702] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1410alice # [ 1.732442] systemd[1]: Reached target Local File Systems.1411alice # [ 1.733673] systemd[1]: Starting Create System Files and Directories...1412alice # [ 1.734410] systemd-modules-load[72]: Inserted module 'virtio_gpu'1413bob # [ 1.726042] systemd-modules-load[73]: Inserted module 'virtio_gpu'1414bob # [ 1.726709] systemd-modules-load[73]: Module 'virtio_rng' is built in1415alice # [ 1.736104] systemd-modules-load[72]: Module 'virtio_rng' is built in1416alice # [ 1.741094] systemd[1]: Starting Rule-based Manager for Device Events and Files...1417alice # [ 1.741835] systemd[1]: Finished Load Kernel Modules.1418bob # [ 1.734706] systemd[1]: Finished Load Kernel Modules.1419bob # [ 1.735218] systemd[1]: Starting Apply Kernel Variables...1420clare # [ 1.741319] systemd[1]: Started Rule-based Manager for Device Events and Files.1421bob # [ 1.750499] systemd-udevd[80]: Using default interface naming scheme 'v261'.1422alice # [ 1.760081] systemd[1]: Starting Apply Kernel Variables...1423bob # [ 1.754687] systemd[1]: Finished Apply Kernel Variables.1424alice # [ 1.773157] systemd[1]: Finished Create System Files and Directories.1425bob # [ 1.772305] systemd[1]: Started Rule-based Manager for Device Events and Files.1426alice # [ 1.789061] systemd[1]: Finished Apply Kernel Variables.1427clare # [ 1.795664] systemd[1]: Starting Virtual Console Setup...1428alice # [ 1.805194] systemd-udevd[78]: Using default interface naming scheme 'v261'.1429alice # [ 1.828699] systemd[1]: Started Rule-based Manager for Device Events and Files.1430bob # [ 1.823414] systemd[1]: Starting Virtual Console Setup...1431clare # [ 1.836341] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1432clare # [ 1.838125] systemd[1]: Finished Virtual Console Setup.1433alice # [ 1.875496] systemd[1]: Starting Virtual Console Setup...1434bob # [ 1.877532] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1435bob # [ 1.878597] systemd[1]: Finished Virtual Console Setup.1436alice # [ 1.904415] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.1437alice # [ 1.909470] systemd[1]: Finished Virtual Console Setup.1438clare # [ 2.057428] systemd[1]: Finished Coldplug All udev Devices.1439clare # [ 2.058024] systemd[1]: Reached target System Initialization.1440clare # [ 2.058550] systemd[1]: Reached target Basic System.1441bob # [ 2.081737] systemd[1]: Finished Coldplug All udev Devices.1442bob # [ 2.082338] systemd[1]: Reached target System Initialization.1443bob # [ 2.082841] systemd[1]: Reached target Basic System.1444alice # [ 2.105696] systemd[1]: Finished Coldplug All udev Devices.1445alice # [ 2.106319] systemd[1]: Reached target System Initialization.1446alice # [ 2.106839] systemd[1]: Reached target Basic System.1447clare # [ 2.158542] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1448clare # [ 2.165471] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1449bob # [ 2.175117] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.1450bob # [ 2.197996] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.1451alice # [ 2.215283] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1452alice # [ 2.221707] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1453clare # [ 2.224090] systemd[1]: Found device /dev/disk/by-label/nixos.1454clare # [ 2.236728] systemd[1]: Reached target Initrd Root Device.1455clare # [ 2.239467] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1456bob # [ 2.269916] systemd[1]: Found device /dev/disk/by-label/nixos.1457bob # [ 2.274875] systemd[1]: Reached target Initrd Root Device.1458bob # [ 2.278086] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1459clare # [ 2.280663] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks1460clare # [ 2.289050] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1461alice # [ 2.308788] systemd[1]: Found device /dev/disk/by-label/nixos.1462alice # [ 2.311926] systemd[1]: Reached target Initrd Root Device.1463alice # [ 2.316215] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1464bob # [ 2.316960] systemd-fsck[109]: nixos: clean, 12/65536 files, 13019/262144 blocks1465bob # [ 2.324157] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1466alice # [ 2.351926] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks1467alice # [ 2.359073] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1468clare # [ 2.507168] systemd[1]: Mounting /sysroot...1469clare # [ 2.534685] systemd[1]: Mounted /sysroot.1470clare # [ 2.539944] EXT4-fs (vda): mounted filesystem b0907bf0-909a-4a59-a898-264bb9a2d8a4 r/w with ordered data mode. Quota mode: none.1471clare # [ 2.537824] systemd[1]: Reached target Initrd Root File System.1472clare # [ 2.542958] systemd[1]: Mounting /sysroot/nix/.ro-store...1473clare # [ 2.550596] systemd[1]: Mounting /sysroot/nix/.rw-store...1474bob # [ 2.556115] systemd[1]: Mounting /sysroot...1475clare # [ 2.570061] systemd[1]: Mounting /sysroot/run...1476alice # [ 2.580111] systemd[1]: Mounting /sysroot...1477clare # [ 2.577638] systemd[1]: Mounting /sysroot/tmp/shared...1478bob # [ 2.587347] EXT4-fs (vda): mounted filesystem 645812f6-01fd-4217-af76-a5305169bf64 r/w with ordered data mode. Quota mode: none.1479bob # [ 2.586108] systemd[1]: Mounted /sysroot.1480bob # [ 2.587464] systemd[1]: Reached target Initrd Root File System.1481bob # [ 2.592408] systemd[1]: Starting Mountpoints Configured in the Real Root...1482clare # [ 2.599276] systemd[1]: Mounting /sysroot/tmp/xchg...1483alice # [ 2.616256] EXT4-fs (vda): mounted filesystem 24a2eb0e-d708-4a3b-8abc-89e28b0e455c r/w with ordered data mode. Quota mode: none.1484alice # [ 2.611788] systemd[1]: Mounted /sysroot.1485alice # [ 2.613209] systemd[1]: Reached target Initrd Root File System.1486clare # [ 2.614062] fuse: init (API version 7.45)1487alice # [ 2.616611] systemd[1]: Starting Mountpoints Configured in the Real Root...1488bob # [ 2.609784] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.1489bob # [ 2.613164] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...1490bob # [ 2.616399] systemd[1]: Reloading...1491clare # [ 2.629038] virtiofs virtio6: discovered new tag: nix-store1492clare # [ 2.629577] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1493alice # [ 2.633846] systemd-sysroot-fstab-check[116]: /sysroot should be mounted in the initrd, will request daemon-reload.1494clare # [ 2.627270] systemd[1]: Starting Mountpoints Configured in the Real Root...1495clare # [ 2.630040] systemd[1]: Mounted /sysroot/nix/.rw-store.1496alice # [ 2.639177] systemd[1]: Reload requested from client PID 116 ('systemd-sysroot') (unit initrd-parse-etc.service)...1497clare # [ 2.632228] systemd[1]: Mounted /sysroot/run.1498alice # [ 2.641657] systemd[1]: Reloading...1499clare # [ 2.648567] virtiofs virtio7: discovered new tag: shared1500clare # [ 2.649095] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1501clare # [ 2.659518] virtiofs virtio8: discovered new tag: xchg1502clare # [ 2.660022] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1503clare # [ 2.660101] systemd[1]: Starting rw-sysroot-nix-store.service...1504clare # [ 2.665948] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.1505clare # [ 2.679829] systemd[1]: Mounted /sysroot/nix/.ro-store.1506clare # [ 2.681593] systemd[1]: Mounted /sysroot/tmp/shared.1507clare # [ 2.682878] systemd[1]: Mounted /sysroot/tmp/xchg.1508clare # [ 2.692104] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...1509clare # [ 2.694028] systemd[1]: Reloading...1510bob # [ 2.780965] systemd[1]: Reloading finished in 165 ms.1511alice # [ 2.810145] systemd[1]: Reloading finished in 167 ms.1512bob # [ 2.807632] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...1513bob # [ 2.809838] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...1514bob # [ 2.813813] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1515bob # [ 2.814490] systemd[1]: Finished Mountpoints Configured in the Real Root.1516bob # [ 2.816129] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1517alice # [ 2.827663] systemd-sysroot-fstab-check[116]: Requesting initrd-fs.target/start/replace...1518alice # [ 2.829447] systemd-sysroot-fstab-check[116]: Requesting swap.target/start/replace...1519alice # [ 2.833549] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1520alice # [ 2.835404] systemd[1]: Finished Mountpoints Configured in the Real Root.1521alice # [ 2.837006] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1522clare # [ 2.857553] systemd[1]: Reloading finished in 166 ms.1523clare # [ 2.886819] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...1524clare # [ 2.888906] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1525clare # [ 2.891566] systemd[1]: Finished rw-sysroot-nix-store.service.1526clare # [ 2.894545] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...1527clare # [ 2.898330] systemd[1]: Starting rw-sysroot-nix-store.service...1528clare # [ 2.900213] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1529clare # [ 2.902878] systemd[1]: Finished Mountpoints Configured in the Real Root.1530clare # [ 2.903822] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1531clare # [ 2.922275] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1532clare # [ 2.922956] systemd[1]: Finished rw-sysroot-nix-store.service.1533bob # [ 2.955850] fuse: init (API version 7.45)1534bob # [ 3.002404] virtiofs virtio6: discovered new tag: nix-store1535bob # [ 3.002907] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1536bob # [ 3.007914] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1537bob # [ 3.013370] (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 directory1538bob # [ 3.023828] virtiofs virtio7: discovered new tag: shared1539bob # [ 3.024329] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1540bob # [ 3.032757] virtiofs virtio8: discovered new tag: xchg1541bob # [ 3.033248] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1542alice # [ 3.051075] fuse: init (API version 7.45)1543bob # [ 3.036318] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1544bob # [ 3.038587] systemd[1]: Stopped Virtual Console Setup.1545bob # [ 3.043261] systemd[1]: Stopping Virtual Console Setup...1546bob # [ 3.044617] systemd[1]: Starting Virtual Console Setup...1547bob # [ 3.062814] systemd-vconsole-setup[136]: Configuration of first virtual console was skipped, ignoring remaining ones.1548bob # [ 3.065092] systemd[1]: Finished Virtual Console Setup.1549alice # [ 3.082977] virtiofs virtio6: discovered new tag: nix-store1550alice # [ 3.083515] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1551alice # [ 3.087044] (udev-worker)[90]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1552alice # [ 3.091892] (udev-worker)[90]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1553alice # [ 3.104342] virtiofs virtio7: discovered new tag: shared1554alice # [ 3.104879] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1555alice # [ 3.118062] virtiofs virtio8: discovered new tag: xchg1556alice # [ 3.118584] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1557alice # [ 3.114341] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1558alice # [ 3.115082] systemd[1]: Stopped Virtual Console Setup.1559alice # [ 3.116053] systemd[1]: Stopping Virtual Console Setup...1560clare # [ 3.108390] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1561alice # [ 3.120393] systemd[1]: Starting Virtual Console Setup...1562clare # [ 3.112373] (udev-worker)[99]: 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 directory1563clare # [ 3.129958] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1564clare # [ 3.131655] systemd[1]: Stopped Virtual Console Setup.1565clare # [ 3.133330] systemd[1]: Stopping Virtual Console Setup...1566alice # [ 3.142568] systemd-vconsole-setup[135]: Configuration of first virtual console was skipped, ignoring remaining ones.1567clare # [ 3.136100] systemd[1]: Starting Virtual Console Setup...1568alice # [ 3.144715] systemd[1]: Finished Virtual Console Setup.1569clare # [ 3.154894] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.1570clare # [ 3.157109] systemd[1]: Finished Virtual Console Setup.1571clare # [ 3.509502] systemd[1]: Mounting /sysroot/nix/store...1572bob # [ 3.555779] systemd[1]: Mounting /sysroot/nix/.ro-store...1573clare # [ 3.559321] systemd[1]: Mounted /sysroot/nix/store.1574clare # [ 3.561590] systemd[1]: Reached target Initrd File Systems.1575bob # [ 3.564187] systemd[1]: Mounting /sysroot/nix/.rw-store...1576clare # [ 3.565377] systemd[1]: Starting Find NixOS closure...1577alice # [ 3.580656] systemd[1]: Mounting /sysroot/nix/.ro-store...1578bob # [ 3.572078] systemd[1]: Mounting /sysroot/run...1579clare # [ 3.576285] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1580alice # [ 3.588231] systemd[1]: Mounting /sysroot/nix/.rw-store...1581bob # [ 3.588480] systemd[1]: Mounting /sysroot/tmp/shared...1582alice # [ 3.599613] systemd[1]: Mounting /sysroot/run...1583bob # [ 3.596185] systemd[1]: Mounting /sysroot/tmp/xchg...1584bob # [ 3.598219] systemd[1]: Mounted /sysroot/nix/.rw-store.1585alice # [ 3.606823] systemd[1]: Mounting /sysroot/tmp/shared...1586bob # [ 3.607960] systemd[1]: Mounted /sysroot/nix/.ro-store.1587bob # [ 3.608980] systemd[1]: Mounted /sysroot/run.1588clare # [ 3.613890] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1589clare # [ 3.615306] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1590alice # [ 3.624772] systemd[1]: Mounting /sysroot/tmp/xchg...1591bob # [ 3.624127] systemd[1]: Starting rw-sysroot-nix-store.service...1592clare # [ 3.627815] systemd[1]: Finished Find NixOS closure.1593clare # [ 3.630388] systemd[1]: Reached target Initrd Default Target.1594bob # [ 3.635304] systemd[1]: Mounted /sysroot/tmp/shared.1595clare # [ 3.635874] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1596bob # [ 3.635870] systemd[1]: Mounted /sysroot/tmp/xchg.1597bob # [ 3.637641] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1598bob # [ 3.638648] systemd[1]: Finished rw-sysroot-nix-store.service.1599alice # [ 3.653237] systemd[1]: Mounted /sysroot/nix/.rw-store.1600alice # [ 3.664642] systemd[1]: Starting rw-sysroot-nix-store.service...1601clare # [ 3.660315] systemd[1]: Stopped target Initrd Default Target.1602clare # [ 3.661634] systemd[1]: Stopped target Basic System.1603clare # [ 3.664395] systemd[1]: Stopped target Initrd Root Device.1604alice # [ 3.673399] systemd[1]: Mounted /sysroot/nix/.ro-store.1605clare # [ 3.665517] systemd[1]: Stopped target Path Units.1606clare # [ 3.667963] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1607alice # [ 3.676769] systemd[1]: Mounted /sysroot/run.1608clare # [ 3.669053] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1609alice # [ 3.677535] systemd[1]: Mounted /sysroot/tmp/shared.1610clare # [ 3.672128] systemd[1]: Stopped target Slice Units.1611alice # [ 3.680477] systemd[1]: Mounted /sysroot/tmp/xchg.1612clare # [ 3.672887] systemd[1]: Stopped target Socket Units.1613clare # [ 3.674472] systemd[1]: Stopped target System Initialization.1614clare # [ 3.676204] systemd[1]: Stopped target Swaps.1615clare # [ 3.680144] systemd[1]: Stopped target Timer Units.1616clare # [ 3.680855] systemd[1]: dbus.socket: Deactivated successfully.1617clare # [ 3.681644] systemd[1]: Closed D-Bus System Message Bus Socket.1618clare # [ 3.682576] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1619alice # [ 3.690830] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1620clare # [ 3.683511] systemd[1]: Stopped Find NixOS closure.1621alice # [ 3.691961] systemd[1]: Finished rw-sysroot-nix-store.service.1622alice # [ 3.694225] systemd[1]: Mounting /sysroot/nix/store...1623clare # [ 3.689102] systemd[1]: Starting rw-sysroot-nix-store.service...1624clare # [ 3.690705] systemd[1]: systemd-sysctl.service: Deactivated successfully.1625clare # [ 3.694396] systemd[1]: Stopped Apply Kernel Variables.1626clare # [ 3.696118] systemd[1]: systemd-modules-load.service: Deactivated successfully.1627clare # [ 3.698582] systemd[1]: Stopped Load Kernel Modules.1628clare # [ 3.699211] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1629clare # [ 3.707009] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1630clare # [ 3.707875] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1631clare # [ 3.711229] systemd[1]: Stopped Create System Files and Directories.1632clare # [ 3.714523] systemd[1]: Stopped target Local File Systems.1633clare # [ 3.715199] systemd[1]: Stopped target Preparation for Local File Systems.1634alice # [ 3.723387] systemd[1]: Mounted /sysroot/nix/store.1635alice # [ 3.724529] systemd[1]: Reached target Initrd File Systems.1636clare # [ 3.716579] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1637alice # [ 3.726336] systemd[1]: Starting Find NixOS closure...1638clare # [ 3.720237] systemd[1]: Stopped Coldplug All udev Devices.1639clare # [ 3.720908] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1640clare # [ 3.721725] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1641clare # [ 3.723472] systemd[1]: Stopped Virtual Console Setup.1642alice # [ 3.731475] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1643clare # [ 3.724479] systemd[1]: initrd-cleanup.service: Deactivated successfully.1644clare # [ 3.726346] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1645clare # [ 3.727638] systemd[1]: systemd-udevd.service: Deactivated successfully.1646clare # [ 3.736150] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1647clare # [ 3.736972] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1648clare # [ 3.740286] systemd[1]: Closed udev Control Socket.1649clare # [ 3.740813] systemd[1]: Starting Cleanup udev Database...1650alice # [ 3.749098] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1651clare # [ 3.741456] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1652clare # [ 3.742204] systemd[1]: Stopped Create Static Device Nodes in /dev.1653clare # [ 3.744195] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1654clare # [ 3.744977] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1655clare # [ 3.748669] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1656clare # [ 3.749331] systemd[1]: Stopped Create List of Static Device Nodes.1657clare # [ 3.749900] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1658alice # [ 3.758117] systemd[1]: Finished Find NixOS closure.1659clare # [ 3.750697] systemd[1]: Finished rw-sysroot-nix-store.service.1660alice # [ 3.759520] systemd[1]: Reached target Initrd Default Target.1661alice # [ 3.760537] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1662clare # [ 3.756924] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1663clare # [ 3.758701] systemd[1]: Finished Cleanup udev Database.1664clare # [ 3.759202] systemd[1]: Reached target Switch Root.1665clare # [ 3.759989] systemd[1]: Starting NixOS Activation...1666alice # [ 3.782980] systemd[1]: initrd-cleanup.service: Deactivated successfully.1667alice # [ 3.783905] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1668alice # [ 3.786116] systemd[1]: Stopped target Initrd Default Target.1669alice # [ 3.788113] systemd[1]: Stopped target Basic System.1670alice # [ 3.788632] systemd[1]: Stopped target Initrd Root Device.1671alice # [ 3.789492] systemd[1]: Stopped target Path Units.1672alice # [ 3.792267] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1673alice # [ 3.796749] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1674alice # [ 3.797479] systemd[1]: Stopped target Slice Units.1675alice # [ 3.797937] systemd[1]: Stopped target Socket Units.1676alice # [ 3.798420] systemd[1]: Stopped target System Initialization.1677alice # [ 3.798943] systemd[1]: Stopped target Swaps.1678alice # [ 3.799354] systemd[1]: Stopped target Timer Units.1679alice # [ 3.799805] systemd[1]: dbus.socket: Deactivated successfully.1680alice # [ 3.803367] systemd[1]: Closed D-Bus System Message Bus Socket.1681alice # [ 3.803936] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1682alice # [ 3.804869] systemd[1]: Stopped Find NixOS closure.1683alice # [ 3.805345] systemd[1]: Starting rw-sysroot-nix-store.service...1684alice # [ 3.805896] systemd[1]: systemd-sysctl.service: Deactivated successfully.1685alice # [ 3.806517] systemd[1]: Stopped Apply Kernel Variables.1686alice # [ 3.807020] systemd[1]: systemd-modules-load.service: Deactivated successfully.1687alice # [ 3.807665] systemd[1]: Stopped Load Kernel Modules.1688alice # [ 3.812248] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1689alice # [ 3.815020] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1690alice # [ 3.820519] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1691alice # [ 3.821278] systemd[1]: Stopped Create System Files and Directories.1692alice # [ 3.821863] systemd[1]: Stopped target Local File Systems.1693alice # [ 3.822388] systemd[1]: Stopped target Preparation for Local File Systems.1694alice # [ 3.822995] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1695alice # [ 3.823633] systemd[1]: Stopped Coldplug All udev Devices.1696alice # [ 3.825505] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1697alice # [ 3.826618] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1698alice # [ 3.827307] systemd[1]: Stopped Virtual Console Setup.1699alice # [ 3.827788] systemd[1]: systemd-udevd.service: Deactivated successfully.1700alice # [ 3.828590] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1701alice # [ 3.829248] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1702alice # [ 3.829893] systemd[1]: Closed udev Control Socket.1703alice # [ 3.830374] systemd[1]: Starting Cleanup udev Database...1704alice # [ 3.830889] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1705alice # [ 3.831576] systemd[1]: Stopped Create Static Device Nodes in /dev.1706alice # [ 3.835100] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1707alice # [ 3.836491] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1708alice # [ 3.840203] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1709alice # [ 3.840978] systemd[1]: Stopped Create List of Static Device Nodes.1710alice # [ 3.841563] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1711alice # [ 3.842206] systemd[1]: Finished rw-sysroot-nix-store.service.1712clare # [ 3.837571] initrd-nixos-activation-start[179]: booting system configuration /nix/store/8xdhh15jdy0rs5a0nffgvrq0i3g11hdq-nixos-system-clare-test1713alice # [ 3.853852] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1714alice # [ 3.856830] systemd[1]: Finished Cleanup udev Database.1715alice # [ 3.857371] systemd[1]: Reached target Switch Root.1716alice # [ 3.857837] systemd[1]: Starting NixOS Activation...1717clare # [ 3.865235] initrd-nixos-activation-start[179]: running activation script...1718alice # [ 3.933614] initrd-nixos-activation-start[171]: booting system configuration /nix/store/mbbrg5s2mrrqc9df28k7m3g5hyfypvzz-nixos-system-alice-test1719alice # [ 3.961113] initrd-nixos-activation-start[171]: running activation script...1720clare # [ 4.105074] initrd-nixos-activation-start[202]: setting up /etc...1721alice # [ 4.172959] initrd-nixos-activation-start[194]: setting up /etc...1722clare # [ 4.196839] initrd-nixos-activation-start[202]: setting up age secrets...1723alice # [ 4.262303] initrd-nixos-activation-start[194]: setting up age secrets...1724clare # [ 4.257876] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1725clare # [ 4.259657] systemd[1]: Finished NixOS Activation.1726clare # [ 4.260479] systemd[1]: Starting Switch Root...1727clare # [ 4.281049] systemd[1]: Switching root.1728alice # [ 4.322935] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1729alice # [ 4.324800] systemd[1]: Finished NixOS Activation.1730alice # [ 4.325528] systemd[1]: Starting Switch Root...1731alice # [ 4.344205] systemd[1]: Switching root.1732clare # [ 4.455660] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1733alice # [ 4.525365] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1734bob # [ 4.555292] systemd[1]: Mounting /sysroot/nix/store...1735bob # [ 4.606923] systemd[1]: Mounted /sysroot/nix/store.1736bob # [ 4.609149] systemd[1]: Reached target Initrd File Systems.1737bob # [ 4.613013] systemd[1]: Starting Find NixOS closure...1738bob # [ 4.624319] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1739bob # [ 4.666466] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1740bob # [ 4.667973] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1741bob # [ 4.680493] systemd[1]: Finished Find NixOS closure.1742bob # [ 4.683210] systemd[1]: Reached target Initrd Default Target.1743bob # [ 4.688273] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1744bob # [ 4.712918] systemd[1]: Stopped target Initrd Default Target.1745bob # [ 4.714544] systemd[1]: Stopped target Basic System.1746bob # [ 4.715678] systemd[1]: Stopped target Initrd Root Device.1747bob # [ 4.720397] systemd[1]: Stopped target Path Units.1748bob # [ 4.721163] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1749bob # [ 4.722244] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1750bob # [ 4.723341] systemd[1]: Stopped target Slice Units.1751bob # [ 4.728184] systemd[1]: Stopped target Socket Units.1752bob # [ 4.728948] systemd[1]: Stopped target System Initialization.1753bob # [ 4.730108] systemd[1]: Stopped target Swaps.1754bob # [ 4.730708] systemd[1]: Stopped target Timer Units.1755bob # [ 4.731959] systemd[1]: dbus.socket: Deactivated successfully.1756bob # [ 4.734224] systemd[1]: Closed D-Bus System Message Bus Socket.1757bob # [ 4.735953] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1758bob # [ 4.740381] systemd[1]: Stopped Find NixOS closure.1759bob # [ 4.742084] systemd[1]: Starting rw-sysroot-nix-store.service...1760bob # [ 4.745519] systemd[1]: systemd-sysctl.service: Deactivated successfully.1761bob # [ 4.747305] systemd[1]: Stopped Apply Kernel Variables.1762bob # [ 4.750726] systemd[1]: systemd-modules-load.service: Deactivated successfully.1763bob # [ 4.758391] systemd[1]: Stopped Load Kernel Modules.1764bob # [ 4.758999] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1765bob # [ 4.762256] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1766bob # [ 4.764120] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1767bob # [ 4.765318] systemd[1]: Stopped Create System Files and Directories.1768bob # [ 4.767015] systemd[1]: Stopped target Local File Systems.1769bob # [ 4.767732] systemd[1]: Stopped target Preparation for Local File Systems.1770bob # [ 4.769624] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1771bob # [ 4.770840] systemd[1]: Stopped Coldplug All udev Devices.1772bob # [ 4.772423] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1773bob # [ 4.775472] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1774bob # [ 4.776247] systemd[1]: Stopped Virtual Console Setup.1775bob # [ 4.776747] systemd[1]: initrd-cleanup.service: Deactivated successfully.1776bob # [ 4.777437] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1777bob # [ 4.778056] systemd[1]: systemd-udevd.service: Deactivated successfully.1778bob # [ 4.778665] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1779bob # [ 4.779310] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1780bob # [ 4.779934] systemd[1]: Finished rw-sysroot-nix-store.service.1781bob # [ 4.780605] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1782bob # [ 4.781252] systemd[1]: Closed udev Control Socket.1783bob # [ 4.781717] systemd[1]: Starting Cleanup udev Database...1784bob # [ 4.782230] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1785bob # [ 4.782914] systemd[1]: Stopped Create Static Device Nodes in /dev.1786bob # [ 4.783483] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1787bob # [ 4.792174] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1788bob # [ 4.792870] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1789bob # [ 4.793701] systemd[1]: Stopped Create List of Static Device Nodes.1790bob # [ 4.803750] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1791bob # [ 4.808528] systemd[1]: Finished Cleanup udev Database.1792bob # [ 4.809053] systemd[1]: Reached target Switch Root.1793bob # [ 4.809512] systemd[1]: Starting NixOS Activation...1794bob # [ 4.887347] initrd-nixos-activation-start[172]: booting system configuration /nix/store/zw49rrmqsf4zgvxr3ds5l8yxjdiw3yc9-nixos-system-bob-test1795bob # [ 4.915429] initrd-nixos-activation-start[172]: running activation script...1796clare # [ 4.948960] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1797clare # [ 4.949054] systemd[1]: Detected virtualization qemu.1798clare # [ 4.949113] systemd[1]: Detected architecture arm64.1799clare # [ 4.949226] systemd[1]: Detected first boot.1800clare # [ 4.951278] systemd[1]: Initializing machine ID from random generator.1801alice # [ 5.022364] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1802alice # [ 5.022476] systemd[1]: Detected virtualization qemu.1803alice # [ 5.022535] systemd[1]: Detected architecture arm64.1804alice # [ 5.022650] systemd[1]: Detected first boot.1805alice # [ 5.024935] systemd[1]: Initializing machine ID from random generator.1806clare # [ 5.132682] systemd[1]: bpf-restrict-fs: LSM BPF program attached1807bob # [ 5.160591] initrd-nixos-activation-start[195]: setting up /etc...1808bob # [ 5.257681] initrd-nixos-activation-start[195]: setting up age secrets...1809clare # [ 5.268480] systemd[1]: Applying preset policy.1810alice # [ 5.318748] systemd[1]: bpf-restrict-fs: LSM BPF program attached1811bob # [ 5.333596] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1812bob # [ 5.335314] systemd[1]: Finished NixOS Activation.1813bob # [ 5.336171] systemd[1]: Starting Switch Root...1814bob # [ 5.352296] systemd[1]: Switching root.1815clare # [ 5.448311] systemd[1]: Populated /etc with preset unit settings.1816alice # [ 5.506624] systemd[1]: Applying preset policy.1817bob # [ 5.522352] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1818alice # [ 5.668766] systemd[1]: Populated /etc with preset unit settings.1819clare # [ 5.666733] systemd[1]: initrd-switch-root.service: Deactivated successfully.1820clare # [ 5.667022] systemd[1]: Stopped initrd-switch-root.service.1821clare # [ 5.670344] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1822clare # [ 5.672569] systemd[1]: Created slice Slice /system/getty.1823clare # [ 5.673011] systemd[1]: Created slice User and Session Slice.1824clare # [ 5.673536] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1825clare # [ 5.673944] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1826clare # [ 5.674247] systemd[1]: Expecting device /dev/hvc0...1827clare # [ 5.674512] systemd[1]: Expecting device /dev/ttyAMA0...1828clare # [ 5.674773] systemd[1]: Reached target Local Encrypted Volumes.1829clare # [ 5.675039] systemd[1]: Stopped target initrd-fs.target.1830clare # [ 5.675296] systemd[1]: Stopped target initrd-root-fs.target.1831clare # [ 5.680468] systemd[1]: Stopped target initrd-switch-root.target.1832clare # [ 5.680962] systemd[1]: Reached target Virtual Machines and Containers.1833clare # [ 5.681531] systemd[1]: Reached target Path Units.1834clare # [ 5.682079] systemd[1]: Reached target Remote File Systems.1835clare # [ 5.682626] systemd[1]: Reached target Slice Units.1836clare # [ 5.683163] systemd[1]: Reached target Swaps.1837clare # [ 5.688321] systemd[1]: Listening on Query the User Interactively for a Password.1838clare # [ 5.690400] systemd[1]: Listening on Process Core Dump Socket.1839clare # [ 5.693021] systemd[1]: Listening on Credential Encryption/Decryption.1840clare # [ 5.694736] systemd[1]: Listening on Factory Reset Management.1841clare # [ 5.695271] systemd[1]: Listening on Hostname Service Socket.1842clare # [ 5.699209] systemd[1]: Starting Journal Log Access Socket...1843clare # [ 5.700801] systemd[1]: Listening on Journal Audit Socket.1844clare # [ 5.702938] systemd[1]: Listening on Console Output Muting Service Socket.1845clare # [ 5.705156] systemd[1]: Listening on Network Management Metrics Varlink Socket.1846clare # [ 5.705837] systemd[1]: Listening on Network Management Varlink Socket.1847clare # [ 5.706511] systemd[1]: Listening on Network Management Netlink Socket.1848clare # [ 5.707223] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1849clare # [ 5.710122] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1850clare # [ 5.710812] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1851clare # [ 5.717296] systemd[1]: Listening on Disk Repartitioning Service Socket.1852clare # [ 5.717851] systemd[1]: Listening on Resolve Monitor Varlink Socket.1853clare # [ 5.718391] systemd[1]: Listening on Resolve Service Varlink Socket.1854clare # [ 5.718937] systemd[1]: Listening on udev Control Socket.1855clare # [ 5.721978] systemd[1]: Listening on udev Varlink Socket.1856clare # [ 5.724449] systemd[1]: Mounting Huge Pages File System...1857clare # [ 5.726257] systemd[1]: Mounting POSIX Message Queue File System...1858clare # [ 5.731555] systemd[1]: Mounting Kernel Debug File System...1859clare # [ 5.747449] systemd[1]: Mounting Kernel Trace File System...1860clare # [ 5.753760] systemd[1]: Starting Create List of Static Device Nodes...1861clare # [ 5.755975] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1862clare # [ 5.771027] systemd[1]: Mounting Kernel Configuration File System...1863clare # [ 5.772647] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1864clare # [ 5.774703] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1865clare # [ 5.777381] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1866clare # [ 5.798999] systemd[1]: Mounting FUSE Control File System...1867clare # [ 5.803077] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671868clare # [ 5.823748] systemd[1]: Starting Journal Service...1869clare # [ 5.840903] systemd[1]: Starting Load Kernel Modules...1870clare # [ 5.848018] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1871clare # [ 5.860666] systemd[1]: Starting Remount Root and Kernel File Systems...1872clare # [ 5.861059] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1873clare # [ 5.870688] systemd[1]: Starting Coldplug All udev Devices...1874alice # [ 5.884573] systemd[1]: initrd-switch-root.service: Deactivated successfully.1875alice # [ 5.884869] systemd[1]: Stopped initrd-switch-root.service.1876alice # [ 5.887465] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1877alice # [ 5.888489] systemd[1]: Created slice Slice /system/getty.1878alice # [ 5.891199] systemd[1]: Created slice User and Session Slice.1879alice # [ 5.891737] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1880alice # [ 5.892097] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1881alice # [ 5.892409] systemd[1]: Expecting device /dev/hvc0...1882alice # [ 5.892681] systemd[1]: Expecting device /dev/ttyAMA0...1883alice # [ 5.892953] systemd[1]: Reached target Local Encrypted Volumes.1884alice # [ 5.896452] systemd[1]: Stopped target initrd-fs.target.1885alice # [ 5.896894] systemd[1]: Stopped target initrd-root-fs.target.1886clare # [ 5.890990] systemd[1]: Listening on Journal Log Access Socket.1887alice # [ 5.898151] systemd[1]: Stopped target initrd-switch-root.target.1888alice # [ 5.898659] systemd[1]: Reached target Virtual Machines and Containers.1889alice # [ 5.898957] systemd[1]: Reached target Path Units.1890alice # [ 5.899264] systemd[1]: Reached target Remote File Systems.1891alice # [ 5.899531] systemd[1]: Reached target Slice Units.1892alice # [ 5.899795] systemd[1]: Reached target Swaps.1893clare # [ 5.894696] systemd-journald[287]: Collecting audit messages is enabled.1894alice # [ 5.904461] systemd[1]: Listening on Query the User Interactively for a Password.1895clare # [ 5.897569] systemd[1]: Mounted Huge Pages File System.1896alice # [ 5.907698] systemd[1]: Listening on Process Core Dump Socket.1897clare # [ 5.898062] systemd[1]: Mounted POSIX Message Queue File System.1898clare # [ 5.898440] systemd[1]: Mounted Kernel Debug File System.1899clare # [ 5.898801] systemd[1]: Mounted Kernel Trace File System.1900alice # [ 5.909766] systemd[1]: Listening on Credential Encryption/Decryption.1901alice # [ 5.911429] systemd[1]: Listening on Factory Reset Management.1902alice # [ 5.911958] systemd[1]: Listening on Hostname Service Socket.1903alice # [ 5.916077] systemd[1]: Starting Journal Log Access Socket...1904clare # [ 5.902915] systemd[1]: Queued start job for default target Multi-User System.1905clare # [ 5.907543] systemd[1]: Finished Create List of Static Device Nodes.1906alice # [ 5.917995] systemd[1]: Listening on Journal Audit Socket.1907clare # [ 5.908104] systemd[1]: Mounted Kernel Configuration File System.1908alice # [ 5.920135] systemd[1]: Listening on Console Output Muting Service Socket.1909alice # [ 5.920810] systemd[1]: Listening on Network Management Metrics Varlink Socket.1910clare # [ 5.908329] systemd[1]: systemd-journald.service: Deactivated successfully.1911alice # [ 5.923391] systemd[1]: Listening on Network Management Varlink Socket.1912alice # [ 5.924443] systemd[1]: Listening on Network Management Netlink Socket.1913alice # [ 5.927064] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1914alice # [ 5.927582] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1915alice # [ 5.928081] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1916clare # [ 5.920051] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1917clare # [ 5.920547] systemd[1]: Started Journal Service.1918alice # [ 5.933779] systemd[1]: Listening on Disk Repartitioning Service Socket.1919alice # [ 5.934229] systemd[1]: Listening on Resolve Monitor Varlink Socket.1920alice # [ 5.934550] systemd[1]: Listening on Resolve Service Varlink Socket.1921alice # [ 5.934860] systemd[1]: Listening on udev Control Socket.1922alice # [ 5.935194] systemd[1]: Listening on udev Varlink Socket.1923alice # [ 5.939462] systemd[1]: Mounting Huge Pages File System...1924alice # [ 5.942006] systemd[1]: Mounting POSIX Message Queue File System...1925alice # [ 5.949287] systemd[1]: Mounting Kernel Debug File System...1926alice # [ 5.962143] systemd[1]: Mounting Kernel Trace File System...1927alice # [ 5.964670] systemd[1]: Starting Create List of Static Device Nodes...1928clare # [ 5.952288] systemd-modules-load[289]: Module 'atkbd' is built in1929alice # [ 5.969097] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1930clare # [ 5.959951] systemd-modules-load[289]: Module 'loop' is built in1931alice # [ 5.980464] systemd[1]: Mounting Kernel Configuration File System...1932alice # [ 5.980912] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1933clare # [ 5.975953] EXT4-fs (vda): re-mounted b0907bf0-909a-4a59-a898-264bb9a2d8a4.1934clare # [ 5.972917] systemd[1]: Finished Load Kernel Modules.1935clare # [ 5.975896] systemd-oomd[290]: No swap; memory pressure usage will be degraded1936alice # [ 5.989620] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1937alice # [ 5.990244] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1938clare # [ 5.978847] systemd[1]: Starting Firewall...1939clare # [ 5.981536] systemd[1]: Starting Apply Kernel Variables...1940clare # [ 5.983413] systemd[1]: Finished Remount Root and Kernel File Systems.1941clare # [ 5.985782] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1942clare # [ 5.988290] systemd[1]: Listening on Disk Image Download Service Socket.1943alice # [ 6.011686] systemd[1]: Mounting FUSE Control File System...1944alice # [ 6.012090] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671945clare # [ 6.003681] systemd[1]: Starting Flush Journal to Persistent Storage...1946clare # [ 6.004429] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1947clare # [ 6.018443] systemd[1]: Starting Load/Save OS Random Seed...1948clare # [ 6.019031] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1949alice # [ 6.033633] systemd[1]: Starting Journal Service...1950alice # [ 6.053957] systemd[1]: Starting Load Kernel Modules...1951clare # [ 6.049128] systemd[1]: Mounted FUSE Control File System.1952alice # [ 6.067104] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1953alice # [ 6.076070] systemd[1]: Starting Remount Root and Kernel File Systems...1954alice # [ 6.076454] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1955bob # [ 6.067672] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1956bob # [ 6.067810] systemd[1]: Detected virtualization qemu.1957bob # [ 6.067866] systemd[1]: Detected architecture arm64.1958bob # [ 6.067977] systemd[1]: Detected first boot.1959bob # [ 6.080799] systemd[1]: Initializing machine ID from random generator.1960alice # [ 6.092842] systemd[1]: Starting Coldplug All udev Devices...1961alice # [ 6.094929] systemd[1]: Listening on Journal Log Access Socket.1962alice # [ 6.095313] systemd[1]: Mounted Huge Pages File System.1963alice # [ 6.095666] systemd[1]: Mounted POSIX Message Queue File System.1964alice # [ 6.096096] systemd[1]: Mounted Kernel Debug File System.1965alice # [ 6.096445] systemd[1]: Mounted Kernel Trace File System.1966alice # [ 6.103494] systemd[1]: Finished Create List of Static Device Nodes.1967alice # [ 6.104048] systemd[1]: Mounted Kernel Configuration File System.1968clare # [ 6.095946] systemd-journald[287]: Received client request to flush runtime journal.1969alice # [ 6.114240] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1970alice # [ 6.122242] systemd-journald[279]: Collecting audit messages is enabled.1971alice # [ 6.124910] systemd[1]: Queued start job for default target Multi-User System.1972alice # [ 6.135019] systemd[1]: Started Journal Service.1973alice # [ 6.128742] systemd[1]: systemd-journald.service: Deactivated successfully.1974alice # [ 6.149318] systemd-modules-load[280]: Module 'atkbd' is built in1975clare # [ 6.144749] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1976clare # [ 6.145630] systemd[1]: Starting Create Static Device Nodes in /dev...1977alice # [ 6.155649] systemd-modules-load[280]: Module 'loop' is built in1978alice # [ 6.158457] systemd[1]: Mounted FUSE Control File System.1979clare # [ 6.153032] systemd[1]: Finished Load/Save OS Random Seed.1980clare # [ 6.153606] systemd[1]: Reached target First Boot Complete.1981clare # [ 6.154119] systemd[1]: Finished Apply Kernel Variables.1982clare # [ 6.154612] systemd[1]: Starting Network Name Resolution...1983alice # [ 6.165321] systemd[1]: Finished Load Kernel Modules.1984clare # [ 6.161480] systemd[1]: Finished Flush Journal to Persistent Storage.1985alice # [ 6.173184] systemd[1]: Starting Firewall...1986alice # [ 6.174852] systemd[1]: Starting Apply Kernel Variables...1987alice # [ 6.185132] EXT4-fs (vda): re-mounted 24a2eb0e-d708-4a3b-8abc-89e28b0e455c.1988alice # [ 6.196859] systemd[1]: Finished Remount Root and Kernel File Systems.1989alice # [ 6.199002] systemd[1]: Listening on Disk Image Download Service Socket.1990alice # [ 6.206806] systemd[1]: Starting Flush Journal to Persistent Storage...1991alice # [ 6.207445] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1992alice # [ 6.220308] systemd[1]: Starting Load/Save OS Random Seed...1993alice # [ 6.220834] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1994alice # [ 6.221807] systemd-oomd[281]: No swap; memory pressure usage will be degraded1995alice # [ 6.247103] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1996alice # [ 6.298015] systemd-journald[279]: Received client request to flush runtime journal.1997clare # [ 6.304679] systemd-resolved[316]: Positive Trust Anchors:1998clare # [ 6.305709] systemd-resolved[316]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1999clare # [ 6.306649] systemd-resolved[316]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162000clare # [ 6.307513] systemd-resolved[316]: 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 test2001alice # [ 6.354650] systemd[1]: Finished Load/Save OS Random Seed.2002alice # [ 6.355333] systemd[1]: Reached target First Boot Complete.2003alice # [ 6.355883] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2004alice # [ 6.358814] systemd[1]: Starting Create Static Device Nodes in /dev...2005alice # [ 6.359466] systemd[1]: Finished Apply Kernel Variables.2006alice # [ 6.359970] systemd[1]: Starting Network Name Resolution...2007alice # [ 6.368460] systemd[1]: Finished Flush Journal to Persistent Storage.2008clare # [ 6.362481] systemd[1]: Finished Create Static Device Nodes in /dev.2009clare # [ 6.363138] systemd[1]: Reached target Preparation for Local File Systems.2010bob # [ 6.367516] systemd[1]: bpf-restrict-fs: LSM BPF program attached2011clare # [ 6.368775] systemd[1]: Starting Rule-based Manager for Device Events and Files...2012bob # [ 6.491158] systemd[1]: Applying preset policy.2013clare # [ 6.508319] systemd-resolved[316]: Using system hostname 'clare'.2014clare # [ 6.511133] systemd[1]: Started Network Name Resolution.2015alice # [ 6.525338] systemd-resolved[308]: Positive Trust Anchors:2016alice # [ 6.525940] systemd-resolved[308]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2017alice # [ 6.526865] systemd-resolved[308]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162018alice # [ 6.527753] systemd-resolved[308]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test2019clare # [ 6.526517] systemd[1]: Finished Coldplug All udev Devices.2020clare # [ 6.536795] systemd-udevd[325]: Using default interface naming scheme 'v261'.2021clare # [ 6.586051] systemd[1]: Started Rule-based Manager for Device Events and Files.2022alice # [ 6.610517] systemd[1]: Finished Create Static Device Nodes in /dev.2023alice # [ 6.611191] systemd[1]: Reached target Preparation for Local File Systems.2024alice # [ 6.613135] systemd[1]: Starting Rule-based Manager for Device Events and Files...2025bob # [ 6.633110] systemd[1]: Populated /etc with preset unit settings.2026clare # [ 6.672164] systemd[1]: Mounting /run/wrappers...2027alice # [ 6.705370] systemd[1]: Finished Coldplug All udev Devices.2028alice # [ 6.715899] systemd-resolved[308]: Using system hostname 'alice'.2029alice # [ 6.718552] systemd[1]: Started Network Name Resolution.2030clare # [ 6.715614] systemd[1]: Mounted /run/wrappers.2031clare # [ 6.716576] systemd[1]: Reached target Local File Systems.2032clare # [ 6.720516] systemd[1]: Listening on Boot Loader Control Service Socket.2033clare # [ 6.723165] systemd[1]: Starting register-nix-paths.service...2034clare # [ 6.729651] systemd[1]: Starting Create SUID/SGID Wrappers...2035clare # [ 6.731833] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2036alice # [ 6.741155] systemd-udevd[317]: Using default interface naming scheme 'v261'.2037clare # [ 6.742208] systemd[1]: Starting Save Transient machine-id to Disk...2038clare # [ 6.765454] systemd[1]: Starting Create System Files and Directories...2039clare # [ 6.766150] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2040alice # [ 6.792187] systemd[1]: Started Rule-based Manager for Device Events and Files.2041clare # [ 6.785127] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2042bob # [ 6.844898] systemd[1]: initrd-switch-root.service: Deactivated successfully.2043bob # [ 6.845186] systemd[1]: Stopped initrd-switch-root.service.2044bob # [ 6.847597] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.2045bob # [ 6.848722] systemd[1]: Created slice Slice /system/getty.2046bob # [ 6.849282] systemd[1]: Created slice User and Session Slice.2047clare # [ 6.849380] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2048bob # [ 6.852056] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.2049bob # [ 6.852621] systemd[1]: Started Forward Password Requests to Wall Directory Watch.2050bob # [ 6.853195] systemd[1]: Expecting device /dev/hvc0...2051bob # [ 6.853783] systemd[1]: Expecting device /dev/ttyAMA0...2052bob # [ 6.857171] systemd[1]: Reached target Local Encrypted Volumes.2053bob # [ 6.857651] systemd[1]: Stopped target initrd-fs.target.2054bob # [ 6.859823] systemd[1]: Stopped target initrd-root-fs.target.2055bob # [ 6.860281] systemd[1]: Stopped target initrd-switch-root.target.2056bob # [ 6.860898] systemd[1]: Reached target Virtual Machines and Containers.2057bob # [ 6.861534] systemd[1]: Reached target Path Units.2058clare # [ 6.860986] systemd[1]: Finished Save Transient machine-id to Disk.2059bob # [ 6.864632] systemd[1]: Reached target Remote File Systems.2060bob # [ 6.865074] systemd[1]: Reached target Slice Units.2061bob # [ 6.865630] systemd[1]: Reached target Swaps.2062bob # [ 6.869425] systemd[1]: Listening on Query the User Interactively for a Password.2063bob # [ 6.872730] systemd[1]: Listening on Process Core Dump Socket.2064alice # [ 6.879455] systemd[1]: Mounting /run/wrappers...2065bob # [ 6.874832] systemd[1]: Listening on Credential Encryption/Decryption.2066bob # [ 6.876510] systemd[1]: Listening on Factory Reset Management.2067bob # [ 6.877038] systemd[1]: Listening on Hostname Service Socket.2068bob # [ 6.881431] systemd[1]: Starting Journal Log Access Socket...2069bob # [ 6.883795] systemd[1]: Listening on Journal Audit Socket.2070bob # [ 6.885830] systemd[1]: Listening on Console Output Muting Service Socket.2071bob # [ 6.887527] systemd[1]: Listening on Network Management Metrics Varlink Socket.2072bob # [ 6.888217] systemd[1]: Listening on Network Management Varlink Socket.2073bob # [ 6.888860] systemd[1]: Listening on Network Management Netlink Socket.2074bob # [ 6.889573] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2075bob # [ 6.893147] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2076bob # [ 6.893839] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2077bob # [ 6.900254] systemd[1]: Listening on Disk Repartitioning Service Socket.2078bob # [ 6.900790] systemd[1]: Listening on Resolve Monitor Varlink Socket.2079bob # [ 6.901350] systemd[1]: Listening on Resolve Service Varlink Socket.2080bob # [ 6.903953] systemd[1]: Listening on udev Control Socket.2081bob # [ 6.904458] systemd[1]: Listening on udev Varlink Socket.2082bob # [ 6.907562] systemd[1]: Mounting Huge Pages File System...2083bob # [ 6.909254] systemd[1]: Mounting POSIX Message Queue File System...2084bob # [ 6.921263] systemd[1]: Mounting Kernel Debug File System...2085alice # [ 6.930052] systemd[1]: Mounted /run/wrappers.2086alice # [ 6.932525] systemd[1]: Reached target Local File Systems.2087clare # [ 6.924577] systemd[1]: Finished Create System Files and Directories.2088bob # [ 6.927927] systemd[1]: Mounting Kernel Trace File System...2089alice # [ 6.935901] systemd[1]: Listening on Boot Loader Control Service Socket.2090clare # [ 6.930582] systemd[1]: Starting Rebuild Journal Catalog...2091alice # [ 6.939711] systemd[1]: Starting register-nix-paths.service...2092clare # [ 6.934791] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2093alice # [ 6.944470] systemd[1]: Starting Create SUID/SGID Wrappers...2094bob # [ 6.938716] systemd[1]: Starting Create List of Static Device Nodes...2095alice # [ 6.945081] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2096bob # [ 6.939273] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2097alice # [ 6.958979] systemd[1]: Starting Save Transient machine-id to Disk...2098bob # [ 6.954256] systemd[1]: Mounting Kernel Configuration File System...2099bob # [ 6.954729] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2100bob # [ 6.955994] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2101bob # [ 6.957052] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2102bob # [ 6.974932] systemd[1]: Mounting FUSE Control File System...2103bob # [ 6.978708] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672104alice # [ 6.992101] systemd[1]: Starting Create System Files and Directories...2105alice # [ 6.992808] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2106alice # [ 6.993686] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2107bob # [ 7.002713] systemd[1]: Starting Journal Service...2108bob # [ 7.016410] systemd[1]: Starting Load Kernel Modules...2109bob # [ 7.037017] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2110clare # [ 7.041955] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2111bob # [ 7.046384] systemd[1]: Starting Remount Root and Kernel File Systems...2112bob # [ 7.046767] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2113bob # [ 7.064179] systemd[1]: Starting Coldplug All udev Devices...2114alice # [ 7.077666] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2115bob # [ 7.074487] systemd[1]: Listening on Journal Log Access Socket.2116bob # [ 7.074986] systemd[1]: Mounted Huge Pages File System.2117bob # [ 7.075360] systemd[1]: Mounted POSIX Message Queue File System.2118bob # [ 7.075695] systemd[1]: Mounted Kernel Debug File System.2119bob # [ 7.076028] systemd[1]: Mounted Kernel Trace File System.2120alice # [ 7.087125] systemd[1]: Finished Save Transient machine-id to Disk.2121clare # [ 7.081118] systemd[1]: Finished Rebuild Journal Catalog.2122clare # [ 7.087204] systemd[1]: Starting Update is Completed...2123bob # [ 7.090094] systemd[1]: Finished Create List of Static Device Nodes.2124bob # [ 7.093520] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2125bob # [ 7.110404] systemd[1]: Finished Load Kernel Modules.2126bob # [ 7.123778] systemd[1]: Starting Firewall...2127clare # [ 7.121249] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2128bob # [ 7.127459] systemd[1]: Starting Apply Kernel Variables...2129alice # [ 7.140851] systemd[1]: Finished Create System Files and Directories.2130alice # [ 7.146869] systemd[1]: Starting Rebuild Journal Catalog...2131bob # [ 7.143349] systemd-journald[288]: Collecting audit messages is enabled.2132bob # [ 7.149025] EXT4-fs (vda): re-mounted 645812f6-01fd-4217-af76-a5305169bf64.2133alice # [ 7.156886] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2134bob # [ 7.156304] systemd[1]: Queued start job for default target Multi-User System.2135clare # [ 7.157932] systemd[1]: Finished Update is Completed.2136bob # [ 7.158764] systemd[1]: systemd-journald.service: Deactivated successfully.2137bob # [ 7.159560] systemd-modules-load[289]: Module 'atkbd' is built in2138bob # [ 7.169854] systemd[1]: Started Journal Service.2139bob # [ 7.165760] systemd-modules-load[289]: Module 'loop' is built in2140bob # [ 7.166673] systemd-oomd[290]: No swap; memory pressure usage will be degraded2141bob # [ 7.175784] systemd[1]: Finished Remount Root and Kernel File Systems.2142bob # [ 7.181812] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2143clare # [ 7.185663] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2144bob # [ 7.198711] systemd[1]: Listening on Disk Image Download Service Socket.2145bob # [ 7.207117] systemd[1]: Starting Flush Journal to Persistent Storage...2146bob # [ 7.207798] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2147bob # [ 7.216524] systemd[1]: Starting Load/Save OS Random Seed...2148bob # [ 7.217116] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2149bob # [ 7.217880] systemd[1]: Mounted Kernel Configuration File System.2150bob # [ 7.224118] systemd[1]: Mounted FUSE Control File System.2151alice # [ 7.265134] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2152alice # [ 7.274952] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2153bob # [ 7.277262] systemd-journald[288]: Received client request to flush runtime journal.2154alice # [ 7.292141] systemd[1]: Finished Rebuild Journal Catalog.2155alice # [ 7.298914] systemd[1]: Starting Update is Completed...2156bob # [ 7.320335] systemd[1]: Finished Load/Save OS Random Seed.2157bob # [ 7.320953] systemd[1]: Reached target First Boot Complete.2158bob # [ 7.330233] systemd[1]: Finished Apply Kernel Variables.2159bob # [ 7.330785] systemd[1]: Finished Flush Journal to Persistent Storage.2160bob # [ 7.332838] systemd[1]: Starting Network Name Resolution...2161alice # [ 7.349250] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2162alice # [ 7.357798] systemd[1]: Finished Update is Completed.2163bob # [ 7.359409] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2164bob # [ 7.361645] systemd[1]: Starting Create Static Device Nodes in /dev...2165clare # [ 7.403825] (udev-worker)[346]: Network interface NamePolicy= disabled on kernel command line.2166clare # [ 7.409099] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.2167bob # [ 7.480872] systemd-resolved[316]: Positive Trust Anchors:2168bob # [ 7.481470] systemd-resolved[316]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2169bob # [ 7.482373] systemd-resolved[316]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162170bob # [ 7.483259] systemd-resolved[316]: 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 test2171alice # [ 7.534607] (udev-worker)[342]: Network interface NamePolicy= disabled on kernel command line.2172alice # [ 7.562833] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.2173clare # [ 7.622219] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2174clare # [ 7.625147] systemd[1]: Finished Create SUID/SGID Wrappers.2175clare # [ 7.629902] systemd[1]: Finished register-nix-paths.service.2176clare # [ 7.630520] systemd[1]: Reached target System Initialization.2177clare # [ 7.631055] systemd[1]: Started Discard unused filesystem blocks once a week.2178clare # [ 7.631686] systemd[1]: Started Daily Cleanup of Temporary Directories.2179clare # [ 7.637716] systemd[1]: Reached target Timer Units.2180clare # [ 7.638224] systemd[1]: Listening on D-Bus System Message Bus Socket.2181clare # [ 7.645904] systemd[1]: Listening on harmonia binary cache socket.2182clare # [ 7.646541] systemd[1]: Listening on Nix Daemon Socket.2183clare # [ 7.647023] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2184clare # [ 7.647785] systemd[1]: Reached target Socket Units.2185clare # [ 7.655520] systemd[1]: Reached target Basic System.2186clare # [ 7.656641] systemd[1]: Started backdoor.service.2187clare # [ 7.657135] systemd[1]: Starting Import lastlog data into lastlog2 database...2188clare # [ 7.665284] mousedev: PS/2 mouse device common for all mice2189clare # [ 7.662067] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2190bob # [ 7.665929] systemd[1]: Finished Create Static Device Nodes in /dev.2191bob # [ 7.666619] systemd[1]: Reached target Preparation for Local File Systems.2192bob # [ 7.668513] systemd[1]: Starting Rule-based Manager for Device Events and Files...2193clare # [ 7.689929] systemd[1]: Starting Post-Boot Actions...2194bob # [ 7.690411] systemd-resolved[316]: Using system hostname 'bob'.2195bob # [ 7.694219] systemd[1]: Started Network Name Resolution.2196bob # [ 7.695706] systemd[1]: Finished Coldplug All udev Devices.2197clare # [ 7.698887] systemd[1]: Started Reset console on configuration changes.2198clare # [ 7.716341] systemd[1]: Starting D-Bus System Message Bus...2199bob # [ 7.733088] systemd-udevd[328]: Using default interface naming scheme 'v261'.2200bob # [ 7.788114] systemd[1]: Started Rule-based Manager for Device Events and Files.2201clare # connecting to host...2202clare # [ 7.806838] systemd[1]: Finished Post-Boot Actions.2203alice # [ 7.825839] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2204alice # [ 7.829174] systemd[1]: Finished Create SUID/SGID Wrappers.2205alice # [ 7.848393] mousedev: PS/2 mouse device common for all mice2206clare # [ 7.834246] systemd[1]: Started Name Service Cache Daemon (nsncd).2207clare # [ 7.836310] systemd[1]: Reached target Host and Network Name Lookups.2208clare # [ 7.836936] systemd[1]: Reached target User and Group Name Lookups.2209alice # [ 7.852170] systemd[1]: Finished register-nix-paths.service.2210clare # [ 7.843568] nsncd[474]: Sep 29 10:26:58.661 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2211alice # [ 7.852793] systemd[1]: Reached target System Initialization.2212alice # [ 7.853316] systemd[1]: Started Discard unused filesystem blocks once a week.2213alice # [ 7.853958] systemd[1]: Started Daily Cleanup of Temporary Directories.2214alice # [ 7.854572] systemd[1]: Reached target Timer Units.2215bob # [ 7.848745] systemd[1]: Mounting /run/wrappers...2216clare # [ 7.851840] systemd[1]: Starting User Login Management...2217alice # [ 7.863209] systemd[1]: Listening on D-Bus System Message Bus Socket.2218alice # [ 7.863853] systemd[1]: Listening on Nix Daemon Socket.2219clare # [ 7.856306] systemd[1]: Finished Import lastlog data into lastlog2 database.2220alice # [ 7.867854] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2221alice # [ 7.870085] systemd[1]: Reached target Socket Units.2222alice # [ 7.870601] systemd[1]: Reached target Basic System.2223alice # [ 7.871119] systemd[1]: Started backdoor.service.2224alice # [ 7.871562] systemd[1]: Starting Import lastlog data into lastlog2 database...2225alice # [ 7.880760] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2226alice # [ 7.881372] systemd[1]: Starting Post-Boot Actions...2227alice # [ 7.894726] systemd[1]: Started Reset console on configuration changes.2228bob # [ 7.911761] systemd[1]: Mounted /run/wrappers.2229bob # [ 7.912550] systemd[1]: Reached target Local File Systems.2230bob # [ 7.916456] systemd[1]: Listening on Boot Loader Control Service Socket.2231bob # [ 7.920213] systemd[1]: Starting register-nix-paths.service...2232bob # [ 7.925752] systemd[1]: Starting Create SUID/SGID Wrappers...2233alice # [ 7.936316] systemd[1]: Starting D-Bus System Message Bus...2234bob # [ 7.927128] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2235bob # [ 7.936788] systemd[1]: Starting Save Transient machine-id to Disk...2236clare # [ 7.946520] dbus-broker-launch[479]: Looking up NSS user entry for 'systemd-timesync'...2237bob # [ 7.946749] systemd[1]: Starting Create System Files and Directories...2238bob # [ 7.949123] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2239bob # [ 7.958230] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2240clare # [ 7.962323] dbus-broker-launch[479]: NSS returned no entry for 'systemd-timesync'2241clare # [ 7.963021] dbus-broker-launch[479]: Invalid user-name in /nix/store/g6lvrf1is179vyss5k22ni833b7b2yk8-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2242alice # [ 7.986018] systemd[1]: Finished Post-Boot Actions.2243clare # [ 7.982325] systemd-logind[504]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2244clare # [ 7.984927] systemd-logind[504]: Watching system buttons on /dev/input/event0 (gpio-keys)2245clare # [ 7.985613] systemd-logind[504]: New seat seat0.2246clare # [ 7.992421] systemd[1]: Started User Login Management.2247clare # [ 7.992952] systemd[1]: Starting linger-users.service...2248clare # [ 8.009723] systemd[1]: Started D-Bus System Message Bus.2249alice # [ 8.018981] systemd[1]: Started Name Service Cache Daemon (nsncd).2250alice # [ 8.019670] systemd[1]: Reached target Host and Network Name Lookups.2251alice # [ 8.024188] systemd[1]: Reached target User and Group Name Lookups.2252alice # [ 8.024986] nsncd[468]: Sep 29 10:26:58.829 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2253alice # [ 8.041878] systemd[1]: Starting User Login Management...2254clare # [ 8.046305] dbus-broker-launch[479]: Ready2255bob # [ 8.046692] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2256bob # [ 8.051370] systemd[1]: Finished Save Transient machine-id to Disk.2257alice # connecting to host...2258clare # [ 8.066624] systemd[1]: linger-users.service: Deactivated successfully.2259clare # [ 8.068142] systemd[1]: Finished linger-users.service.2260alice # [ 8.098022] systemd[1]: Finished Import lastlog data into lastlog2 database.2261bob # [ 8.108706] systemd[1]: Finished Create System Files and Directories.2262bob # [ 8.116926] systemd[1]: Starting Rebuild Journal Catalog...2263bob # [ 8.121177] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2264alice # [ 8.130778] dbus-broker-launch[474]: Looking up NSS user entry for 'systemd-timesync'...2265alice # [ 8.144198] dbus-broker-launch[474]: NSS returned no entry for 'systemd-timesync'2266alice # [ 8.144906] dbus-broker-launch[474]: Invalid user-name in /nix/store/imfr7zwkk8rdy7x52lcyk7i3h7y32p3s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2267alice # [ 8.187149] systemd-logind[489]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2268alice # [ 8.190704] systemd-logind[489]: Watching system buttons on /dev/input/event0 (gpio-keys)2269alice # [ 8.194952] systemd-logind[489]: New seat seat0.2270alice # [ 8.195552] systemd[1]: Started User Login Management.2271alice # [ 8.200675] systemd[1]: Starting linger-users.service...2272alice # [ 8.201208] systemd[1]: Started D-Bus System Message Bus.2273clare # [ 8.208643] systemd[1]: Finished Firewall.2274clare # [ 8.209131] systemd[1]: Reached target Preparation for Network.2275clare # [ 8.209648] systemd[1]: Listening on Network Management Resolve Hook Socket.2276clare # [ 8.214431] systemd[1]: Starting Network Management...2277bob # [ 8.223666] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2278alice # [ 8.238972] dbus-broker-launch[474]: Ready2279bob # [ 8.250368] systemd[1]: Finished Rebuild Journal Catalog.2280bob # [ 8.258955] systemd[1]: Starting Update is Completed...2281alice # [ 8.270851] systemd[1]: linger-users.service: Deactivated successfully.2282alice # [ 8.274290] systemd[1]: Finished linger-users.service.2283bob # [ 8.271917] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2284bob # [ 8.318640] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2285alice # [ 8.349786] systemd[1]: Finished Firewall.2286alice # [ 8.351655] systemd[1]: Reached target Preparation for Network.2287alice # [ 8.354720] systemd[1]: Listening on Network Management Resolve Hook Socket.2288alice # [ 8.358121] systemd[1]: Starting Network Management...2289bob # [ 8.358236] systemd[1]: Finished Update is Completed.2290clare # [ 8.396911] cfg80211: Loading compiled-in X.509 certificates for regulatory database2291clare # [ 8.435807] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2292clare # [ 8.436331] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2293clare # [ 8.437754] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22294clare # [ 8.438140] cfg80211: failed to load regulatory.db2295clare # [ 8.464432] systemd-networkd[546]: lo: Link UP2296clare # [ 8.464918] systemd-networkd[546]: lo: Gained carrier2297clare # [ 8.468617] systemd[1]: Started Network Management.2298clare # [ 8.469109] systemd[1]: Reached target Network.2299clare # [ 8.472682] systemd-networkd[546]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2300clare # [ 8.474000] systemd-networkd[546]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2301clare # [ 8.483804] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2302clare # [ 8.485915] systemd-networkd[546]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2303clare # [ 8.487204] systemd-networkd[546]: eth1: Link UP2304clare # [ 8.487643] systemd-networkd[546]: eth1: Gained carrier2305clare # [ 8.496490] systemd-networkd[546]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2306clare # [ 8.497845] systemd[1]: Starting Permit User Sessions...2307clare # [ 8.498352] systemd-networkd[546]: eth0: Link UP2308clare # [ 8.498785] systemd-networkd[546]: eth0: Gained carrier2309clare # [ 8.509641] systemd-networkd[546]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22310alice # [ 8.539899] cfg80211: Loading compiled-in X.509 certificates for regulatory database2311clare # [ 8.555505] systemd[1]: Finished Permit User Sessions.2312bob # [ 8.558591] (udev-worker)[351]: Network interface NamePolicy= disabled on kernel command line.2313clare # [ 8.563810] systemd[1]: Started Getty on tty1.2314alice # [ 8.579770] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2315alice # [ 8.580299] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2316bob # [ 8.563799] (udev-worker)[355]: Network interface NamePolicy= disabled on kernel command line.2317clare # [ 8.566225] systemd[1]: Reached target Login Prompts.2318alice # [ 8.583607] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22319alice # [ 8.584005] cfg80211: failed to load regulatory.db2320clare # [ 8.569256] systemd[1]: Reached target Multi-User System.2321clare # [ 8.572986] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2322clare # [ 8.575569] systemd[1]: Startup finished in 724ms (kernel) + 3.792s (initrd) + 4.057s (userspace) = 8.574s.2323alice # [ 8.608544] systemd-networkd[534]: lo: Link UP2324alice # [ 8.609038] systemd-networkd[534]: lo: Gained carrier2325alice # [ 8.615409] systemd[1]: Started Network Management.2326alice # [ 8.617448] systemd[1]: Reached target Network.2327alice # [ 8.620886] systemd-networkd[534]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2328alice # [ 8.622256] systemd-networkd[534]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2329alice # [ 8.630575] systemd-networkd[534]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2330alice # [ 8.631465] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2331alice # [ 8.637427] systemd-networkd[534]: eth1: Link UP2332alice # [ 8.637909] systemd-networkd[534]: eth1: Gained carrier2333alice # [ 8.638380] systemd-networkd[534]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2334alice # [ 8.639658] systemd[1]: Starting Permit User Sessions...2335alice # [ 8.650204] systemd-networkd[534]: eth0: Link UP2336alice # [ 8.650660] systemd-networkd[534]: eth0: Gained carrier2337alice # [ 8.651112] systemd-networkd[534]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22338alice # [ 8.708677] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2339alice # [ 8.715698] systemd[1]: Finished Permit User Sessions.2340alice # [ 8.720971] systemd[1]: Started Getty on tty1.2341alice # [ 8.722527] systemd[1]: Reached target Login Prompts.2342alice # [ 8.724483] systemd[1]: Reached target Multi-User System.2343alice # [ 8.729089] systemd[1]: Startup finished in 739ms (kernel) + 3.846s (initrd) + 4.138s (userspace) = 8.725s.2344clare # [ 8.748041] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32345bob # [ 8.801838] mousedev: PS/2 mouse device common for all mice2346bob # [ 8.829902] systemd[1]: Finished register-nix-paths.service.2347bob # [ 8.830538] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2348bob # [ 8.835520] systemd[1]: Finished Create SUID/SGID Wrappers.2349bob # [ 8.836980] systemd[1]: Reached target System Initialization.2350bob # [ 8.837579] systemd[1]: Started Discard unused filesystem blocks once a week.2351bob # [ 8.838244] systemd[1]: Started Daily Cleanup of Temporary Directories.2352bob # [ 8.838881] systemd[1]: Reached target Timer Units.2353bob # [ 8.839378] systemd[1]: Listening on D-Bus System Message Bus Socket.2354bob # [ 8.839957] systemd[1]: Listening on Nix Daemon Socket.2355bob # [ 8.850897] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2356bob # [ 8.851710] systemd[1]: Reached target Socket Units.2357bob # [ 8.857349] systemd[1]: Reached target Basic System.2358bob # [ 8.857873] systemd[1]: Started backdoor.service.2359bob # [ 8.858344] systemd[1]: Starting Import lastlog data into lastlog2 database...2360bob # [ 8.859002] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2361bob # [ 8.864676] systemd[1]: Starting Post-Boot Actions...2362bob # [ 8.877374] systemd[1]: Started Reset console on configuration changes.2363alice # [ 8.898831] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32364bob # [ 8.917102] systemd[1]: Starting D-Bus System Message Bus...2365bob # [ 9.006095] systemd[1]: Finished Post-Boot Actions.2366bob # connecting to host...2367bob # [ 9.026926] systemd[1]: Started Name Service Cache Daemon (nsncd).2368bob # [ 9.031507] systemd[1]: Reached target Host and Network Name Lookups.2369bob # [ 9.034272] systemd[1]: Reached target User and Group Name Lookups.2370bob # [ 9.035085] nsncd[477]: Sep 29 10:26:59.850 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2371clare # [ 9.040890] systemd[1]: Starting Virtual Console Setup...2372bob # [ 9.044399] systemd[1]: Starting User Login Management...2373bob # [ 9.051554] systemd[1]: Finished Import lastlog data into lastlog2 database.2374clare # [ 9.057755] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2375clare # [ 9.064355] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2376clare # [ 9.065365] systemd[1]: Stopped Virtual Console Setup.2377bob: Guest shell says: b'Spawning backdoor root shell...\n'2378clare # [ 9.073954] systemd-logind[504]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2379clare # [ 9.077184] systemd[1]: Starting Virtual Console Setup...2380bob # [ 9.101571] dbus-broker-launch[481]: Looking up NSS user entry for 'systemd-timesync'...2381bob # [ 9.116930] dbus-broker-launch[481]: NSS returned no entry for 'systemd-timesync'2382bob # [ 9.117605] dbus-broker-launch[481]: Invalid user-name in /nix/store/v6wpwi7ngzw4zlafqmhafh8jkj658jv3-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2383bob: connected to guest root shell2384bob: (connecting took 9.43 seconds)2385bob: (finished: waiting for the VM to finish booting, in 9.43 seconds)2386bob # [ 9.174196] systemd[1]: Started D-Bus System Message Bus.2387alice # [ 9.185372] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2388clare # [ 9.178964] systemd-vconsole-setup[566]: Configuration of first virtual console was skipped, ignoring remaining ones.2389bob # [ 9.180455] systemd-logind[500]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2390clare # [ 9.182171] systemd[1]: Finished Virtual Console Setup.2391alice # [ 9.190267] systemd[1]: Starting Virtual Console Setup...2392bob # [ 9.181372] systemd-logind[500]: Watching system buttons on /dev/input/event0 (gpio-keys)2393bob # [ 9.189384] systemd-logind[500]: New seat seat0.2394bob # [ 9.189903] systemd[1]: Started User Login Management.2395bob # [ 9.196385] systemd[1]: Starting linger-users.service...2396alice # [ 9.209249] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2397alice # [ 9.211757] systemd[1]: Stopped Virtual Console Setup.2398alice # [ 9.213129] systemd[1]: Starting Virtual Console Setup...2399alice # [ 9.219698] systemd-logind[489]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2400bob # [ 9.242894] dbus-broker-launch[481]: Ready2401bob # [ 9.283390] systemd[1]: linger-users.service: Deactivated successfully.2402bob # [ 9.286407] systemd[1]: Finished linger-users.service.2403alice # [ 9.320064] systemd-vconsole-setup[553]: Configuration of first virtual console was skipped, ignoring remaining ones.2404alice # [ 9.322875] systemd[1]: Finished Virtual Console Setup.2405bob # [ 9.398279] systemd[1]: Finished Firewall.2406bob # [ 9.399924] systemd[1]: Reached target Preparation for Network.2407bob # [ 9.403475] systemd[1]: Listening on Network Management Resolve Hook Socket.2408bob # [ 9.407111] systemd[1]: Starting Network Management...2409bob # [ 9.581455] cfg80211: Loading compiled-in X.509 certificates for regulatory database2410bob # [ 9.635645] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2411bob # [ 9.636135] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2412bob # [ 9.637521] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22413bob # [ 9.640182] cfg80211: failed to load regulatory.db2414bob # [ 9.664472] systemd-networkd[554]: lo: Link UP2415clare # [ 9.665567] systemd-networkd[546]: eth0: Gained IPv6LL2416bob # [ 9.668075] systemd-networkd[554]: lo: Gained carrier2417bob # [ 9.671793] systemd[1]: Started Network Management.2418bob # [ 9.678210] systemd[1]: Reached target Network.2419bob # [ 9.678721] systemd[1]: Reached target Network is Online.2420bob # [ 9.679224] systemd-networkd[554]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2421bob # [ 9.690604] systemd-networkd[554]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2422bob # [ 9.691425] systemd-networkd[554]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2423bob # [ 9.695994] systemd-networkd[554]: eth1: Link UP2424bob # [ 9.698144] systemd-networkd[554]: eth1: Gained carrier2425bob # [ 9.698640] systemd-networkd[554]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2426bob # [ 9.699978] systemd[1]: Starting ncps binary cache proxy service...2427bob # [ 9.710008] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2428bob # [ 9.710700] systemd-networkd[554]: eth0: Link UP2429bob # [ 9.711142] systemd-networkd[554]: eth0: Gained carrier2430bob # [ 9.711611] systemd[1]: Starting Permit User Sessions...2431bob # [ 9.717117] systemd-networkd[554]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22432bob # [ 9.800710] systemd[1]: Finished Permit User Sessions.2433bob # [ 9.806388] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2434bob # [ 9.812603] systemd[1]: Started Getty on tty1.2435bob # [ 9.813117] systemd[1]: Reached target Login Prompts.2436bob # [ 9.845471] ncps-pre-start[561]: /nix/store/0m8la0b5a7q97yz1mc9c2x9xb5mc67vz-ncps-0.9.4/bin/dbmate-ncps up2437alice # [ 9.889499] systemd-networkd[534]: eth0: Gained IPv6LL2438alice # [ 9.921535] systemd-networkd[534]: eth1: Gained IPv6LL2439bob # [ 10.040315] ncps-pre-start[575]: Creating: /var/lib/ncps/db/db.sqlite2440bob # [ 10.063292] ncps-pre-start[575]: Applying: 20241210054814_create-narinfos-table.sql2441bob # [ 10.071539] ncps-pre-start[575]: Applied: 20241210054814_create-narinfos-table.sql in 7.91296ms2442bob # [ 10.074206] ncps-pre-start[575]: Applying: 20241210054829_create-nars-table.sql2443bob # [ 10.079610] ncps-pre-start[575]: Applied: 20241210054829_create-nars-table.sql in 8.34436ms2444bob # [ 10.082558] ncps-pre-start[575]: Applying: 20241213014846_add-query-to-nars-table.sql2445bob # [ 10.087863] ncps-pre-start[575]: Applied: 20241213014846_add-query-to-nars-table.sql in 8.24204ms2446bob # [ 10.090191] ncps-pre-start[575]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2447bob # [ 10.099668] ncps-pre-start[575]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 11.78896ms2448bob # [ 10.102186] ncps-pre-start[575]: Applying: 20260101000000_add-config-table.sql2449bob # [ 10.107985] ncps-pre-start[575]: Applied: 20260101000000_add-config-table.sql in 8.29848ms2450bob # [ 10.108782] ncps-pre-start[575]: Applying: 20260105025735_remove-redundant-indexes.sql2451bob # [ 10.118792] ncps-pre-start[575]: Applied: 20260105025735_remove-redundant-indexes.sql in 10.78884ms2452bob # [ 10.120365] ncps-pre-start[575]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2453bob # [ 10.129222] ncps-pre-start[575]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 10.35788ms2454bob # [ 10.130094] ncps-pre-start[575]: Applying: 20260117195000_add_narinfo_de_normalized.sql2455bob # [ 10.143815] ncps-pre-start[575]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 14.55136ms[ 10.147420] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32456bob # 2457bob # [ 10.147993] ncps-pre-start[575]: Applying: 20260127223000_allow_multiple_nar_representations.sql2458bob # [ 10.152768] ncps-pre-start[575]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 9.01664ms2459bob # [ 10.154914] ncps-pre-start[575]: Applying: 20260131021850_add_chunks.sql2460bob # [ 10.161549] ncps-pre-start[575]: Applied: 20260131021850_add_chunks.sql in 8.76692ms2461bob # [ 10.163183] ncps-pre-start[575]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2462bob # [ 10.168880] ncps-pre-start[575]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 7.23864ms2463bob # [ 10.172196] ncps-pre-start[575]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2464bob # [ 10.180271] ncps-pre-start[575]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 11.43572ms2465bob # [ 10.181419] ncps-pre-start[575]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2466bob # [ 10.190539] ncps-pre-start[575]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 9.87944ms2467clare # [ 10.336985] systemd-networkd[546]: eth1: Gained IPv6LL2468bob # [ 10.354355] systemd[1]: Started ncps binary cache proxy service.2469bob # [ 10.354977] systemd[1]: Reached target Multi-User System.2470bob # [ 10.357586] systemd[1]: Startup finished in 730ms (kernel) + 4.862s (initrd) + 4.764s (userspace) = 10.357s.2471bob: (finished: waiting for unit ncps, in 10.73 seconds)2472bob: must succeed: systemctl status ncps2473bob: (finished: must succeed: systemctl status ncps, in 0.09 seconds)2474clare: waiting for unit harmonia.socket2475clare: waiting for the VM to finish booting2476clare: Guest shell says: b'Spawning backdoor root shell...\n'2477clare: connected to guest root shell2478clare: (connecting took 0.00 seconds)2479clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2480clare: (finished: waiting for unit harmonia.socket, in 0.06 seconds)2481alice: waiting for success: curl bob:8502/nix-cache-info2482alice: waiting for the VM to finish booting2483alice: Guest shell says: b'Spawning backdoor root shell...\n'2484alice: connected to guest root shell2485alice: (connecting took 0.00 seconds)2486alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2487bob # [ 10.632524] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2488bob # [ 10.650870] systemd[1]: Starting Virtual Console Setup...2489bob # [ 10.680275] systemd-logind[500]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2490bob # [ 10.766579] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","log_level":"info","time":"2026-09-29T10:27:01Z","message":"logger created"}2491bob # [ 10.767798] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","xz-binary-path":"/nix/store/hrvsv5knsgy3kjqykgh75d0yfxm92j8g-xz-5.8.3-bin/bin/xz","time":"2026-09-29T10:27:01Z","message":"Using xz binary for xz decompression"}2492bob # [ 10.784814] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","time":"2026-09-29T10:27:01Z","message":"using local locks (single-instance mode)"}2493bob # [ 10.793725] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-09-29T10:27:01Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2494bob # [ 10.799329] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-29T10:27:01Z","message":"setting up tracer provider to discard traces"}2495bob # [ 10.802063] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-29T10:27:01Z","message":"setting up meter provider to discard metrics"}2496bob # [ 10.805332] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-29T10:27:01Z","message":"setting up logger provider to discard logs"}2497bob # [ 10.811789] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-09-29T10:27:01Z","message":"Reporting anonymous metrics to the project maintainers"}2498bob # [ 10.816052] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-09-29T10:27:01Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2499bob # [ 10.817906] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-09-29T10:27:01Z","message":"using local storage"}2500clare # [ 10.851966] systemd[1]: Starting harmonia binary cache service...2501bob # [ 10.872643] systemd-vconsole-setup[599]: Configuration of first virtual console was skipped, ignoring remaining ones.2502bob # [ 10.875322] systemd[1]: Finished Virtual Console Setup.2503clare # [ 10.999215] harmonia-cache[573]: 2026-09-29T10:27:01.822619Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2504clare # [ 11.004530] harmonia-cache[573]: 2026-09-29T10:27:01.827237Z INFO actix_server::builder: starting 4 workers2505clare # [ 11.010761] harmonia-cache[573]: 2026-09-29T10:27:01.828110Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2506clare # [ 11.015447] harmonia-cache[573]: 2026-09-29T10:27:01.828215Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2507clare # [ 11.019563] harmonia-cache[573]: 2026-09-29T10:27:01.828248Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002508clare # [ 11.025409] systemd[1]: Started harmonia binary cache service.2509bob # [ 11.035378] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-09-29T10:27:01Z","message":"upstream became healthy and is now available for requests"}2510bob # [ 11.044159] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-09-29T10:27:01Z","message":"Server started"}2511bob # [ 11.048382] systemd-networkd[554]: eth0: Gained IPv6LL2512bob # [ 11.522506] systemd-networkd[554]: eth1: Gained IPv6LL2513alice # % Total % Received % Xferd Average Speed Time Time Time Current2514alice # Dload Upload Total Spent Left Speed2515bob # [ 11.708277] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:38100","trace_id":"ca8338cecef92a1e55c68ed6f3cce833","span_id":"a05d5e7cf37b61ca","status":200,"elapsed":0.13256,"bytes":50,"time":"2026-09-29T10:27:02Z","message":"handled request"}2516alice # 0 0 0 0 0 0 0 0 00:01 0100 50 100 50 0 0 47 0 00:01 00:01 0100 50 100 50 0 0 47 0 00:01 00:01 0100 50 100 50 0 0 47 0 00:01 00:01 02517alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 1.13 seconds)2518bob: waiting for success: curl clare:5000/nix-cache-info2519bob # % Total % Received % Xferd Average Speed Time Time Time Current2520bob # Dload Upload Total Spent Left Speed2521bob # 0 0 0 0 0 0 0 0 0[ 11.823965] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: 2026/09/29 10:27:02 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2522bob # 100 51 100 51 0 0 1871 0 0100 51 100 51 0 0 1766 0 0100 51 100 51 0 0 1664 0 02523bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.09 seconds)2524clare: waiting for unit harmonia2525clare: (finished: waiting for unit harmonia, in 0.06 seconds)2526clare: must succeed: systemctl status harmonia2527clare: (finished: must succeed: systemctl status harmonia, in 0.02 seconds)2528clare: must succeed: nix-build --expr '2529 builtins.derivation {2530 name = "hi";2531 builder = "/bin/sh";2532 args = [ "-c" "echo hi > $out" ];2533 system = "aarch64-linux";2534 }2535' 2>&125362537clare # [ 11.994007] systemd-resolved[316]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2538clare # [ 11.996771] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2539clare # [ 11.998620] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2540clare # [ 12.263044] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2541clare # [ 12.267481] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2542clare # [ 12.272684] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2543clare # [ 12.276348] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2544clare # [ 12.928358] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2545clare # [ 12.932138] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2546clare # [ 12.936597] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2547clare # [ 12.941004] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2548clare # [ 14.105341] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2549clare # [ 14.109814] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2550clare # [ 14.114377] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2551clare # [ 14.118905] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2552clare # [ 16.293639] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2553clare # [ 16.297242] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2554clare # [ 16.301696] systemd-resolved[316]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2555clare # [ 16.305738] systemd-resolved[316]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2556clare: (finished: must succeed: nix-build --expr '2557 builtins.derivation {2558 name = "hi";2559 builder = "/bin/sh";2560 args = [ "-c" "echo hi > $out" ];2561 system = "aarch64-linux";2562 }2563' 2>&12564, in 4.52 seconds)2565alice: must succeed: nix-build --expr '2566 builtins.derivation {2567 name = "hi";2568 builder = "/bin/sh";2569 args = [ "-c" "echo hi > $out" ];2570 system = "aarch64-linux";2571 }2572' 2>&125732574alice # [ 16.551008] systemd-resolved[308]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2575bob # [ 16.537851] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:53810","trace_id":"4d635d65025774c30581a5cafab671e3","span_id":"850e93165b87dd84","status":200,"elapsed":0.03,"bytes":50,"time":"2026-09-29T10:27:07Z","message":"handled request"}2576alice # [ 16.872888] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2577alice # [ 16.876613] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2578alice # [ 16.881153] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2579alice # [ 16.886183] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2580alice # [ 17.399852] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2581alice # [ 17.403827] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2582alice # [ 17.408733] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2583alice # [ 17.412207] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2584alice # [ 18.830082] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2585alice # [ 18.834637] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2586alice # [ 18.839073] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2587alice # [ 18.844296] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2588alice # [ 21.185372] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2589alice # [ 21.189327] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2590alice # [ 21.193891] systemd-resolved[308]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2591alice # [ 21.197832] systemd-resolved[308]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2592bob # [ 21.197673] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_url":"http://clare.clan:5000/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","upstream_url":"http://clare.clan:5000","time":"2026-09-29T10:27:12Z","message":"download the narinfo from upstream"}2593bob # [ 21.223832] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-29T10:27:12Z","message":"downloading the nar from upstream"}2594bob # [ 21.235699] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"http://clare.clan:5000/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","upstream_url":"http://clare.clan:5000","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-29T10:27:12Z","message":"download the nar from upstream"}2595bob # [ 21.272227] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-29T10:27:12Z","message":"storing narinfo and nar_file record in the database"}2596bob # [ 21.291164] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":62.52616,"time":"2026-09-29T10:27:12Z","message":"download of nar complete"}2597bob # [ 21.301071] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":92.99892,"time":"2026-09-29T10:27:12Z","message":"download of narinfo complete"}2598bob # [ 21.309135] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:53810","trace_id":"0d56936267e315733c6621a36c037479","span_id":"1a6345689993d33f","status":200,"elapsed":95.76128,"bytes":532,"time":"2026-09-29T10:27:12Z","message":"handled request"}2599bob # [ 21.314332] 3s19njv5lirrqabc42ybnlkqr47z9dsh-ncps-wrapper[582]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:53810","trace_id":"5ead19fb0db8c8bd86256e00f551d73b","span_id":"827fd0236cf30b27","status":200,"elapsed":0.66552,"bytes":95,"time":"2026-09-29T10:27:12Z","message":"handled request"}2600alice: (finished: must succeed: nix-build --expr '2601 builtins.derivation {2602 name = "hi";2603 builder = "/bin/sh";2604 args = [ "-c" "echo hi > $out" ];2605 system = "aarch64-linux";2606 }2607' 2>&12608, in 4.90 seconds)2609(finished: run the VM test script, in 22.13 seconds)2610test script finished in 22.27s2611cleanup2612kill QemuMachine (pid 48)2613alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2614alice # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2615alice # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2616alice # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2617kill QemuMachine (pid 49)2618bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2619bob # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2620bob # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2621bob # [2026-09-29T10:27:12Z INFO virtiofsd] Client disconnected, shutting down2622kill QemuMachine (pid 50)2623clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2624clare # [2026-09-29T10:27:13Z INFO virtiofsd] Client disconnected, shutting down2625clare # [2026-09-29T10:27:13Z INFO virtiofsd] Client disconnected, shutting down2626clare # [2026-09-29T10:27:13Z INFO virtiofsd] Client disconnected, shutting down2627(finished: cleanup, in 0.39 seconds)