vm-test-run-ncps
checks.aarch64-linux.ncps
· build #846
· raw
1build01: building 2vszkvj6phf9al38mr6nfrhdk8av704y-vm-test-run-ncps.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7additionally exposed symbols:8 alice, bob, clare,9 vlan1,10 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh11start all VMs12alice: starting vm13bob: starting vm14clare: starting vm15clare # Disk image does not exist, creating the virtualisation disk image...16bob # Disk image does not exist, creating the virtualisation disk image...17clare # Formatting '/build/vm-state-clare/tmp.9VgjT71VpY', fmt=raw size=107374182418bob: QEMU running (pid 50)19clare: QEMU running (pid 49)20bob # Formatting '/build/vm-state-bob/tmp.HnmOHYYl3G', fmt=raw size=107374182421alice: QEMU running (pid 48)22alice # Disk image does not exist, creating the virtualisation disk image...23clare # mke2fs 1.47.4 (6-Mar-2025)24alice # Formatting '/build/vm-state-alice/tmp.MOdz3RIdVJ', fmt=raw size=107374182425bob # mke2fs 1.47.4 (6-Mar-2025)26clare # Discarding device blocks: 0/262144 done27bob # Discarding device blocks: 0/262144 done28(finished: start all VMs, in 0.47 seconds)29alice # mke2fs 1.47.4 (6-Mar-2025)30bob # Creating filesystem with 262144 4k blocks and 65536 inodes31clare # Creating filesystem with 262144 4k blocks and 65536 inodes32bob: waiting for unit ncps33bob # Filesystem UUID: 9a85103c-e61a-45f1-815c-081cff456cc034alice # Discarding device blocks: 0/262144 done35alice # Creating filesystem with 262144 4k blocks and 65536 inodes36bob # Superblock backups stored on blocks:37bob: waiting for the VM to finish booting38bob # 32768, 98304, 163840, 22937639clare # Filesystem UUID: 3317e99a-9d03-426d-9dd0-980aa506fcea40bob # 41clare # Superblock backups stored on blocks:42bob # Allocating group tables: 0/8 done43clare # 32768, 98304, 163840, 22937644bob # Writing inode tables: 0/8 done45clare # 46bob # Creating journal (8192 blocks): done47clare # Allocating group tables: 0/8 done48bob # Writing superblocks and filesystem accounting information: 0/8 done49clare # Writing inode tables: 0/8 done50bob # 51clare # Creating journal (8192 blocks): done52bob # Virtualisation disk image created.53clare # Writing superblocks and filesystem accounting information: 0/8 done54bob # Starting virtiofs daemons...55clare # 56bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)57clare # Virtualisation disk image created.58bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether59clare # Starting virtiofs daemons...60bob # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...61clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)62bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)63clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether64bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether65clare # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...66bob # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...67clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)68bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)69clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether70bob # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether71clare # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...72bob # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...73clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)74bob # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests75clare # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether76bob # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests77clare # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...78bob # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests79clare # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests80alice # Filesystem UUID: 5ea69935-7a05-4fd9-9dea-02574aa7561181clare # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests82alice # Superblock backups stored on blocks:83clare # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests84alice # 32768, 98304, 163840, 22937685alice # 86alice # Allocating group tables: 0/8 done87alice # Writing inode tables: 0/8 done88alice # Creating journal (8192 blocks): done89alice # Writing superblocks and filesystem accounting information: 0/8 done90alice # 91alice # Virtualisation disk image created.92alice # Starting virtiofs daemons...93alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)94alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether95alice # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...96alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)97alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether98alice # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...99alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)100alice # [2026-10-04T15:27:10Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether101alice # [2026-10-04T15:27:10Z INFO virtiofsd] Waiting for vhost-user socket connection...102alice # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests103alice # [2026-10-04T15:27:10Z INFO virtiofsd] Client connected, servicing requests104alice # [2026-10-04T15:27:10Z 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) 16.2.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.1129alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)130alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296131alice # [ 0.000000] Detected PIPT I-cache on CPU0132alice # [ 0.000000] CPU features: detected: GICv3 CPU interface133alice # [ 0.000000] CPU features: detected: Spectre-v4134alice # [ 0.000000] CPU features: detected: Spectre-BHB135clare # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]136alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR137alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)138bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]139alice # [ 0.000000] CPU features: detected: ARM erratum 1418040140clare # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026141clare # [ 0.000000] KASLR enabled142alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion143clare # [ 0.000000] random: crng init done144clare # [ 0.000000] Machine model: linux,dummy-virt145bob # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026146alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing147clare # [ 0.000000] efi: UEFI not found.148bob # [ 0.000000] KASLR enabled149alice # [ 0.000000] alternatives: applying boot alternatives150bob # [ 0.000000] random: crng init done151clare # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT152bob # [ 0.000000] Machine model: linux,dummy-virt153bob # [ 0.000000] efi: UEFI not found.154clare # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]155bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT156clare # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]157clare # [ 0.000000] Zone ranges:158bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]159clare # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]160bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08700-0x7fc0be7f]161clare # [ 0.000000] DMA32 empty162bob # [ 0.000000] Zone ranges:163clare # [ 0.000000] Normal empty164alice # [ 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/224zj3jyaabv4hz182jfl10dhc1dfxmj-nixos-system-alice-test/init regInfo=/nix/.ro-store/s3ijbsqxx0p1n6g4bzim347sgbdkp05b-closure-info/registration console=ttyAMA0,115200n8 console=tty0165clare # [ 0.000000] Device empty166bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]167clare # [ 0.000000] Movable zone start for each node168bob # [ 0.000000] DMA32 empty169clare # [ 0.000000] Early memory node ranges170bob # [ 0.000000] Normal empty171bob # [ 0.000000] Device empty172alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/s3ijbsqxx0p1n6g4bzim347sgbdkp05b-closure-info/registration", will be passed to user space.173clare # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]174bob # [ 0.000000] Movable zone start for each node175bob # [ 0.000000] Early memory node ranges176alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes177clare # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]178bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]179clare # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000180alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)181clare # [ 0.000000] psci: probing for conduit method from DT.182bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]183alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)184clare # [ 0.000000] psci: PSCIv1.3 detected in firmware.185bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000186clare # [ 0.000000] psci: Using standard PSCI v0.2 function IDs187alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB188bob # [ 0.000000] psci: probing for conduit method from DT.189clare # [ 0.000000] psci: Trusted OS migration not required190alice # [ 0.000000] software IO TLB: area num 1.191bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.192clare # [ 0.000000] psci: SMC Calling Convention v1.1193bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs194alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)195bob # [ 0.000000] psci: Trusted OS migration not required196alice # [ 0.000000] Fallback order for Node 0: 0197clare # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)198bob # [ 0.000000] psci: SMC Calling Convention v1.1199alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144200clare # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296201alice # [ 0.000000] Policy zone: DMA202clare # [ 0.000000] Detected PIPT I-cache on CPU0203bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)204alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off205clare # [ 0.000000] CPU features: detected: GICv3 CPU interface206bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296207clare # [ 0.000000] CPU features: detected: Spectre-v4208alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1209bob # [ 0.000000] Detected PIPT I-cache on CPU0210clare # [ 0.000000] CPU features: detected: Spectre-BHB211bob # [ 0.000000] CPU features: detected: GICv3 CPU interface212alice # [ 0.000000] allocated 2097152 bytes of page_ext213alice # [ 0.000000] ftrace: allocating 75026 entries in 294 pages214clare # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR215bob # [ 0.000000] CPU features: detected: Spectre-v4216alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups217bob # [ 0.000000] CPU features: detected: Spectre-BHB218clare # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)219alice # [ 0.000000] rcu: Hierarchical RCU implementation.220bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR221clare # [ 0.000000] CPU features: detected: ARM erratum 1418040222alice # [ 0.000000] rcu: RCU event tracing is enabled.223bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)224clare # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion225alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.226bob # [ 0.000000] CPU features: detected: ARM erratum 1418040227clare # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing228alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.229bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion230clare # [ 0.000000] alternatives: applying boot alternatives231alice # [ 0.000000] Rude variant of Tasks RCU enabled.232alice # [ 0.000000] Tracing variant of Tasks RCU enabled.233bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing234bob # [ 0.000000] alternatives: applying boot alternatives235alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.236alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1237alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.238clare # [ 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/8bymk31vx2mmv1ipicyvn9gg03cx5h69-nixos-system-clare-test/init regInfo=/nix/.ro-store/3vif0aqkj0hw6ry1h33rmzkb019hwd1s-closure-info/registration console=ttyAMA0,115200n8 console=tty0239alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.240bob # [ 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/xnn913dv5vbwaw6kjszszkc89wy4ryrr-nixos-system-bob-test/init regInfo=/nix/.ro-store/z4fx6153slkdfivwdn36cymmy0y9hgvg-closure-info/registration console=ttyAMA0,115200n8 console=tty0241alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.242clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/3vif0aqkj0hw6ry1h33rmzkb019hwd1s-closure-info/registration", will be passed to user space.243alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0244clare # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes245alice # [ 0.000000] GICv3: 256 SPIs implemented246bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/z4fx6153slkdfivwdn36cymmy0y9hgvg-closure-info/registration", will be passed to user space.247alice # [ 0.000000] GICv3: 0 Extended SPIs implemented248clare # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)249alice # [ 0.000000] Root IRQ handler: gic_handle_irq250bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes251alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI252clare # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)253bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)254alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0255clare # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB256alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000257bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)258clare # [ 0.000000] software IO TLB: area num 1.259alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]260clare # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)261bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB262bob # [ 0.000000] software IO TLB: area num 1.263clare # [ 0.000000] Fallback order for Node 0: 0264alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)265bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)266clare # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144267clare # [ 0.000000] Policy zone: DMA268alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)269bob # [ 0.000000] Fallback order for Node 0: 0270clare # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off271alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000272bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144273bob # [ 0.000000] Policy zone: DMA274clare # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1275alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000276clare # [ 0.000000] allocated 2097152 bytes of page_ext277bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off278alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.279clare # [ 0.000000] ftrace: allocating 75026 entries in 294 pages280bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1281clare # [ 0.000000] ftrace: allocated 294 pages with 4 groups282bob # [ 0.000000] allocated 2097152 bytes of page_ext283alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns284clare # [ 0.000000] rcu: Hierarchical RCU implementation.285bob # [ 0.000000] ftrace: allocating 75026 entries in 294 pages286clare # [ 0.000000] rcu: RCU event tracing is enabled.287alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040288bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups289alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).290clare # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.291bob # [ 0.000000] rcu: Hierarchical RCU implementation.292bob # [ 0.000000] rcu: RCU event tracing is enabled.293clare # [ 0.000000] Trampoline variant of Tasks RCU enabled.294alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns295clare # [ 0.000000] Rude variant of Tasks RCU enabled.296bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.297clare # [ 0.000000] Tracing variant of Tasks RCU enabled.298alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns299bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.300bob # [ 0.000000] Rude variant of Tasks RCU enabled.301clare # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.302alice # [ 0.000049] arm-pv: using stolen time PV303bob # [ 0.000000] Tracing variant of Tasks RCU enabled.304clare # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1305alice # [ 0.000411] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)306bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.307alice # [ 0.000697] Console: colour dummy device 80x25308clare # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.309bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1310alice # [ 0.000709] printk: legacy console [tty0] enabled311clare # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.312bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.313alice # [ 0.000960] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)314alice # [ 0.000965] pid_max: default: 32768 minimum: 301315clare # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.316bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.317clare # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0318alice # [ 0.001038] LSM: initializing lsm=capability,landlock,yama,bpf,ima319alice # [ 0.001210] landlock: Up and running.320clare # [ 0.000000] GICv3: 256 SPIs implemented321bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.322alice # [ 0.001213] Yama: becoming mindful.323clare # [ 0.000000] GICv3: 0 Extended SPIs implemented324bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0325clare # [ 0.000000] Root IRQ handler: gic_handle_irq326alice # [ 0.001692] LSM support for eBPF active327bob # [ 0.000000] GICv3: 256 SPIs implemented328clare # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI329alice # [ 0.001884] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)330bob # [ 0.000000] GICv3: 0 Extended SPIs implemented331clare # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0332bob # [ 0.000000] Root IRQ handler: gic_handle_irq333alice # [ 0.001902] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)334clare # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000335bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI336alice # [ 0.004625] rcu: Hierarchical SRCU implementation.337clare # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]338bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0339alice # [ 0.004632] rcu: Max phase no-delay instances is 1000.340bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000341clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)342alice # [ 0.005605] fsl-mc MSI: its@8080000 domain created343bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]344alice # [ 0.005797] EFI services will not be available.345alice # [ 0.005893] smp: Bringing up secondary CPUs ...346clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)347bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)348alice # [ 0.005937] smp: Brought up 1 node, 1 CPU349clare # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000350alice # [ 0.005941] SMP: Total of 1 processors activated.351alice # [ 0.005943] CPU: All CPU(s) started at EL1352bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)353clare # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000354alice # [ 0.005957] CPU features: detected: 32-bit EL0 Support355bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000356clare # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.357alice # [ 0.005959] CPU features: detected: Data cache clean to the PoU not required for I/D coherence358bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000359clare # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns360alice # [ 0.005962] CPU features: detected: Common not Private translations361bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.362alice # [ 0.005964] CPU features: detected: CRC32 instructions363clare # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040364clare # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).365bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns366alice # [ 0.005966] CPU features: detected: Data cache clean to Point of Persistence367bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040368alice # [ 0.005969] CPU features: detected: Enhanced Virtualization Traps369clare # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns370alice # [ 0.005980] CPU features: detected: RCpc load-acquire (LDAPR)371bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).372clare # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns373alice # [ 0.005982] CPU features: detected: LSE atomic instructions374clare # [ 0.000042] arm-pv: using stolen time PV375alice # [ 0.005984] CPU features: detected: Privileged Access Never376bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns377alice # [ 0.005986] CPU features: detected: PMUv3378bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns379clare # [ 0.000327] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)380alice # [ 0.005987] CPU features: detected: RAS Extension Support381bob # [ 0.000048] arm-pv: using stolen time PV382clare # [ 0.000621] Console: colour dummy device 80x25383alice # [ 0.005991] CPU features: detected: Speculative Store Bypassing Safe (SSBS)384clare # [ 0.000632] printk: legacy console [tty0] enabled385bob # [ 0.000401] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)386alice # [ 0.006011] alternatives: applying system-wide alternatives387bob # [ 0.000733] Console: colour dummy device 80x25388clare # [ 0.000862] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)389alice # [ 0.007377] CPU features: detected: Hardware dirty bit management on CPU0390bob # [ 0.000743] printk: legacy console [tty0] enabled391clare # [ 0.000867] pid_max: default: 32768 minimum: 301392clare # [ 0.000947] LSM: initializing lsm=capability,landlock,yama,bpf,ima393bob # [ 0.000995] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)394clare # [ 0.001076] landlock: Up and running.395alice # [ 0.007582] Memory: 891208K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116068K reserved, 32768K cma-reserved)396bob # [ 0.001001] pid_max: default: 32768 minimum: 301397clare # [ 0.001078] Yama: becoming mindful.398alice # [ 0.008031] devtmpfs: initialized399clare # [ 0.001499] LSM support for eBPF active400bob # [ 0.001105] LSM: initializing lsm=capability,landlock,yama,bpf,ima401alice # [ 0.009478] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)402bob # [ 0.001233] landlock: Up and running.403clare # [ 0.001702] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)404bob # [ 0.001235] Yama: becoming mindful.405alice # [ 0.009517] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).406bob # [ 0.001614] LSM support for eBPF active407clare # [ 0.001721] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)408alice # [ 0.009647] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL409bob # [ 0.001782] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)410clare # [ 0.004401] rcu: Hierarchical SRCU implementation.411alice # [ 0.009650] 0 pages in range for non-PLT usage412clare # [ 0.004408] rcu: Max phase no-delay instances is 1000.413alice # [ 0.009651] 508208 pages in range for PLT usage414bob # [ 0.001801] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)415clare # [ 0.005418] fsl-mc MSI: its@8080000 domain created416alice # [ 0.009753] pinctrl core: initialized pinctrl subsystem417bob # [ 0.004583] rcu: Hierarchical SRCU implementation.418clare # [ 0.005609] EFI services will not be available.419alice # [ 0.010502] DMI not present or invalid.420clare # [ 0.005718] smp: Bringing up secondary CPUs ...421bob # [ 0.004590] rcu: Max phase no-delay instances is 1000.422alice # [ 0.013893] NET: Registered PF_NETLINK/PF_ROUTE protocol family423clare # [ 0.005757] smp: Brought up 1 node, 1 CPU424bob # [ 0.005524] fsl-mc MSI: its@8080000 domain created425clare # [ 0.005761] SMP: Total of 1 processors activated.426bob # [ 0.005703] EFI services will not be available.427alice # [ 0.016499] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations428clare # [ 0.005763] CPU: All CPU(s) started at EL1429bob # [ 0.005791] smp: Bringing up secondary CPUs ...430alice # [ 0.016629] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations431bob # [ 0.005830] smp: Brought up 1 node, 1 CPU432clare # [ 0.005774] CPU features: detected: 32-bit EL0 Support433bob # [ 0.005834] SMP: Total of 1 processors activated.434alice # [ 0.016774] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations435bob # [ 0.005836] CPU: All CPU(s) started at EL1436clare # [ 0.005777] CPU features: detected: Data cache clean to the PoU not required for I/D coherence437alice # [ 0.016791] audit: initializing netlink subsys (disabled)438bob # [ 0.005847] CPU features: detected: 32-bit EL0 Support439clare # [ 0.005780] CPU features: detected: Common not Private translations440alice # [ 0.017401] thermal_sys: Registered thermal governor 'fair_share'441clare # [ 0.005782] CPU features: detected: CRC32 instructions442bob # [ 0.005849] CPU features: detected: Data cache clean to the PoU not required for I/D coherence443alice # [ 0.017403] thermal_sys: Registered thermal governor 'bang_bang'444clare # [ 0.005784] CPU features: detected: Data cache clean to Point of Persistence445bob # [ 0.005852] CPU features: detected: Common not Private translations446clare # [ 0.005786] CPU features: detected: Enhanced Virtualization Traps447bob # [ 0.005854] CPU features: detected: CRC32 instructions448alice # [ 0.017406] thermal_sys: Registered thermal governor 'step_wise'449clare # [ 0.005796] CPU features: detected: RCpc load-acquire (LDAPR)450bob # [ 0.005856] CPU features: detected: Data cache clean to Point of Persistence451alice # [ 0.017408] thermal_sys: Registered thermal governor 'user_space'452clare # [ 0.005799] CPU features: detected: LSE atomic instructions453bob # [ 0.005859] CPU features: detected: Enhanced Virtualization Traps454alice # [ 0.017410] thermal_sys: Registered thermal governor 'power_allocator'455clare # [ 0.005801] CPU features: detected: Privileged Access Never456bob # [ 0.005869] CPU features: detected: RCpc load-acquire (LDAPR)457clare # [ 0.005803] CPU features: detected: PMUv3458alice # [ 0.017451] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1459bob # [ 0.005871] CPU features: detected: LSE atomic instructions460clare # [ 0.005805] CPU features: detected: RAS Extension Support461alice # [ 0.017460] cpuidle: using governor ladder462bob # [ 0.005873] CPU features: detected: Privileged Access Never463alice # [ 0.017465] cpuidle: using governor menu464clare # [ 0.005809] CPU features: detected: Speculative Store Bypassing Safe (SSBS)465bob # [ 0.005875] CPU features: detected: PMUv3466alice # [ 0.017601] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.467clare # [ 0.005829] alternatives: applying system-wide alternatives468bob # [ 0.005877] CPU features: detected: RAS Extension Support469alice # [ 0.017652] ASID allocator initialised with 32768 entries470clare # [ 0.007253] CPU features: detected: Hardware dirty bit management on CPU0471bob # [ 0.005880] CPU features: detected: Speculative Store Bypassing Safe (SSBS)472alice # [ 0.018291] Serial: AMBA PL011 UART driver473bob # [ 0.005904] alternatives: applying system-wide alternatives474alice # [ 0.021745] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1475bob # [ 0.007280] CPU features: detected: Hardware dirty bit management on CPU0476clare # [ 0.007440] Memory: 891232K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116076K reserved, 32768K cma-reserved)477alice # [ 0.021906] printk: console [ttyAMA0] enabled478clare # [ 0.007902] devtmpfs: initialized479clare # [ 0.009434] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)480bob # [ 0.007438] Memory: 891228K/1048576K available (24512K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 116052K reserved, 32768K cma-reserved)481bob # [ 0.007917] devtmpfs: initialized482clare # [ 0.009458] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).483bob # [ 0.009375] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)484clare # [ 0.009600] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL485clare # [ 0.009604] 0 pages in range for non-PLT usage486bob # [ 0.009398] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).487clare # [ 0.009605] 508208 pages in range for PLT usage488bob # [ 0.009526] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL489clare # [ 0.009713] pinctrl core: initialized pinctrl subsystem490bob # [ 0.009530] 0 pages in range for non-PLT usage491clare # [ 0.010473] DMI not present or invalid.492bob # [ 0.009530] 508208 pages in range for PLT usage493clare # [ 0.013664] NET: Registered PF_NETLINK/PF_ROUTE protocol family494bob # [ 0.009639] pinctrl core: initialized pinctrl subsystem495clare # [ 0.016230] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations496bob # [ 0.010419] DMI not present or invalid.497bob # [ 0.013716] NET: Registered PF_NETLINK/PF_ROUTE protocol family498clare # [ 0.016360] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations499bob # [ 0.016266] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations500clare # [ 0.016507] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations501bob # [ 0.016397] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations502clare # [ 0.016523] audit: initializing netlink subsys (disabled)503clare # [ 0.017066] thermal_sys: Registered thermal governor 'fair_share'504bob # [ 0.016544] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations505clare # [ 0.017068] thermal_sys: Registered thermal governor 'bang_bang'506bob # [ 0.016561] audit: initializing netlink subsys (disabled)507bob # [ 0.017101] thermal_sys: Registered thermal governor 'fair_share'508clare # [ 0.017071] thermal_sys: Registered thermal governor 'step_wise'509clare # [ 0.017074] thermal_sys: Registered thermal governor 'user_space'510bob # [ 0.017103] thermal_sys: Registered thermal governor 'bang_bang'511bob # [ 0.017107] thermal_sys: Registered thermal governor 'step_wise'512clare # [ 0.017076] thermal_sys: Registered thermal governor 'power_allocator'513bob # [ 0.017109] thermal_sys: Registered thermal governor 'user_space'514clare # [ 0.017126] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1515clare # [ 0.017135] cpuidle: using governor ladder516bob # [ 0.017111] thermal_sys: Registered thermal governor 'power_allocator'517clare # [ 0.017140] cpuidle: using governor menu518bob # [ 0.017148] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1519clare # [ 0.017264] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.520bob # [ 0.017157] cpuidle: using governor ladder521clare # [ 0.017284] ASID allocator initialised with 32768 entries522bob # [ 0.017162] cpuidle: using governor menu523clare # [ 0.017925] Serial: AMBA PL011 UART driver524bob # [ 0.017282] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.525bob # [ 0.017301] ASID allocator initialised with 32768 entries526clare # [ 0.021391] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1527bob # [ 0.017931] Serial: AMBA PL011 UART driver528clare # [ 0.021559] printk: console [ttyAMA0] enabled529bob # [ 0.021270] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1530alice # [ 0.094425] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages531bob # [ 0.021406] printk: console [ttyAMA0] enabled532alice # [ 0.094439] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page533alice # [ 0.094442] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages534alice # [ 0.094447] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page535alice # [ 0.094449] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages536alice # [ 0.094451] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page537alice # [ 0.094453] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages538alice # [ 0.094455] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page539alice # [ 0.095437] fbcon: Taking over console540alice # [ 0.095453] ACPI: Interpreter disabled.541alice # [ 0.096098] iommu: Default domain type: Translated542alice # [ 0.096102] iommu: DMA domain TLB invalidation policy: strict mode543alice # [ 0.096403] SCSI subsystem initialized544alice # [ 0.096586] usbcore: registered new interface driver usbfs545alice # [ 0.096615] usbcore: registered new interface driver hub546alice # [ 0.096635] usbcore: registered new device driver usb547alice # [ 0.096838] pps_core: LinuxPPS API ver. 1 registered548alice # [ 0.096841] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>549alice # [ 0.096846] PTP clock support registered550alice # [ 0.096878] EDAC MC: Ver: 3.0.0551clare # [ 0.093631] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages552clare # [ 0.093646] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page553alice # [ 0.106718] scmi_core: SCMI protocol bus registered554bob # [ 0.093550] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages555clare # [ 0.093649] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages556alice # [ 0.107097] FPGA manager framework557alice # [ 0.110658] vgaarb: loaded558bob # [ 0.093564] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page559clare # [ 0.093653] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page560bob # [ 0.093567] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages561clare # [ 0.093655] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages562bob # [ 0.093571] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page563clare # [ 0.093657] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page564bob # [ 0.093573] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages565clare # [ 0.093659] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages566bob # [ 0.093575] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page567clare # [ 0.093661] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page568clare # [ 0.094690] fbcon: Taking over console569bob # [ 0.093577] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages570clare # [ 0.094706] ACPI: Interpreter disabled.571bob # [ 0.093579] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page572clare # [ 0.095369] iommu: Default domain type: Translated573bob # [ 0.094588] fbcon: Taking over console574clare # [ 0.095373] iommu: DMA domain TLB invalidation policy: strict mode575bob # [ 0.094606] ACPI: Interpreter disabled.576alice # [ 0.111714] clocksource: Switched to clocksource arch_sys_counter577clare # [ 0.095675] SCSI subsystem initialized578bob # [ 0.095255] iommu: Default domain type: Translated579clare # [ 0.095880] usbcore: registered new interface driver usbfs580bob # [ 0.095259] iommu: DMA domain TLB invalidation policy: strict mode581clare # [ 0.095909] usbcore: registered new interface driver hub582bob # [ 0.095551] SCSI subsystem initialized583clare # [ 0.095924] usbcore: registered new device driver usb584bob # [ 0.095751] usbcore: registered new interface driver usbfs585clare # [ 0.096132] pps_core: LinuxPPS API ver. 1 registered586bob # [ 0.095786] usbcore: registered new interface driver hub587bob # [ 0.095801] usbcore: registered new device driver usb588clare # [ 0.096135] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>589bob # [ 0.095997] pps_core: LinuxPPS API ver. 1 registered590clare # [ 0.096140] PTP clock support registered591clare # [ 0.096171] EDAC MC: Ver: 3.0.0592bob # [ 0.096000] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>593bob # [ 0.096005] PTP clock support registered594clare # [ 0.105800] scmi_core: SCMI protocol bus registered595bob # [ 0.096036] EDAC MC: Ver: 3.0.0596bob # [ 0.105690] scmi_core: SCMI protocol bus registered597clare # [ 0.106522] FPGA manager framework598clare # [ 0.109725] vgaarb: loaded599bob # [ 0.106417] FPGA manager framework600bob # [ 0.109603] vgaarb: loaded601alice # [ 0.121177] VFS: Disk quotas dquot_6.6.0602alice # [ 0.121202] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)603alice # [ 0.122673] netfs: FS-Cache loaded604alice # [ 0.122764] pnp: PnP ACPI: disabled605clare # [ 0.110455] clocksource: Switched to clocksource arch_sys_counter606bob # [ 0.110299] clocksource: Switched to clocksource arch_sys_counter607alice # [ 0.126033] NET: Registered PF_INET protocol family608alice # [ 0.126207] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)609clare # [ 0.120347] VFS: Disk quotas dquot_6.6.0610clare # [ 0.120374] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)611clare # [ 0.121861] netfs: FS-Cache loaded612bob # [ 0.120260] VFS: Disk quotas dquot_6.6.0613clare # [ 0.121970] pnp: PnP ACPI: disabled614bob # [ 0.120285] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)615bob # [ 0.121742] netfs: FS-Cache loaded616bob # [ 0.121842] pnp: PnP ACPI: disabled617clare # [ 0.125202] NET: Registered PF_INET protocol family618clare # [ 0.125372] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)619bob # [ 0.125124] NET: Registered PF_INET protocol family620bob # [ 0.125305] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)621alice # [ 0.150394] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)622alice # [ 0.150419] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)623alice # [ 0.150432] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)624alice # [ 0.150469] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)625alice # [ 0.150535] TCP: Hash tables configured (established 8192 bind 8192)626alice # [ 0.150633] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)627alice # [ 0.150666] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)628alice # [ 0.150687] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)629alice # [ 0.150798] NET: Registered PF_UNIX/PF_LOCAL protocol family630alice # [ 0.150851] NET: Registered PF_XDP protocol family631alice # [ 0.150874] PCI: CLS 0 bytes, default 64632alice # [ 0.151090] Trying to unpack rootfs image as initramfs...633bob # [ 0.150240] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)634bob # [ 0.150265] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)635bob # [ 0.150277] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)636clare # [ 0.150694] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)637alice # [ 0.163739] kvm [1]: HYP mode not available638clare # [ 0.150718] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)639clare # [ 0.150732] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)640clare # [ 0.150770] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)641clare # [ 0.150837] TCP: Hash tables configured (established 8192 bind 8192)642clare # [ 0.150951] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)643clare # [ 0.151014] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)644clare # [ 0.151068] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)645clare # [ 0.151179] NET: Registered PF_UNIX/PF_LOCAL protocol family646clare # [ 0.151241] NET: Registered PF_XDP protocol family647clare # [ 0.151261] PCI: CLS 0 bytes, default 64648clare # [ 0.151486] Trying to unpack rootfs image as initramfs...649clare # [ 0.160621] kvm [1]: HYP mode not available650bob # [ 0.152322] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)651bob # [ 0.152392] TCP: Hash tables configured (established 8192 bind 8192)652bob # [ 0.152499] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)653bob # [ 0.152563] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)654bob # [ 0.152585] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)655bob # [ 0.152694] NET: Registered PF_UNIX/PF_LOCAL protocol family656bob # [ 0.152725] NET: Registered PF_XDP protocol family657bob # [ 0.152744] PCI: CLS 0 bytes, default 64658bob # [ 0.152971] Trying to unpack rootfs image as initramfs...659bob # [ 0.154599] kvm [1]: HYP mode not available660alice # [ 0.228162] Initialise system trusted keyrings661alice # [ 0.228275] workingset: timestamp_bits=42 max_order=18 bucket_order=0662alice # [ 0.228604] squashfs: version 4.0 (2009/01/31) Phillip Lougher663alice # [ 0.228637] 9p: Installing v9fs 9p2000 file system support664clare # [ 0.226107] Initialise system trusted keyrings665clare # [ 0.226248] workingset: timestamp_bits=42 max_order=18 bucket_order=0666bob # [ 0.230710] Initialise system trusted keyrings667bob # [ 0.230821] workingset: timestamp_bits=42 max_order=18 bucket_order=0668bob # [ 0.231152] squashfs: version 4.0 (2009/01/31) Phillip Lougher669bob # [ 0.231195] 9p: Installing v9fs 9p2000 file system support670clare # [ 0.235578] squashfs: version 4.0 (2009/01/31) Phillip Lougher671clare # [ 0.235633] 9p: Installing v9fs 9p2000 file system support672alice # [ 0.257241] Key type asymmetric registered673alice # [ 0.257256] Asymmetric key parser 'x509' registered674alice # [ 0.257317] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)675alice # [ 0.257409] io scheduler mq-deadline registered676alice # [ 0.257412] io scheduler kyber registered677alice # [ 0.261712] pl061_gpio 9030000.pl061: PL061 GPIO chip registered678alice # [ 0.262053] ledtrig-cpu: registered to indicate activity on CPUs679alice # [ 0.262350] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:680alice # [ 0.262366] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000681alice # [ 0.262378] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000682alice # [ 0.262382] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000683alice # [ 0.262413] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits684bob # [ 0.251741] Key type asymmetric registered685bob # [ 0.251755] Asymmetric key parser 'x509' registered686alice # [ 0.262433] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]687bob # [ 0.251804] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)688alice # [ 0.262504] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00689bob # [ 0.251895] io scheduler mq-deadline registered690alice # [ 0.262520] pci_bus 0000:00: root bus resource [bus 00-ff]691bob # [ 0.251898] io scheduler kyber registered692alice # [ 0.262523] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]693alice # [ 0.262526] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]694alice # [ 0.262528] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]695clare # [ 0.255362] Key type asymmetric registered696alice # [ 0.262601] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint697clare # [ 0.255377] Asymmetric key parser 'x509' registered698clare # [ 0.255434] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)699alice # [ 0.263038] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint700clare # [ 0.255524] io scheduler mq-deadline registered701alice # [ 0.263162] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]702clare # [ 0.255527] io scheduler kyber registered703alice # [ 0.263171] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]704clare # [ 0.257850] pl061_gpio 9030000.pl061: PL061 GPIO chip registered705alice # [ 0.263189] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]706clare # [ 0.258165] ledtrig-cpu: registered to indicate activity on CPUs707alice # [ 0.263198] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]708alice # [ 0.263512] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint709alice # [ 0.263635] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]710clare # [ 0.261337] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:711alice # [ 0.263644] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]712alice # [ 0.263662] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]713clare # [ 0.261357] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000714clare # [ 0.261370] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000715clare # [ 0.261374] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000716clare # [ 0.261402] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits717clare # [ 0.261423] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]718clare # [ 0.261512] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00719clare # [ 0.261529] pci_bus 0000:00: root bus resource [bus 00-ff]720bob # [ 0.262432] pl061_gpio 9030000.pl061: PL061 GPIO chip registered721clare # [ 0.261532] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]722bob # [ 0.262803] ledtrig-cpu: registered to indicate activity on CPUs723clare # [ 0.261535] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]724bob # [ 0.263092] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:725clare # [ 0.261537] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]726bob # [ 0.263108] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000727clare # [ 0.261602] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint728bob # [ 0.263121] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000729clare # [ 0.262047] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint730clare # [ 0.262173] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]731bob # [ 0.263126] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000732clare # [ 0.262182] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]733bob # [ 0.263156] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits734clare # [ 0.262201] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]735clare # [ 0.262210] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]736bob # [ 0.263177] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]737bob # [ 0.263243] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00738bob # [ 0.263259] pci_bus 0000:00: root bus resource [bus 00-ff]739bob # [ 0.263263] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]740bob # [ 0.263265] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]741bob # [ 0.263268] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]742bob # [ 0.263347] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint743bob # [ 0.263796] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint744alice # [ 0.284072] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint745bob # [ 0.263923] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]746alice # [ 0.284205] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]747bob # [ 0.263932] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]748alice # [ 0.284214] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]749bob # [ 0.263951] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]750alice # [ 0.284234] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]751bob # [ 0.263960] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]752alice # [ 0.284550] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint753alice # [ 0.284674] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]754bob # [ 0.264292] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint755bob # [ 0.264417] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]756alice # [ 0.284683] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]757bob # [ 0.264426] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]758alice # [ 0.284701] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]759alice # [ 0.284710] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]760bob # [ 0.264444] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]761alice # [ 0.285023] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint762bob # [ 0.264755] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint763bob # [ 0.264881] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]764alice # [ 0.285150] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]765bob # [ 0.264890] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]766alice # [ 0.285168] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]767bob # [ 0.264908] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]768alice # [ 0.285501] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint769bob # [ 0.265218] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint770alice # [ 0.285631] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]771bob # [ 0.265344] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]772alice # [ 0.285649] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]773clare # [ 0.278607] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint774bob # [ 0.265353] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]775clare # [ 0.278738] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]776alice # [ 0.285931] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint777bob # [ 0.265371] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]778clare # [ 0.278748] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]779alice # [ 0.286053] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]780bob # [ 0.265380] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]781clare # [ 0.278766] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]782alice # [ 0.286245] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint783bob # [ 0.265692] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint784clare # [ 0.279101] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint785alice # [ 0.286372] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]786clare # [ 0.279227] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]787bob # [ 0.265820] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]788alice # [ 0.286390] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]789clare # [ 0.279237] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]790bob # [ 0.265838] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]791alice # [ 0.286698] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint792clare # [ 0.279255] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]793bob # [ 0.266167] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint794alice # [ 0.286828] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]795bob # [ 0.266294] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]796clare # [ 0.279568] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint797alice # [ 0.286845] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]798clare # [ 0.279695] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]799alice # [ 0.287151] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint800clare # [ 0.279704] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]801bob # [ 0.285907] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]802alice # [ 0.287276] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]803clare # [ 0.279722] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]804bob # [ 0.286225] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint805alice # [ 0.287293] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]806clare # [ 0.279731] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]807alice # [ 0.287606] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint808clare # [ 0.280048] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint809clare # [ 0.280175] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]810clare # [ 0.280193] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]811clare # [ 0.280508] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint812clare # [ 0.280635] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]813alice # [ 0.301756] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]814clare # [ 0.280653] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]815alice # [ 0.301767] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]816alice # [ 0.301785] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]817clare # [ 0.280931] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint818clare # [ 0.281053] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]819alice # [ 0.302120] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint820alice # [ 0.302245] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]821clare # [ 0.281276] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint822alice # [ 0.302254] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]823clare # [ 0.281403] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]824alice # [ 0.302273] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]825clare # [ 0.281422] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]826alice # [ 0.302712] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned827clare # [ 0.281732] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint828alice # [ 0.302719] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned829clare # [ 0.281861] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]830clare # [ 0.281879] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]831alice # [ 0.302722] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned832clare # [ 0.282189] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint833alice # [ 0.302756] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned834clare # [ 0.282317] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]835alice # [ 0.302785] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned836clare # [ 0.282335] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]837alice # [ 0.302815] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned838alice # [ 0.302847] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned839clare # [ 0.298140] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint840alice # [ 0.302876] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned841clare # [ 0.298362] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]842bob # [ 0.294410] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]843clare # [ 0.298371] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]844alice # [ 0.302907] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned845clare # [ 0.298388] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]846bob # [ 0.294626] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint847alice # [ 0.302936] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned848bob # [ 0.294756] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]849alice # [ 0.302966] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned850bob # [ 0.294774] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]851alice # [ 0.302996] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned852bob # [ 0.295085] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint853bob # [ 0.295217] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]854alice # [ 0.303057] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned855bob # [ 0.295235] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]856alice # [ 0.303085] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned857clare # [ 0.300680] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint858alice # [ 0.303098] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned859clare # [ 0.300806] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]860bob # [ 0.295570] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint861clare # [ 0.300815] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]862alice # [ 0.303109] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned863bob # [ 0.295699] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]864clare # [ 0.300833] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]865alice # [ 0.303171] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned866bob # [ 0.295717] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]867alice # [ 0.303184] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned868clare # [ 0.301304] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned869bob # [ 0.296037] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint870alice # [ 0.303196] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned871clare # [ 0.301311] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned872bob # [ 0.296210] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]873alice # [ 0.303208] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned874bob # [ 0.296220] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]875clare # [ 0.301314] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned876alice # [ 0.303220] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned877bob # [ 0.296239] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]878clare # [ 0.301348] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned879alice # [ 0.303233] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned880bob # [ 0.296649] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint881clare # [ 0.301378] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned882alice # [ 0.303244] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned883bob # [ 0.296775] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]884clare # [ 0.301408] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned885bob # [ 0.296784] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]886alice # [ 0.303256] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned887bob # [ 0.296802] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]888alice # [ 0.303268] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned889clare # [ 0.301439] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned890bob # [ 0.297235] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned891alice # [ 0.303280] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned892clare # [ 0.301469] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned893alice # [ 0.303292] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned894bob # [ 0.297242] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned895clare # [ 0.301499] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned896alice # [ 0.303304] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned897bob # [ 0.297245] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned898clare # [ 0.301528] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned899alice # [ 0.303316] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned900bob # [ 0.297279] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned901alice # [ 0.303328] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned902clare # [ 0.301558] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned903alice # [ 0.303339] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned904bob # [ 0.297309] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned905clare # [ 0.301587] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned906alice # [ 0.303356] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]907bob # [ 0.297339] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned908clare # [ 0.301677] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned909alice # [ 0.303360] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]910bob # [ 0.297370] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned911clare # [ 0.301729] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned912alice # [ 0.303368] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]913bob # [ 0.297399] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned914clare # [ 0.301741] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned915clare # [ 0.301754] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned916bob # [ 0.297430] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned917clare # [ 0.301766] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned918bob # [ 0.297459] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned919clare # [ 0.301778] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned920bob # [ 0.297487] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned921clare # [ 0.301790] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned922bob # [ 0.297516] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned923clare # [ 0.301802] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned924alice # [ 0.325019] pci 0000:00:07.0: enabling device (0000 -> 0002)925bob # [ 0.297599] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned926clare # [ 0.301815] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned927bob # [ 0.297642] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned928clare # [ 0.301827] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned929bob # [ 0.297655] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned930clare # [ 0.301840] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned931bob # [ 0.297666] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned932clare # [ 0.301851] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned933bob # [ 0.297678] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned934clare # [ 0.301864] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned935bob # [ 0.297690] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned936clare # [ 0.301876] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned937clare # [ 0.301887] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned938bob # [ 0.297702] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned939clare # [ 0.301899] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned940bob # [ 0.297715] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned941clare # [ 0.301911] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned942bob # [ 0.297727] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned943clare # [ 0.301923] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned944bob # [ 0.297738] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned945clare # [ 0.301935] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned946bob # [ 0.297750] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned947clare # [ 0.301952] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]948bob # [ 0.297762] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned949clare # [ 0.301957] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]950bob # [ 0.297774] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned951clare # [ 0.301965] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]952bob # [ 0.297785] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned953bob # [ 0.297797] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned954bob # [ 0.297809] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned955bob # [ 0.297821] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned956alice # [ 0.333422] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)957bob # [ 0.297832] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned958alice # [ 0.334931] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)959bob # [ 0.297844] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned960bob # [ 0.297860] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]961bob # [ 0.297864] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]962bob # [ 0.297872] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]963bob # [ 0.325308] pci 0000:00:07.0: enabling device (0000 -> 0002)964clare # [ 0.326592] pci 0000:00:07.0: enabling device (0000 -> 0002)965bob # [ 0.332352] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)966alice # [ 0.344456] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)967bob # [ 0.333828] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)968alice # [ 0.346314] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)969clare # [ 0.341355] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)970clare # [ 0.343562] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)971alice # [ 0.355861] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)972bob # [ 0.343713] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)973clare # [ 0.344969] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)974alice # [ 0.358362] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)975bob # [ 0.345392] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)976clare # [ 0.346311] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)977clare # [ 0.355657] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)978clare # [ 0.357399] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)979alice # [ 0.368122] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)980bob # [ 0.356019] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)981alice # [ 0.369708] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)982bob # [ 0.357873] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)983alice # [ 0.371258] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)984clare # [ 0.359898] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)985clare # [ 0.361431] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)986alice # [ 0.374281] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)987bob # [ 0.368454] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)988bob # [ 0.370048] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)989clare # [ 0.370599] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)990alice # [ 0.383877] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)991clare # [ 0.372197] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)992bob # [ 0.372622] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)993alice # [ 0.387321] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled994bob # [ 0.373983] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)995clare # [ 0.374311] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)996alice # [ 0.389269] msm_serial: driver initialized997alice # [ 0.389397] SuperH (H)SCI(F) driver initialized998alice # [ 0.389439] STM32 USART driver initialized999clare # [ 0.385698] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1000bob # [ 0.383484] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1001clare # [ 0.387177] msm_serial: driver initialized1002clare # [ 0.387261] SuperH (H)SCI(F) driver initialized1003clare # [ 0.387310] STM32 USART driver initialized1004bob # [ 0.387574] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1005bob # [ 0.388557] msm_serial: driver initialized1006bob # [ 0.388628] SuperH (H)SCI(F) driver initialized1007bob # [ 0.388667] STM32 USART driver initialized1008alice # [ 0.412368] loop: module loaded1009alice # [ 0.412492] virtio_blk virtio2: 1/0/0 default/read/poll queues1010alice # [ 0.413079] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1011alice # [ 0.417409] megasas: 07.734.00.00-rc11012alice # [ 0.417902] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1013alice # [ 0.420709] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001014alice # [ 0.420730] Intel/Sharp Extended Query Table at 0x00311015alice # [ 0.422370] Using buffer write method1016alice # [ 0.422418] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1017clare # [ 0.412119] loop: module loaded1018clare # [ 0.412250] virtio_blk virtio2: 1/0/0 default/read/poll queues1019bob # [ 0.412503] loop: module loaded1020clare # [ 0.412870] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1021bob # [ 0.412619] virtio_blk virtio2: 1/0/0 default/read/poll queues1022bob # [ 0.413292] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1023alice # [ 0.432298] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001024alice # [ 0.432339] Intel/Sharp Extended Query Table at 0x00311025alice # [ 0.434317] Using buffer write method1026alice # [ 0.434329] Concatenating MTD devices:1027alice # [ 0.434331] (0): "0.flash"1028alice # [ 0.434333] (1): "0.flash"1029alice # [ 0.434334] into device "0.flash"1030bob # [ 0.418681] megasas: 07.734.00.00-rc11031bob # [ 0.419137] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1032clare # [ 0.416146] megasas: 07.734.00.00-rc11033clare # [ 0.416616] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1034bob # [ 0.431330] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001035bob # [ 0.431353] Intel/Sharp Extended Query Table at 0x00311036bob # [ 0.432938] Using buffer write method1037bob # [ 0.432992] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1038clare # [ 0.439595] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001039clare # [ 0.439620] Intel/Sharp Extended Query Table at 0x00311040clare # [ 0.441224] Using buffer write method1041clare # [ 0.441280] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1042clare # [ 0.445125] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001043clare # [ 0.445138] Intel/Sharp Extended Query Table at 0x00311044bob # [ 0.442313] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001045bob # [ 0.442338] Intel/Sharp Extended Query Table at 0x00311046bob # [ 0.444178] Using buffer write method1047bob # [ 0.444191] Concatenating MTD devices:1048bob # [ 0.444192] (0): "0.flash"1049bob # [ 0.444194] (1): "0.flash"1050bob # [ 0.444196] into device "0.flash"1051clare # [ 0.454478] Using buffer write method1052clare # [ 0.454491] Concatenating MTD devices:1053clare # [ 0.454492] (0): "0.flash"1054clare # [ 0.454494] (1): "0.flash"1055clare # [ 0.454496] into device "0.flash"1056alice # [ 0.649999] Freeing initrd memory: 26948K1057alice # [ 0.656843] tun: Universal TUN/TAP device driver, 1.61058alice # [ 0.659034] thunder_xcv, ver 1.01059alice # [ 0.659049] thunder_bgx, ver 1.01060alice # [ 0.659058] nicpf, ver 1.01061alice # [ 0.659382] e1000: Intel(R) PRO/1000 Network Driver1062alice # [ 0.659387] e1000: Copyright (c) 1999-2006 Intel Corporation.1063alice # [ 0.659401] e1000e: Intel(R) PRO/1000 Network Driver1064alice # [ 0.659406] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1065alice # [ 0.659417] igb: Intel(R) Gigabit Ethernet Network Driver1066alice # [ 0.659419] igb: Copyright (c) 2007-2014 Intel Corporation.1067alice # [ 0.659428] igbvf: Intel(R) Gigabit Virtual Function Network Driver1068alice # [ 0.659433] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1069alice # [ 0.659499] sky2: driver version 1.301070alice # [ 0.665257] usbcore: registered new interface driver usb-storage1071alice # [ 0.665343] usbcore: registered new interface driver usbserial_generic1072alice # [ 0.665361] usbserial: USB Serial support registered for generic1073alice # [ 0.665714] hv_vmbus: registering driver hyperv_keyboard1074alice # [ 0.666710] ehci-pci 0000:00:07.0: EHCI Host Controller1075alice # [ 0.666741] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11076alice # [ 0.667000] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001077alice # [ 0.667173] rtc-pl031 9010000.pl031: registered as rtc01078bob # [ 0.657793] Freeing initrd memory: 26932K1079alice # [ 0.667201] rtc-pl031 9010000.pl031: setting system clock to 2026-10-04T15:27:12 UTC (1791127632)1080alice # [ 0.667394] i2c_dev: i2c /dev entries driver1081alice # [ 0.673864] sdhci: Secure Digital Host Controller Interface driver1082alice # [ 0.673871] sdhci: Copyright(c) Pierre Ossman1083alice # [ 0.674032] Synopsys Designware Multimedia Card Interface Driver1084alice # [ 0.674217] sdhci-pltfm: SDHCI platform and OF driver helper1085alice # [ 0.675147] hid: raw HID events driver (C) Jiri Kosina1086alice # [ 0.675294] usbcore: registered new interface driver usbhid1087clare # [ 0.663525] Freeing initrd memory: 26956K1088alice # [ 0.675298] usbhid: USB HID core driver1089alice # [ 0.675771] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001090bob # [ 0.664835] tun: Universal TUN/TAP device driver, 1.61091alice # [ 0.676175] hub 1-0:1.0: USB hub found1092alice # [ 0.676201] hub 1-0:1.0: 6 ports detected1093bob # [ 0.667542] thunder_xcv, ver 1.01094bob # [ 0.667557] thunder_bgx, ver 1.01095alice # [ 0.680808] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1096bob # [ 0.667566] nicpf, ver 1.01097bob # [ 0.667896] e1000: Intel(R) PRO/1000 Network Driver1098alice # [ 0.681689] drop_monitor: Initializing network drop monitor service1099alice # [ 0.681852] NET: Registered PF_INET6 protocol family1100bob # [ 0.667900] e1000: Copyright (c) 1999-2006 Intel Corporation.1101alice # [ 0.682481] Segment Routing with IPv61102bob # [ 0.667915] e1000e: Intel(R) PRO/1000 Network Driver1103alice # [ 0.682497] In-situ OAM (IOAM) with IPv61104bob # [ 0.667920] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1105alice # [ 0.682541] NET: Registered PF_PACKET protocol family1106alice # [ 0.682598] 9pnet: Installing 9P2000 support1107bob # [ 0.667931] igb: Intel(R) Gigabit Ethernet Network Driver1108alice # [ 0.682630] Key type dns_resolver registered1109bob # [ 0.667933] igb: Copyright (c) 2007-2014 Intel Corporation.1110clare # [ 0.670565] tun: Universal TUN/TAP device driver, 1.61111bob # [ 0.667943] igbvf: Intel(R) Gigabit Virtual Function Network Driver1112clare # [ 0.672816] thunder_xcv, ver 1.01113clare # [ 0.672832] thunder_bgx, ver 1.01114bob # [ 0.667948] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1115clare # [ 0.672841] nicpf, ver 1.01116bob # [ 0.668012] sky2: driver version 1.301117clare # [ 0.673184] e1000: Intel(R) PRO/1000 Network Driver1118bob # [ 0.668869] usbcore: registered new interface driver usb-storage1119clare # [ 0.673189] e1000: Copyright (c) 1999-2006 Intel Corporation.1120clare # [ 0.673205] e1000e: Intel(R) PRO/1000 Network Driver1121bob # [ 0.668959] usbcore: registered new interface driver usbserial_generic1122clare # [ 0.673210] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1123bob # [ 0.668981] usbserial: USB Serial support registered for generic1124clare # [ 0.673221] igb: Intel(R) Gigabit Ethernet Network Driver1125bob # [ 0.669289] hv_vmbus: registering driver hyperv_keyboard1126clare # [ 0.673223] igb: Copyright (c) 2007-2014 Intel Corporation.1127bob # [ 0.670290] ehci-pci 0000:00:07.0: EHCI Host Controller1128clare # [ 0.673233] igbvf: Intel(R) Gigabit Virtual Function Network Driver1129clare # [ 0.673237] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1130clare # [ 0.673305] sky2: driver version 1.301131alice # [ 0.688670] registered taskstats version 11132clare # [ 0.674130] usbcore: registered new interface driver usb-storage1133alice # [ 0.688826] Loading compiled-in X.509 certificates1134clare # [ 0.674215] usbcore: registered new interface driver usbserial_generic1135clare # [ 0.674234] usbserial: USB Serial support registered for generic1136clare # [ 0.681488] ehci-pci 0000:00:07.0: EHCI Host Controller1137bob # [ 0.677226] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11138clare # [ 0.681521] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11139bob # [ 0.677428] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001140clare # [ 0.681763] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001141alice # [ 0.694160] Demotion targets for Node 0: null1142bob # [ 0.677603] rtc-pl031 9010000.pl031: registered as rtc01143alice # [ 0.694228] Key type .fscrypt registered1144clare # [ 0.681940] hv_vmbus: registering driver hyperv_keyboard1145alice # [ 0.694235] Key type fscrypt-provisioning registered1146bob # [ 0.677632] rtc-pl031 9010000.pl031: setting system clock to 2026-10-04T15:27:12 UTC (1791127632)1147bob # [ 0.677810] i2c_dev: i2c /dev entries driver1148alice # [ 0.694339] ima: No TPM chip found, activating TPM-bypass!1149alice # [ 0.694350] ima: Allocated hash algorithm: sha11150bob # [ 0.679416] sdhci: Secure Digital Host Controller Interface driver1151alice # [ 0.694404] ima: No architecture policies found1152bob # [ 0.679422] sdhci: Copyright(c) Pierre Ossman1153alice # [ 0.694897] input: gpio-keys as /devices/platform/gpio-keys/input/input01154bob # [ 0.679571] Synopsys Designware Multimedia Card Interface Driver1155bob # [ 0.679748] sdhci-pltfm: SDHCI platform and OF driver helper1156clare # [ 0.684339] rtc-pl031 9010000.pl031: registered as rtc01157bob # [ 0.680649] hid: raw HID events driver (C) Jiri Kosina1158bob # [ 0.680780] usbcore: registered new interface driver usbhid1159clare # [ 0.684373] rtc-pl031 9010000.pl031: setting system clock to 2026-10-04T15:27:12 UTC (1791127632)1160bob # [ 0.680783] usbhid: USB HID core driver1161clare # [ 0.684550] i2c_dev: i2c /dev entries driver1162clare # [ 0.686150] sdhci: Secure Digital Host Controller Interface driver1163clare # [ 0.686155] sdhci: Copyright(c) Pierre Ossman1164clare # [ 0.686311] Synopsys Designware Multimedia Card Interface Driver1165clare # [ 0.689306] sdhci-pltfm: SDHCI platform and OF driver helper1166clare # [ 0.690249] hid: raw HID events driver (C) Jiri Kosina1167bob # [ 0.686749] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001168clare # [ 0.690400] usbcore: registered new interface driver usbhid1169bob # [ 0.687122] hub 1-0:1.0: USB hub found1170clare # [ 0.690404] usbhid: USB HID core driver1171bob # [ 0.687146] hub 1-0:1.0: 6 ports detected1172clare # [ 0.690509] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001173bob # [ 0.687441] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1174bob # [ 0.688330] drop_monitor: Initializing network drop monitor service1175bob # [ 0.688443] NET: Registered PF_INET6 protocol family1176bob # [ 0.689057] Segment Routing with IPv61177bob # [ 0.689075] In-situ OAM (IOAM) with IPv61178clare # [ 0.692978] hub 1-0:1.0: USB hub found1179bob # [ 0.689119] NET: Registered PF_PACKET protocol family1180clare # [ 0.693003] hub 1-0:1.0: 6 ports detected1181bob # [ 0.689177] 9pnet: Installing 9P2000 support1182bob # [ 0.689211] Key type dns_resolver registered1183alice # [ 0.707446] clk: Disabling unused clocks1184clare # [ 0.693952] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1185alice # [ 0.707455] PM: genpd: Disabling unused power domains1186clare # [ 0.696131] drop_monitor: Initializing network drop monitor service1187clare # [ 0.696247] NET: Registered PF_INET6 protocol family1188clare # [ 0.696919] Segment Routing with IPv61189alice # [ 0.710461] Freeing unused kernel memory: 4736K1190bob # [ 0.696415] registered taskstats version 11191clare # [ 0.696935] In-situ OAM (IOAM) with IPv61192alice # [ 0.710536] Run /init as init process1193bob # [ 0.696576] Loading compiled-in X.509 certificates1194clare # [ 0.696980] NET: Registered PF_PACKET protocol family1195clare # [ 0.697037] 9pnet: Installing 9P2000 support1196clare # [ 0.697068] Key type dns_resolver registered1197bob # [ 0.701894] Demotion targets for Node 0: null1198bob # [ 0.701966] Key type .fscrypt registered1199bob # [ 0.701973] Key type fscrypt-provisioning registered1200bob # [ 0.702093] ima: No TPM chip found, activating TPM-bypass!1201bob # [ 0.702104] ima: Allocated hash algorithm: sha11202bob # [ 0.702181] ima: No architecture policies found1203clare # [ 0.702520] registered taskstats version 11204clare # [ 0.702694] Loading compiled-in X.509 certificates1205bob # [ 0.704971] input: gpio-keys as /devices/platform/gpio-keys/input/input01206clare # [ 0.708040] Demotion targets for Node 0: null1207clare # [ 0.708112] Key type .fscrypt registered1208clare # [ 0.708119] Key type fscrypt-provisioning registered1209clare # [ 0.708230] ima: No TPM chip found, activating TPM-bypass!1210clare # [ 0.708240] ima: Allocated hash algorithm: sha11211clare # [ 0.708341] ima: No architecture policies found1212clare # [ 0.708850] input: gpio-keys as /devices/platform/gpio-keys/input/input01213bob # [ 0.715305] clk: Disabling unused clocks1214alice # [ 0.730248] systemd[1]: Successfully made /usr/ read-only.1215bob # [ 0.715316] PM: genpd: Disabling unused power domains1216bob # [ 0.717659] Freeing unused kernel memory: 4736K1217bob # [ 0.717735] Run /init as init process1218clare # [ 0.721719] clk: Disabling unused clocks1219clare # [ 0.721729] PM: genpd: Disabling unused power domains1220clare # [ 0.724829] Freeing unused kernel memory: 4736K1221clare # [ 0.724914] Run /init as init process1222bob # [ 0.740740] systemd[1]: Successfully made /usr/ read-only.1223clare # [ 0.744888] systemd[1]: Successfully made /usr/ read-only.1224alice # [ 0.927831] usb 1-1: new high-speed USB device number 2 using ehci-pci1225bob # [ 0.938392] usb 1-1: new high-speed USB device number 2 using ehci-pci1226clare # [ 0.942525] usb 1-1: new high-speed USB device number 2 using ehci-pci1227alice # [ 1.064050] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1228alice # [ 1.064080] systemd[1]: Detected virtualization qemu.1229alice # [ 1.064120] systemd[1]: Detected architecture arm64.1230alice # [ 1.064129] systemd[1]: Running in initrd.1231alice # [ 1.064906] systemd[1]: Initializing machine ID from random generator.1232alice # [ 1.065261] systemd[1]: Hostname set to <alice>.1233bob # [ 1.074842] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1234alice # [ 1.094331] 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/input11235bob # [ 1.074873] systemd[1]: Detected virtualization qemu.1236bob # [ 1.074912] systemd[1]: Detected architecture arm64.1237bob # [ 1.074921] systemd[1]: Running in initrd.1238clare # [ 1.078997] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1239clare # [ 1.079029] systemd[1]: Detected virtualization qemu.1240bob # [ 1.075702] systemd[1]: Initializing machine ID from random generator.1241clare # [ 1.079069] systemd[1]: Detected architecture arm64.1242bob # [ 1.075965] systemd[1]: Hostname set to <bob>.1243clare # [ 1.079078] systemd[1]: Running in initrd.1244clare # [ 1.079930] systemd[1]: Initializing machine ID from random generator.1245clare # [ 1.080221] systemd[1]: Hostname set to <clare>.1246bob # [ 1.097897] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11247clare # [ 1.109448] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11248alice # [ 1.183674] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01249alice # [ 1.203518] systemd[1]: bpf-restrict-fs: LSM BPF program attached1250bob # [ 1.186466] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01251clare # [ 1.194637] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01252bob # [ 1.211336] systemd[1]: bpf-restrict-fs: LSM BPF program attached1253clare # [ 1.224786] systemd[1]: bpf-restrict-fs: LSM BPF program attached1254alice # [ 1.258127] systemd[1]: Queued start job for default target Initrd Default Target.1255alice # [ 1.265135] systemd[1]: Created slice Slice /system/modprobe.1256alice # [ 1.265302] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1257alice # [ 1.265337] systemd[1]: Expecting device /dev/disk/by-label/nixos...1258alice # [ 1.265356] systemd[1]: Reached target Path Units.1259alice # [ 1.265368] systemd[1]: Reached target Slice Units.1260alice # [ 1.265380] systemd[1]: Reached target Swaps.1261alice # [ 1.265390] systemd[1]: Reached target Timer Units.1262alice # [ 1.265527] systemd[1]: Listening on D-Bus System Message Bus Socket.1263alice # [ 1.265641] systemd[1]: Listening on Journal Socket (/dev/log).1264alice # [ 1.265752] systemd[1]: Listening on Journal Sockets.1265bob # [ 1.259491] systemd[1]: Queued start job for default target Initrd Default Target.1266alice # [ 1.265819] systemd[1]: Listening on udev Control Socket.1267alice # [ 1.265858] systemd[1]: Listening on udev Kernel Socket.1268alice # [ 1.265871] systemd[1]: Reached target Socket Units.1269alice # [ 1.266857] systemd[1]: Starting Create List of Static Device Nodes...1270alice # [ 1.266904] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1271alice # [ 1.278735] systemd[1]: Mounting Kernel Configuration File System...1272bob # [ 1.267642] systemd[1]: Created slice Slice /system/modprobe.1273bob # [ 1.267769] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1274bob # [ 1.267798] systemd[1]: Expecting device /dev/disk/by-label/nixos...1275bob # [ 1.267817] systemd[1]: Reached target Path Units.1276bob # [ 1.267829] systemd[1]: Reached target Slice Units.1277bob # [ 1.267838] systemd[1]: Reached target Swaps.1278bob # [ 1.267849] systemd[1]: Reached target Timer Units.1279bob # [ 1.267968] systemd[1]: Listening on D-Bus System Message Bus Socket.1280bob # [ 1.268074] systemd[1]: Listening on Journal Socket (/dev/log).1281bob # [ 1.268218] systemd[1]: Listening on Journal Sockets.1282alice # [ 1.283938] systemd[1]: Starting Journal Service...1283bob # [ 1.268287] systemd[1]: Listening on udev Control Socket.1284bob # [ 1.268326] systemd[1]: Listening on udev Kernel Socket.1285bob # [ 1.268338] systemd[1]: Reached target Socket Units.1286bob # [ 1.269328] systemd[1]: Starting Create List of Static Device Nodes...1287bob # [ 1.269374] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1288bob # [ 1.280983] systemd[1]: Mounting Kernel Configuration File System...1289alice # [ 1.294772] systemd[1]: Starting Load Kernel Modules...1290clare # [ 1.280755] systemd[1]: Queued start job for default target Initrd Default Target.1291alice # [ 1.294829] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1292clare # [ 1.284601] systemd[1]: Created slice Slice /system/modprobe.1293clare # [ 1.284743] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1294clare # [ 1.284801] systemd[1]: Expecting device /dev/disk/by-label/nixos...1295clare # [ 1.284822] systemd[1]: Reached target Path Units.1296clare # [ 1.284834] systemd[1]: Reached target Slice Units.1297clare # [ 1.284846] systemd[1]: Reached target Swaps.1298clare # [ 1.284858] systemd[1]: Reached target Timer Units.1299clare # [ 1.284991] systemd[1]: Listening on D-Bus System Message Bus Socket.1300clare # [ 1.285164] systemd[1]: Listening on Journal Socket (/dev/log).1301clare # [ 1.285779] systemd[1]: Listening on Journal Sockets.1302bob # [ 1.286511] systemd[1]: Starting Journal Service...1303clare # [ 1.285861] systemd[1]: Listening on udev Control Socket.1304clare # [ 1.285904] systemd[1]: Listening on udev Kernel Socket.1305clare # [ 1.285918] systemd[1]: Reached target Socket Units.1306clare # [ 1.293342] systemd[1]: Starting Create List of Static Device Nodes...1307clare # [ 1.293397] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1308alice # [ 1.303775] usb 1-2: new high-speed USB device number 3 using ehci-pci1309alice # [ 1.304751] systemd[1]: Starting Coldplug All udev Devices...1310bob # [ 1.296784] systemd[1]: Starting Load Kernel Modules...1311bob # [ 1.296842] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1312clare # [ 1.301035] systemd[1]: Mounting Kernel Configuration File System...1313bob # [ 1.306350] usb 1-2: new high-speed USB device number 3 using ehci-pci1314bob # [ 1.307247] systemd[1]: Starting Coldplug All udev Devices...1315alice # [ 1.319821] systemd[1]: Finished Create List of Static Device Nodes.1316clare # [ 1.310768] systemd[1]: Starting Journal Service...1317alice # [ 1.320713] systemd[1]: Mounted Kernel Configuration File System.1318clare # [ 1.314485] usb 1-2: new high-speed USB device number 3 using ehci-pci1319bob # [ 1.318575] systemd[1]: Finished Create List of Static Device Nodes.1320bob # [ 1.319312] systemd[1]: Mounted Kernel Configuration File System.1321bob # [ 1.320430] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1322alice # [ 1.332339] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1323alice # [ 1.335062] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1324alice # [ 1.338041] systemd-journald[71]: Collecting audit messages is disabled.1325clare # [ 1.334574] systemd[1]: Starting Load Kernel Modules...1326clare # [ 1.334653] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1327clare # [ 1.335602] systemd[1]: Starting Coldplug All udev Devices...1328alice # [ 1.348593] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1329clare # [ 1.340255] systemd[1]: Finished Create List of Static Device Nodes.1330clare # [ 1.341019] systemd[1]: Mounted Kernel Configuration File System.1331bob # [ 1.336951] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1332alice # [ 1.359200] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01333alice # [ 1.359433] [drm] features: -virgl +edid -resource_blob -host_visible1334alice # [ 1.359436] [drm] features: -context_init1335clare # [ 1.347677] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1336clare # [ 1.352233] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1337clare # [ 1.353314] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1338alice # [ 1.363856] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1339alice # [ 1.368695] systemd[1]: Starting Create Static Device Nodes in /dev...1340bob # [ 1.354396] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1341bob # [ 1.364588] systemd-journald[71]: Collecting audit messages is disabled.1342clare # [ 1.360443] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01343clare # [ 1.360672] [drm] features: -virgl +edid -resource_blob -host_visible1344clare # [ 1.360674] [drm] features: -context_init1345bob # [ 1.367305] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1346clare # [ 1.361157] [drm] number of scanouts: 11347clare # [ 1.361166] [drm] number of cap sets: 01348alice # [ 1.380041] [drm] number of scanouts: 11349alice # [ 1.380051] [drm] number of cap sets: 01350alice # [ 1.380629] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1351alice # [ 1.380637] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01352bob # [ 1.371304] systemd[1]: Starting Create Static Device Nodes in /dev...1353bob # [ 1.375824] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01354bob # [ 1.376050] [drm] features: -virgl +edid -resource_blob -host_visible1355bob # [ 1.376052] [drm] features: -context_init1356bob # [ 1.376530] [drm] number of scanouts: 11357bob # [ 1.376539] [drm] number of cap sets: 01358clare # [ 1.382831] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1359clare # [ 1.382843] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01360bob # [ 1.382656] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1361bob # [ 1.382663] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01362alice # [ 1.401791] Console: switching to colour frame buffer device 160x501363clare # [ 1.394904] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1364clare # [ 1.395978] systemd[1]: Starting Create Static Device Nodes in /dev...1365alice # [ 1.408275] systemd[1]: Finished Create Static Device Nodes in /dev.1366alice # [ 1.408404] systemd[1]: Reached target Preparation for Local File Systems.1367alice # [ 1.408421] systemd[1]: Reached target Local File Systems.1368alice # [ 1.413441] systemd[1]: Starting Rule-based Manager for Device Events and Files...1369clare # [ 1.402866] Console: switching to colour frame buffer device 160x501370bob # [ 1.402631] Console: switching to colour frame buffer device 160x501371clare # [ 1.412335] systemd-journald[71]: Collecting audit messages is disabled.1372bob # [ 1.410674] systemd[1]: Finished Create Static Device Nodes in /dev.1373alice # [ 1.426607] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1374bob # [ 1.410805] systemd[1]: Reached target Preparation for Local File Systems.1375bob # [ 1.410822] systemd[1]: Reached target Local File Systems.1376bob # [ 1.411926] systemd[1]: Starting Rule-based Manager for Device Events and Files...1377alice # [ 1.435899] systemd[1]: Finished Load Kernel Modules.1378alice # [ 1.436963] systemd[1]: Starting Apply Kernel Variables...1379alice # [ 1.433952] systemd-modules-load[72]: Inserted module 'dm_mod'1380alice # [ 1.436327] systemd-modules-load[72]: Module 'virtio_balloon' is built in1381alice # [ 1.437095] systemd-modules-load[72]: Module 'virtio_console' is built in1382alice # [ 1.437850] systemd-modules-load[72]: Inserted module 'virtio_gpu'1383alice # [ 1.438607] systemd-modules-load[72]: Module 'virtio_rng' is built in1384clare # [ 1.430989] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1385bob # [ 1.430910] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1386alice # [ 1.449360] systemd[1]: Started Journal Service.1387clare # [ 1.438871] systemd[1]: Finished Create Static Device Nodes in /dev.1388clare # [ 1.439031] systemd[1]: Reached target Preparation for Local File Systems.1389clare # [ 1.439059] systemd[1]: Reached target Local File Systems.1390clare # [ 1.440224] systemd[1]: Starting Rule-based Manager for Device Events and Files...1391bob # [ 1.442739] systemd[1]: Finished Load Kernel Modules.1392alice # [ 1.458227] 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/input21393alice # [ 1.458375] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01394clare # [ 1.449365] systemd[1]: Finished Load Kernel Modules.1395bob # [ 1.451020] systemd[1]: Starting Apply Kernel Variables...1396clare # [ 1.454746] systemd[1]: Starting Apply Kernel Variables...1397alice # [ 1.469138] systemd[1]: Starting Create System Files and Directories...1398bob # [ 1.461909] systemd-modules-load[72]: Inserted module 'dm_mod'1399bob # [ 1.466660] 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/input21400bob # [ 1.466831] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01401bob # [ 1.469035] systemd[1]: Started Journal Service.1402bob # [ 1.467214] systemd-modules-load[72]: Module 'virtio_balloon' is built in1403clare # [ 1.470511] 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/input21404clare # [ 1.478101] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01405alice # [ 1.486971] systemd-udevd[79]: Using default interface naming scheme 'v261'.1406bob # [ 1.478754] systemd-modules-load[72]: Module 'virtio_console' is built in1407bob # [ 1.479599] systemd-modules-load[72]: Inserted module 'virtio_gpu'1408alice # [ 1.492584] systemd[1]: Finished Apply Kernel Variables.1409clare # [ 1.486653] systemd[1]: Started Journal Service.1410bob # [ 1.488266] systemd-modules-load[72]: Module 'virtio_rng' is built in1411alice # [ 1.500685] systemd[1]: Finished Create System Files and Directories.1412bob # [ 1.488931] systemd[1]: Starting Create System Files and Directories...1413bob # [ 1.496117] systemd[1]: Finished Apply Kernel Variables.1414clare # [ 1.497414] systemd-modules-load[72]: Inserted module 'dm_mod'1415clare # [ 1.498300] systemd-modules-load[72]: Module 'virtio_balloon' is built in1416clare # [ 1.499029] systemd-modules-load[72]: Module 'virtio_console' is built in1417clare # [ 1.499792] systemd-modules-load[72]: Inserted module 'virtio_gpu'1418bob # [ 1.502280] systemd-udevd[79]: Using default interface naming scheme 'v261'.1419bob # [ 1.503718] systemd[1]: Finished Create System Files and Directories.1420alice # [ 1.517449] systemd[1]: Started Rule-based Manager for Device Events and Files.1421clare # [ 1.512315] systemd-modules-load[72]: Module 'virtio_rng' is built in1422clare # [ 1.512989] systemd[1]: Starting Create System Files and Directories...1423clare # [ 1.513709] systemd[1]: Finished Apply Kernel Variables.1424bob # [ 1.524255] systemd[1]: Started Rule-based Manager for Device Events and Files.1425clare # [ 1.527749] systemd[1]: Finished Create System Files and Directories.1426clare # [ 1.529520] systemd-udevd[79]: Using default interface naming scheme 'v261'.1427clare # [ 1.548271] systemd[1]: Started Rule-based Manager for Device Events and Files.1428alice # [ 1.565066] systemd[1]: Starting Virtual Console Setup...1429clare # [ 1.590601] systemd[1]: Starting Virtual Console Setup...1430alice # [ 1.604302] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1431alice # [ 1.606606] systemd[1]: Finished Virtual Console Setup.1432bob # [ 1.596067] systemd[1]: Starting Virtual Console Setup...1433clare # [ 1.640316] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1434clare # [ 1.642785] systemd[1]: Finished Virtual Console Setup.1435bob # [ 1.647311] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1436bob # [ 1.649622] systemd[1]: Finished Virtual Console Setup.1437alice # [ 1.834878] systemd[1]: Finished Coldplug All udev Devices.1438alice # [ 1.835479] systemd[1]: Reached target System Initialization.1439alice # [ 1.836039] systemd[1]: Reached target Basic System.1440bob # [ 1.858900] systemd[1]: Finished Coldplug All udev Devices.1441bob # [ 1.859489] systemd[1]: Reached target System Initialization.1442bob # [ 1.860053] systemd[1]: Reached target Basic System.1443clare # [ 1.867403] systemd[1]: Finished Coldplug All udev Devices.1444clare # [ 1.868037] systemd[1]: Reached target System Initialization.1445clare # [ 1.872095] systemd[1]: Reached target Basic System.1446alice # [ 1.928211] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1447alice # [ 1.958705] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.1448bob # [ 1.960225] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1449clare # [ 1.966114] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1450bob # [ 1.970784] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1451clare # [ 1.988852] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1452alice # [ 2.024352] systemd[1]: Found device /dev/disk/by-label/nixos.1453alice # [ 2.028881] systemd[1]: Reached target Initrd Root Device.1454alice # [ 2.032196] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1455clare # [ 2.041530] systemd[1]: Found device /dev/disk/by-label/nixos.1456bob # [ 2.047309] systemd[1]: Found device /dev/disk/by-label/nixos.1457clare # [ 2.049010] systemd[1]: Reached target Initrd Root Device.1458bob # [ 2.049438] systemd[1]: Reached target Initrd Root Device.1459clare # [ 2.052139] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1460bob # [ 2.051880] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1461alice # [ 2.064651] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1462alice # [ 2.068979] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1463bob # [ 2.084288] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1464bob # [ 2.089144] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1465clare # [ 2.093936] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks1466clare # [ 2.098387] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1467alice # [ 2.298445] systemd[1]: Mounting /sysroot...1468bob # [ 2.304152] systemd[1]: Mounting /sysroot...1469alice # [ 2.330037] EXT4-fs (vda): mounted filesystem 5ea69935-7a05-4fd9-9dea-02574aa75611 r/w with ordered data mode. Quota mode: none.1470alice # [ 2.326300] systemd[1]: Mounted /sysroot.1471alice # [ 2.326729] systemd[1]: Reached target Initrd Root File System.1472alice # [ 2.330479] systemd[1]: Starting Mountpoints Configured in the Real Root...1473alice # [ 2.337727] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1474bob # [ 2.334012] EXT4-fs (vda): mounted filesystem 9a85103c-e61a-45f1-815c-081cff456cc0 r/w with ordered data mode. Quota mode: none.1475alice # [ 2.342591] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1476clare # [ 2.331861] systemd[1]: Mounting /sysroot...1477bob # [ 2.333004] systemd[1]: Mounted /sysroot.1478alice # [ 2.345570] systemd[1]: Reloading...1479bob # [ 2.334905] systemd[1]: Reached target Initrd Root File System.1480bob # [ 2.340435] systemd[1]: Starting Mountpoints Configured in the Real Root...1481bob # [ 2.357552] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1482clare # [ 2.365132] EXT4-fs (vda): mounted filesystem 3317e99a-9d03-426d-9dd0-980aa506fcea r/w with ordered data mode. Quota mode: none.1483clare # [ 2.362794] systemd[1]: Mounted /sysroot.1484clare # [ 2.363265] systemd[1]: Reached target Initrd Root File System.1485bob # [ 2.362144] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1486bob # [ 2.364397] systemd[1]: Reloading...1487clare # [ 2.367114] systemd[1]: Starting Mountpoints Configured in the Real Root...1488clare # [ 2.377564] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1489clare # [ 2.380303] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1490clare # [ 2.382989] systemd[1]: Reloading...1491alice # [ 2.508084] systemd[1]: Reloading finished in 163 ms.1492alice # [ 2.531870] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1493alice # [ 2.535493] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1494alice # [ 2.537945] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1495alice # [ 2.539625] systemd[1]: Finished Mountpoints Configured in the Real Root.1496alice # [ 2.541319] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1497bob # [ 2.531261] systemd[1]: Reloading finished in 166 ms.1498clare # [ 2.548839] systemd[1]: Reloading finished in 165 ms.1499bob # [ 2.559364] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1500bob # [ 2.561388] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1501bob # [ 2.565889] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1502clare # [ 2.568286] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1503bob # [ 2.567801] systemd[1]: Finished Mountpoints Configured in the Real Root.1504bob # [ 2.569578] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1505clare # [ 2.571126] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1506clare # [ 2.573286] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1507clare # [ 2.575073] systemd[1]: Finished Mountpoints Configured in the Real Root.1508clare # [ 2.576380] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1509alice # [ 2.766005] fuse: init (API version 7.45)1510bob # [ 2.769947] fuse: init (API version 7.45)1511alice # [ 2.790645] virtiofs virtio6: discovered new tag: nix-store1512alice # [ 2.791134] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1513clare # [ 2.781204] fuse: init (API version 7.45)1514alice # [ 2.792727] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1515alice # [ 2.797388] (udev-worker)[94]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1516bob # [ 2.803913] virtiofs virtio6: discovered new tag: nix-store1517alice # [ 2.818822] virtiofs virtio7: discovered new tag: shared1518bob # [ 2.804429] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1519alice # [ 2.819303] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1520alice # [ 2.818707] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1521alice # [ 2.819391] systemd[1]: Stopped Virtual Console Setup.1522alice # [ 2.825143] virtiofs virtio8: discovered new tag: xchg1523alice # [ 2.825606] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1524bob # [ 2.809165] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1525alice # [ 2.824323] systemd[1]: Stopping Virtual Console Setup...1526alice # [ 2.825058] systemd[1]: Starting Virtual Console Setup...1527bob # [ 2.812832] (udev-worker)[96]: 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 directory1528clare # [ 2.820421] virtiofs virtio6: discovered new tag: nix-store1529clare # [ 2.820934] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1530alice # [ 2.837313] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1531alice # [ 2.838013] systemd[1]: Stopped Virtual Console Setup.1532bob # [ 2.832392] virtiofs virtio7: discovered new tag: shared1533alice # [ 2.840167] systemd[1]: Starting Virtual Console Setup...1534bob # [ 2.832890] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1535clare # [ 2.840646] virtiofs virtio7: discovered new tag: shared1536clare # [ 2.841164] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1537bob # [ 2.842190] virtiofs virtio8: discovered new tag: xchg1538bob # [ 2.837584] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1539bob # [ 2.838536] systemd[1]: Stopped Virtual Console Setup.1540bob # [ 2.839149] systemd[1]: Stopping Virtual Console Setup...1541clare # [ 2.840389] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1542bob # [ 2.840690] systemd[1]: Starting Virtual Console Setup...1543clare # [ 2.843994] (udev-worker)[96]: 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 directory1544alice # [ 2.856630] systemd-vconsole-setup[139]: Configuration of first virtual console was skipped, ignoring remaining ones.1545alice # [ 2.858700] systemd[1]: Finished Virtual Console Setup.1546bob # [ 2.851352] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1547bob # [ 2.852455] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1548bob # [ 2.854829] systemd[1]: Stopped Virtual Console Setup.1549bob # [ 2.856326] systemd[1]: Starting Virtual Console Setup...1550clare # [ 2.866298] virtiofs virtio8: discovered new tag: xchg1551clare # [ 2.868981] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1552clare # [ 2.865189] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1553clare # [ 2.866861] systemd[1]: Stopped Virtual Console Setup.1554clare # [ 2.867405] systemd[1]: Stopping Virtual Console Setup...1555clare # [ 2.869140] systemd[1]: Starting Virtual Console Setup...1556bob # [ 2.882688] systemd-vconsole-setup[139]: Configuration of first virtual console was skipped, ignoring remaining ones.1557bob # [ 2.884834] systemd[1]: Finished Virtual Console Setup.1558clare # [ 2.898882] systemd-vconsole-setup[138]: Configuration of first virtual console was skipped, ignoring remaining ones.1559clare # [ 2.901191] systemd[1]: Finished Virtual Console Setup.1560alice # [ 3.302757] systemd[1]: Mounting /sysroot/nix/.ro-store...1561alice # [ 3.312270] systemd[1]: Mounting /sysroot/nix/.rw-store...1562alice # [ 3.315451] systemd[1]: Mounting /sysroot/run...1563bob # [ 3.306847] systemd[1]: Mounting /sysroot/nix/.ro-store...1564alice # [ 3.326600] systemd[1]: Mounting /sysroot/tmp/shared...1565bob # [ 3.316294] systemd[1]: Mounting /sysroot/nix/.rw-store...1566bob # [ 3.319652] systemd[1]: Mounting /sysroot/run...1567bob # [ 3.330765] systemd[1]: Mounting /sysroot/tmp/shared...1568clare # [ 3.335336] systemd[1]: Mounting /sysroot/nix/.ro-store...1569clare # [ 3.344331] systemd[1]: Mounting /sysroot/nix/.rw-store...1570alice # [ 3.356664] systemd[1]: Mounting /sysroot/tmp/xchg...1571clare # [ 3.352294] systemd[1]: Mounting /sysroot/run...1572bob # [ 3.360256] systemd[1]: Mounting /sysroot/tmp/xchg...1573clare # [ 3.362030] systemd[1]: Mounting /sysroot/tmp/shared...1574alice # [ 3.374136] systemd[1]: Mounted /sysroot/nix/.ro-store.1575alice # [ 3.384504] systemd[1]: Mounted /sysroot/nix/.rw-store.1576alice # [ 3.386192] systemd[1]: Mounted /sysroot/run.1577alice # [ 3.389519] systemd[1]: Mounted /sysroot/tmp/shared.1578bob # [ 3.381116] systemd[1]: Mounted /sysroot/nix/.ro-store.1579alice # [ 3.398016] systemd[1]: Starting rw-sysroot-nix-store.service...1580alice # [ 3.402594] systemd[1]: Mounted /sysroot/tmp/xchg.1581clare # [ 3.396242] systemd[1]: Mounting /sysroot/tmp/xchg...1582bob # [ 3.396453] systemd[1]: Mounted /sysroot/nix/.rw-store.1583bob # [ 3.397507] systemd[1]: Mounted /sysroot/run.1584bob # [ 3.399045] systemd[1]: Mounted /sysroot/tmp/shared.1585alice # [ 3.415236] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1586alice # [ 3.416660] systemd[1]: Finished rw-sysroot-nix-store.service.1587bob # [ 3.406150] systemd[1]: Starting rw-sysroot-nix-store.service...1588alice # [ 3.418926] systemd[1]: Mounting /sysroot/nix/store...1589bob # [ 3.407819] systemd[1]: Mounted /sysroot/tmp/xchg.1590clare # [ 3.409512] systemd[1]: Mounted /sysroot/nix/.rw-store.1591clare # [ 3.420868] systemd[1]: Starting rw-sysroot-nix-store.service...1592bob # [ 3.422257] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1593bob # [ 3.423415] systemd[1]: Finished rw-sysroot-nix-store.service.1594clare # [ 3.424334] systemd[1]: Mounted /sysroot/nix/.ro-store.1595clare # [ 3.425041] systemd[1]: Mounted /sysroot/run.1596clare # [ 3.425621] systemd[1]: Mounted /sysroot/tmp/shared.1597clare # [ 3.442954] systemd[1]: Mounted /sysroot/tmp/xchg.1598alice # [ 3.454704] systemd[1]: Mounted /sysroot/nix/store.1599alice # [ 3.456467] systemd[1]: Reached target Initrd File Systems.1600clare # [ 3.446248] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1601clare # [ 3.447525] systemd[1]: Finished rw-sysroot-nix-store.service.1602alice # [ 3.458664] systemd[1]: Starting Find NixOS closure...1603alice # [ 3.464676] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1604alice # [ 3.491789] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1605alice # [ 3.503412] systemd[1]: Finished Find NixOS closure.1606alice # [ 3.505179] systemd[1]: Reached target Initrd Default Target.1607alice # [ 3.506358] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1608alice # [ 3.528451] systemd[1]: Stopped target Initrd Default Target.1609alice # [ 3.529703] systemd[1]: Stopped target Basic System.1610alice # [ 3.530688] systemd[1]: Stopped target Initrd Root Device.1611alice # [ 3.531671] systemd[1]: Stopped target Path Units.1612alice # [ 3.532655] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1613alice # [ 3.536316] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1614alice # [ 3.537312] systemd[1]: Stopped target Slice Units.1615alice # [ 3.538616] systemd[1]: Stopped target Socket Units.1616alice # [ 3.540114] systemd[1]: Stopped target System Initialization.1617alice # [ 3.541994] systemd[1]: Stopped target Swaps.1618alice # [ 3.544118] systemd[1]: Stopped target Timer Units.1619alice # [ 3.548107] systemd[1]: dbus.socket: Deactivated successfully.1620alice # [ 3.549930] systemd[1]: Closed D-Bus System Message Bus Socket.1621alice # [ 3.551489] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1622alice # [ 3.553387] systemd[1]: Stopped Find NixOS closure.1623alice # [ 3.557923] systemd[1]: Starting rw-sysroot-nix-store.service...1624alice # [ 3.558579] systemd[1]: systemd-sysctl.service: Deactivated successfully.1625alice # [ 3.559926] systemd[1]: Stopped Apply Kernel Variables.1626alice # [ 3.562265] systemd[1]: systemd-modules-load.service: Deactivated successfully.1627alice # [ 3.563478] systemd[1]: Stopped Load Kernel Modules.1628alice # [ 3.569562] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1629alice # [ 3.572153] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1630alice # [ 3.573086] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1631alice # [ 3.574951] systemd[1]: Stopped Create System Files and Directories.1632alice # [ 3.576663] systemd[1]: Stopped target Local File Systems.1633alice # [ 3.579684] systemd[1]: Stopped target Preparation for Local File Systems.1634alice # [ 3.580530] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1635alice # [ 3.581348] systemd[1]: Stopped Coldplug All udev Devices.1636alice # [ 3.582148] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1637alice # [ 3.582951] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1638alice # [ 3.583723] systemd[1]: Stopped Virtual Console Setup.1639alice # [ 3.584377] systemd[1]: initrd-cleanup.service: Deactivated successfully.1640alice # [ 3.585086] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1641alice # [ 3.585794] systemd[1]: systemd-udevd.service: Deactivated successfully.1642alice # [ 3.586491] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1643alice # [ 3.587247] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1644alice # [ 3.587995] systemd[1]: Finished rw-sysroot-nix-store.service.1645alice # [ 3.596089] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1646alice # [ 3.596832] systemd[1]: Closed udev Control Socket.1647alice # [ 3.597424] systemd[1]: Starting Cleanup udev Database...1648alice # [ 3.598113] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1649alice # [ 3.598811] systemd[1]: Stopped Create Static Device Nodes in /dev.1650alice # [ 3.599378] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1651alice # [ 3.604194] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1652alice # [ 3.604832] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1653alice # [ 3.605444] systemd[1]: Stopped Create List of Static Device Nodes.1654alice # [ 3.615355] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1655alice # [ 3.616804] systemd[1]: Finished Cleanup udev Database.1656alice # [ 3.617294] systemd[1]: Reached target Switch Root.1657alice # [ 3.617757] systemd[1]: Starting NixOS Activation...1658alice # [ 3.685313] initrd-nixos-activation-start[174]: booting system configuration /nix/store/224zj3jyaabv4hz182jfl10dhc1dfxmj-nixos-system-alice-test1659alice # [ 3.711732] initrd-nixos-activation-start[174]: running activation script...1660alice # [ 3.914387] initrd-nixos-activation-start[197]: setting up /etc...1661alice # [ 3.997487] initrd-nixos-activation-start[197]: setting up age secrets...1662alice # [ 4.055798] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1663alice # [ 4.057651] systemd[1]: Finished NixOS Activation.1664alice # [ 4.058398] systemd[1]: Starting Switch Root...1665alice # [ 4.071811] systemd[1]: Switching root.1666alice # [ 4.240185] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1667bob # [ 4.303939] systemd[1]: Mounting /sysroot/nix/store...1668clare # [ 4.332710] systemd[1]: Mounting /sysroot/nix/store...1669bob # [ 4.353517] systemd[1]: Mounted /sysroot/nix/store.1670bob # [ 4.356177] systemd[1]: Reached target Initrd File Systems.1671bob # [ 4.359765] systemd[1]: Starting Find NixOS closure...1672bob # [ 4.368246] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1673clare # [ 4.381136] systemd[1]: Mounted /sysroot/nix/store.1674clare # [ 4.384155] systemd[1]: Reached target Initrd File Systems.1675clare # [ 4.387542] systemd[1]: Starting Find NixOS closure...1676clare # [ 4.396257] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1677bob # [ 4.404411] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1678bob # [ 4.408228] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1679bob # [ 4.423985] systemd[1]: Finished Find NixOS closure.1680bob # [ 4.425807] systemd[1]: Reached target Initrd Default Target.1681bob # [ 4.428683] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1682clare # [ 4.438392] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1683clare # [ 4.440233] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1684clare # [ 4.451381] systemd[1]: Finished Find NixOS closure.1685clare # [ 4.453522] systemd[1]: Reached target Initrd Default Target.1686clare # [ 4.456258] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1687bob # [ 4.456697] systemd[1]: Stopped target Initrd Default Target.1688bob # [ 4.460100] systemd[1]: Stopped target Basic System.1689bob # [ 4.460935] systemd[1]: Stopped target Initrd Root Device.1690bob # [ 4.462612] systemd[1]: Stopped target Path Units.1691bob # [ 4.464142] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1692bob # [ 4.468140] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1693bob # [ 4.469174] systemd[1]: Stopped target Slice Units.1694bob # [ 4.469889] systemd[1]: Stopped target Socket Units.1695bob # [ 4.470598] systemd[1]: Stopped target System Initialization.1696bob # [ 4.471385] systemd[1]: Stopped target Swaps.1697bob # [ 4.471972] systemd[1]: Stopped target Timer Units.1698bob # [ 4.477844] systemd[1]: dbus.socket: Deactivated successfully.1699bob # [ 4.480124] systemd[1]: Closed D-Bus System Message Bus Socket.1700bob # [ 4.482937] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1701bob # [ 4.485594] systemd[1]: Stopped Find NixOS closure.1702bob # [ 4.486521] systemd[1]: Starting rw-sysroot-nix-store.service...1703clare # [ 4.488398] systemd[1]: Stopped target Initrd Default Target.1704bob # [ 4.487647] systemd[1]: systemd-sysctl.service: Deactivated successfully.1705bob # [ 4.488584] systemd[1]: Stopped Apply Kernel Variables.1706bob # [ 4.489196] systemd[1]: systemd-modules-load.service: Deactivated successfully.1707bob # [ 4.490191] systemd[1]: Stopped Load Kernel Modules.1708bob # [ 4.490768] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1709clare # [ 4.492337] systemd[1]: Stopped target Basic System.1710bob # [ 4.491600] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1711clare # [ 4.493113] systemd[1]: Stopped target Initrd Root Device.1712clare # [ 4.493891] systemd[1]: Stopped target Path Units.1713clare # [ 4.495104] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1714clare # [ 4.497646] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1715clare # [ 4.500123] systemd[1]: Stopped target Slice Units.1716bob # [ 4.499646] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1717clare # [ 4.501718] systemd[1]: Stopped target Socket Units.1718clare # [ 4.504108] systemd[1]: Stopped target System Initialization.1719clare # [ 4.504894] systemd[1]: Stopped target Swaps.1720bob # [ 4.504271] systemd[1]: Stopped Create System Files and Directories.1721bob # [ 4.505017] systemd[1]: Stopped target Local File Systems.1722clare # [ 4.506236] systemd[1]: Stopped target Timer Units.1723bob # [ 4.505647] systemd[1]: Stopped target Preparation for Local File Systems.1724clare # [ 4.508125] systemd[1]: dbus.socket: Deactivated successfully.1725bob # [ 4.507747] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1726bob # [ 4.508771] systemd[1]: Stopped Coldplug All udev Devices.1727clare # [ 4.509633] systemd[1]: Closed D-Bus System Message Bus Socket.1728bob # [ 4.510266] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1729clare # [ 4.511835] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1730bob # [ 4.511351] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1731bob # [ 4.512119] systemd[1]: Stopped Virtual Console Setup.1732bob # [ 4.512619] systemd[1]: initrd-cleanup.service: Deactivated successfully.1733bob # [ 4.513229] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1734clare # [ 4.514537] systemd[1]: Stopped Find NixOS closure.1735bob # [ 4.513879] systemd[1]: systemd-udevd.service: Deactivated successfully.1736bob # [ 4.514495] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1737bob # [ 4.515157] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1738bob # [ 4.515810] systemd[1]: Closed udev Control Socket.1739clare # [ 4.517158] systemd[1]: Starting rw-sysroot-nix-store.service...1740bob # [ 4.519048] systemd[1]: Starting Cleanup udev Database...1741clare # [ 4.519667] systemd[1]: systemd-sysctl.service: Deactivated successfully.1742bob # [ 4.520179] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1743bob # [ 4.524173] systemd[1]: Stopped Create Static Device Nodes in /dev.1744bob # [ 4.524756] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1745bob # [ 4.525465] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1746clare # [ 4.526797] systemd[1]: Stopped Apply Kernel Variables.1747bob # [ 4.526095] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1748bob # [ 4.526693] systemd[1]: Stopped Create List of Static Device Nodes.1749clare # [ 4.527422] systemd[1]: systemd-modules-load.service: Deactivated successfully.1750bob # [ 4.527226] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1751bob # [ 4.527855] systemd[1]: Finished rw-sysroot-nix-store.service.1752clare # [ 4.531787] systemd[1]: Stopped Load Kernel Modules.1753clare # [ 4.532479] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1754clare # [ 4.535024] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1755clare # [ 4.538088] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1756clare # [ 4.539626] systemd[1]: Stopped Create System Files and Directories.1757bob # [ 4.538958] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1758bob # [ 4.539663] systemd[1]: Finished Cleanup udev Database.1759clare # [ 4.541438] systemd[1]: Stopped target Local File Systems.1760clare # [ 4.542783] systemd[1]: Stopped target Preparation for Local File Systems.1761clare # [ 4.544146] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1762bob # [ 4.543788] systemd[1]: Reached target Switch Root.1763bob # [ 4.544981] systemd[1]: Starting NixOS Activation...1764clare # [ 4.547340] systemd[1]: Stopped Coldplug All udev Devices.1765clare # [ 4.547887] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1766clare # [ 4.549078] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1767clare # [ 4.549734] systemd[1]: Stopped Virtual Console Setup.1768clare # [ 4.550230] systemd[1]: initrd-cleanup.service: Deactivated successfully.1769clare # [ 4.551024] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1770clare # [ 4.551625] systemd[1]: systemd-udevd.service: Deactivated successfully.1771clare # [ 4.552299] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1772clare # [ 4.552932] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1773clare # [ 4.553571] systemd[1]: Finished rw-sysroot-nix-store.service.1774clare # [ 4.554103] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1775clare # [ 4.554776] systemd[1]: Closed udev Control Socket.1776clare # [ 4.555284] systemd[1]: Starting Cleanup udev Database...1777clare # [ 4.555789] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1778clare # [ 4.559292] systemd[1]: Stopped Create Static Device Nodes in /dev.1779clare # [ 4.560359] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1780clare # [ 4.564193] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1781clare # [ 4.564953] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1782clare # [ 4.565590] systemd[1]: Stopped Create List of Static Device Nodes.1783clare # [ 4.577010] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1784clare # [ 4.577735] systemd[1]: Finished Cleanup udev Database.1785clare # [ 4.580739] systemd[1]: Reached target Switch Root.1786clare # [ 4.581248] systemd[1]: Starting NixOS Activation...1787bob # [ 4.614860] initrd-nixos-activation-start[174]: booting system configuration /nix/store/xnn913dv5vbwaw6kjszszkc89wy4ryrr-nixos-system-bob-test1788bob # [ 4.641204] initrd-nixos-activation-start[174]: running activation script...1789clare # [ 4.652335] initrd-nixos-activation-start[173]: booting system configuration /nix/store/8bymk31vx2mmv1ipicyvn9gg03cx5h69-nixos-system-clare-test1790clare # [ 4.679670] initrd-nixos-activation-start[173]: running activation script...1791alice # [ 4.764552] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1792alice # [ 4.764644] systemd[1]: Detected virtualization qemu.1793alice # [ 4.764715] systemd[1]: Detected architecture arm64.1794alice # [ 4.764836] systemd[1]: Detected first boot.1795alice # [ 4.776556] systemd[1]: Initializing machine ID from random generator.1796bob # [ 4.856292] initrd-nixos-activation-start[197]: setting up /etc...1797clare # [ 4.915347] initrd-nixos-activation-start[196]: setting up /etc...1798bob # [ 4.958553] initrd-nixos-activation-start[197]: setting up age secrets...1799alice # [ 4.995156] systemd[1]: bpf-restrict-fs: LSM BPF program attached1800clare # [ 5.011583] initrd-nixos-activation-start[196]: setting up age secrets...1801bob # [ 5.046022] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1802bob # [ 5.048164] systemd[1]: Finished NixOS Activation.1803bob # [ 5.049086] systemd[1]: Starting Switch Root...1804bob # [ 5.070129] systemd[1]: Switching root.1805clare # [ 5.072980] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1806clare # [ 5.075378] systemd[1]: Finished NixOS Activation.1807clare # [ 5.076521] systemd[1]: Starting Switch Root...1808clare # [ 5.098235] systemd[1]: Switching root.1809alice # [ 5.176181] systemd[1]: Applying preset policy.1810bob # [ 5.248601] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1811clare # [ 5.272815] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1812alice # [ 5.381730] systemd[1]: Populated /etc with preset unit settings.1813alice # [ 5.616753] systemd[1]: initrd-switch-root.service: Deactivated successfully.1814alice # [ 5.617761] systemd[1]: Stopped initrd-switch-root.service.1815alice # [ 5.619466] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1816alice # [ 5.623151] systemd[1]: Created slice Slice /system/getty.1817alice # [ 5.625220] systemd[1]: Created slice User and Session Slice.1818alice # [ 5.625844] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1819alice # [ 5.626467] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1820alice # [ 5.627075] systemd[1]: Expecting device /dev/hvc0...1821alice # [ 5.627666] systemd[1]: Expecting device /dev/ttyAMA0...1822alice # [ 5.631293] systemd[1]: Reached target Local Encrypted Volumes.1823alice # [ 5.632968] systemd[1]: Stopped target initrd-fs.target.1824alice # [ 5.633486] systemd[1]: Stopped target initrd-root-fs.target.1825alice # [ 5.634092] systemd[1]: Stopped target initrd-switch-root.target.1826alice # [ 5.634696] systemd[1]: Reached target Virtual Machines and Containers.1827alice # [ 5.635301] systemd[1]: Reached target Path Units.1828alice # [ 5.638728] systemd[1]: Reached target Remote File Systems.1829alice # [ 5.639220] systemd[1]: Reached target Slice Units.1830alice # [ 5.641166] systemd[1]: Reached target Swaps.1831alice # [ 5.643464] systemd[1]: Listening on Query the User Interactively for a Password.1832alice # [ 5.646871] systemd[1]: Listening on Process Core Dump Socket.1833alice # [ 5.649402] systemd[1]: Listening on Credential Encryption/Decryption.1834alice # [ 5.651488] systemd[1]: Listening on Factory Reset Management.1835alice # [ 5.653057] systemd[1]: Listening on Hostname Service Socket.1836alice # [ 5.656746] systemd[1]: Starting Journal Log Access Socket...1837alice # [ 5.658333] systemd[1]: Listening on Journal Audit Socket.1838alice # [ 5.661946] systemd[1]: Listening on Console Output Muting Service Socket.1839alice # [ 5.662700] systemd[1]: Listening on Network Management Metrics Varlink Socket.1840alice # [ 5.663497] systemd[1]: Listening on Network Management Varlink Socket.1841alice # [ 5.666522] systemd[1]: Listening on Network Management Netlink Socket.1842alice # [ 5.668512] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1843alice # [ 5.669518] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1844alice # [ 5.669983] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1845alice # [ 5.676293] systemd[1]: Listening on Disk Repartitioning Service Socket.1846alice # [ 5.676881] systemd[1]: Listening on Resolve Monitor Varlink Socket.1847alice # [ 5.677459] systemd[1]: Listening on Resolve Service Varlink Socket.1848alice # [ 5.678063] systemd[1]: Listening on udev Control Socket.1849alice # [ 5.678668] systemd[1]: Listening on udev Varlink Socket.1850alice # [ 5.683575] systemd[1]: Mounting Huge Pages File System...1851alice # [ 5.686579] systemd[1]: Mounting POSIX Message Queue File System...1852alice # [ 5.696162] systemd[1]: Mounting Kernel Debug File System...1853alice # [ 5.703543] systemd[1]: Mounting Kernel Trace File System...1854alice # [ 5.716468] systemd[1]: Starting Create List of Static Device Nodes...1855alice # [ 5.720311] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1856alice # [ 5.731355] systemd[1]: Mounting Kernel Configuration File System...1857alice # [ 5.733998] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1858alice # [ 5.740277] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1859alice # [ 5.740814] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1860alice # [ 5.763084] systemd[1]: Mounting FUSE Control File System...1861alice # [ 5.763564] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671862alice # [ 5.789853] systemd[1]: Starting Journal Service...1863alice # [ 5.808671] systemd[1]: Starting Load Kernel Modules...1864alice # [ 5.818300] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1865clare # [ 5.799902] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1866clare # [ 5.800062] systemd[1]: Detected virtualization qemu.1867clare # [ 5.800208] systemd[1]: Detected architecture arm64.1868clare # [ 5.812451] systemd[1]: Detected first boot.1869clare # [ 5.818026] systemd[1]: Initializing machine ID from random generator.1870alice # [ 5.843987] systemd[1]: Starting Remount Root and Kernel File Systems...1871alice # [ 5.844466] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1872alice # [ 5.856638] systemd[1]: Starting Coldplug All udev Devices...1873alice # [ 5.859166] systemd[1]: Listening on Journal Log Access Socket.1874alice # [ 5.859593] systemd[1]: Mounted Huge Pages File System.1875bob # [ 5.842913] systemd[1]: systemd 261.3 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1876bob # [ 5.843197] systemd[1]: Detected virtualization qemu.1877bob # [ 5.843928] systemd[1]: Detected architecture arm64.1878bob # [ 5.844797] systemd[1]: Detected first boot.1879alice # [ 5.876151] systemd[1]: Mounted POSIX Message Queue File System.1880alice # [ 5.876810] systemd[1]: Mounted Kernel Debug File System.1881bob # [ 5.863906] systemd[1]: Initializing machine ID from random generator.1882alice # [ 5.877208] systemd[1]: Mounted Kernel Trace File System.1883alice # [ 5.881970] systemd-journald[282]: Collecting audit messages is enabled.1884alice # [ 5.879232] systemd[1]: Queued start job for default target Multi-User System.1885alice # [ 5.889197] systemd[1]: Finished Create List of Static Device Nodes.1886alice # [ 5.889833] systemd[1]: Started Journal Service.1887alice # [ 5.889387] systemd[1]: systemd-journald.service: Deactivated successfully.1888alice # [ 5.901592] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1889alice # [ 5.926673] systemd-modules-load[283]: Module 'atkbd' is built in1890alice # [ 5.931052] systemd-modules-load[283]: Module 'loop' is built in1891alice # [ 5.933286] systemd-oomd[285]: No swap; memory pressure usage will be degraded1892alice # [ 5.940431] systemd[1]: Finished Load Kernel Modules.1893alice # [ 5.944136] systemd[1]: Starting Firewall...1894alice # [ 5.958656] systemd[1]: Starting Apply Kernel Variables...1895alice # [ 5.959252] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1896alice # [ 5.973934] systemd[1]: Mounted Kernel Configuration File System.1897alice # [ 5.980650] EXT4-fs (vda): re-mounted 5ea69935-7a05-4fd9-9dea-02574aa75611.1898clare # [ 5.976339] systemd[1]: bpf-restrict-fs: LSM BPF program attached1899alice # [ 5.992458] systemd[1]: Finished Remount Root and Kernel File Systems.1900alice # [ 5.993117] systemd[1]: Listening on Disk Image Download Service Socket.1901alice # [ 5.998570] systemd[1]: Starting Flush Journal to Persistent Storage...1902alice # [ 5.999223] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1903bob # [ 5.997464] systemd[1]: bpf-restrict-fs: LSM BPF program attached1904alice # [ 6.005841] systemd[1]: Starting Load/Save OS Random Seed...1905alice # [ 6.006418] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1906alice # [ 6.007173] systemd[1]: Mounted FUSE Control File System.1907alice # [ 6.071630] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1908alice # [ 6.082293] systemd-journald[282]: Received client request to flush runtime journal.1909bob # [ 6.081013] systemd[1]: Applying preset policy.1910clare # [ 6.124818] systemd[1]: Applying preset policy.1911alice # [ 6.160476] systemd[1]: Starting Create Static Device Nodes in /dev...1912alice # [ 6.164549] systemd[1]: Finished Load/Save OS Random Seed.1913alice # [ 6.165131] systemd[1]: Reached target First Boot Complete.1914alice # [ 6.165672] systemd[1]: Finished Apply Kernel Variables.1915alice # [ 6.166182] systemd[1]: Starting Network Name Resolution...1916alice # [ 6.172594] systemd[1]: Finished Flush Journal to Persistent Storage.1917bob # [ 6.248714] systemd[1]: Populated /etc with preset unit settings.1918clare # [ 6.284777] systemd[1]: Populated /etc with preset unit settings.1919alice # [ 6.320817] systemd-resolved[312]: Positive Trust Anchors:1920alice # [ 6.321427] systemd-resolved[312]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1921alice # [ 6.322331] systemd-resolved[312]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161922alice # [ 6.323213] systemd-resolved[312]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1923alice # [ 6.366097] systemd[1]: Finished Create Static Device Nodes in /dev.1924alice # [ 6.367197] systemd[1]: Reached target Preparation for Local File Systems.1925alice # [ 6.367861] systemd[1]: Starting Rule-based Manager for Device Events and Files...1926bob # [ 6.469820] systemd[1]: initrd-switch-root.service: Deactivated successfully.1927bob # [ 6.471732] systemd[1]: Stopped initrd-switch-root.service.1928bob # [ 6.473535] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1929alice # [ 6.482408] systemd[1]: Finished Coldplug All udev Devices.1930bob # [ 6.476200] systemd[1]: Created slice Slice /system/getty.1931bob # [ 6.477185] systemd[1]: Created slice User and Session Slice.1932bob # [ 6.477761] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1933bob # [ 6.480387] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1934bob # [ 6.480909] systemd[1]: Expecting device /dev/hvc0...1935bob # [ 6.481463] systemd[1]: Expecting device /dev/ttyAMA0...1936bob # [ 6.482012] systemd[1]: Reached target Local Encrypted Volumes.1937alice # [ 6.491113] systemd-resolved[312]: Using system hostname 'alice'.1938bob # [ 6.484998] systemd[1]: Stopped target initrd-fs.target.1939bob # [ 6.485474] systemd[1]: Stopped target initrd-root-fs.target.1940bob # [ 6.486008] systemd[1]: Stopped target initrd-switch-root.target.1941alice # [ 6.494842] systemd[1]: Started Network Name Resolution.1942bob # [ 6.488434] systemd[1]: Reached target Virtual Machines and Containers.1943bob # [ 6.488923] systemd[1]: Reached target Path Units.1944bob # [ 6.489456] systemd[1]: Reached target Remote File Systems.1945bob # [ 6.489997] systemd[1]: Reached target Slice Units.1946bob # [ 6.492780] systemd[1]: Reached target Swaps.1947bob # [ 6.495207] systemd[1]: Listening on Query the User Interactively for a Password.1948bob # [ 6.497287] systemd[1]: Listening on Process Core Dump Socket.1949bob # [ 6.499958] systemd[1]: Listening on Credential Encryption/Decryption.1950bob # [ 6.501700] systemd[1]: Listening on Factory Reset Management.1951alice # [ 6.508917] systemd-udevd[320]: Using default interface naming scheme 'v261'.1952bob # [ 6.502264] systemd[1]: Listening on Hostname Service Socket.1953clare # [ 6.505491] systemd[1]: initrd-switch-root.service: Deactivated successfully.1954bob # [ 6.506258] systemd[1]: Starting Journal Log Access Socket...1955clare # [ 6.506135] systemd[1]: Stopped initrd-switch-root.service.1956clare # [ 6.509700] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1957bob # [ 6.507786] systemd[1]: Listening on Journal Audit Socket.1958bob # [ 6.509940] systemd[1]: Listening on Console Output Muting Service Socket.1959clare # [ 6.512121] systemd[1]: Created slice Slice /system/getty.1960clare # [ 6.513128] systemd[1]: Created slice User and Session Slice.1961bob # [ 6.511567] systemd[1]: Listening on Network Management Metrics Varlink Socket.1962clare # [ 6.513693] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1963bob # [ 6.512315] systemd[1]: Listening on Network Management Varlink Socket.1964clare # [ 6.514281] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1965bob # [ 6.512956] systemd[1]: Listening on Network Management Netlink Socket.1966bob # [ 6.513657] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1967bob # [ 6.514195] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1968clare # [ 6.517461] systemd[1]: Expecting device /dev/hvc0...1969clare # [ 6.517927] systemd[1]: Expecting device /dev/ttyAMA0...1970bob # [ 6.518227] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1971clare # [ 6.519777] systemd[1]: Reached target Local Encrypted Volumes.1972clare # [ 6.520256] systemd[1]: Stopped target initrd-fs.target.1973clare # [ 6.520805] systemd[1]: Stopped target initrd-root-fs.target.1974clare # [ 6.521367] systemd[1]: Stopped target initrd-switch-root.target.1975clare # [ 6.521924] systemd[1]: Reached target Virtual Machines and Containers.1976clare # [ 6.525243] systemd[1]: Reached target Path Units.1977clare # [ 6.525721] systemd[1]: Reached target Remote File Systems.1978bob # [ 6.523678] systemd[1]: Listening on Disk Repartitioning Service Socket.1979clare # [ 6.526257] systemd[1]: Reached target Slice Units.1980bob # [ 6.524207] systemd[1]: Listening on Resolve Monitor Varlink Socket.1981bob # [ 6.524741] systemd[1]: Listening on Resolve Service Varlink Socket.1982bob # [ 6.525290] systemd[1]: Listening on udev Control Socket.1983bob # [ 6.525835] systemd[1]: Listening on udev Varlink Socket.1984clare # [ 6.528513] systemd[1]: Reached target Swaps.1985clare # [ 6.530960] systemd[1]: Listening on Query the User Interactively for a Password.1986clare # [ 6.533084] systemd[1]: Listening on Process Core Dump Socket.1987bob # [ 6.530609] systemd[1]: Mounting Huge Pages File System...1988bob # [ 6.532629] systemd[1]: Mounting POSIX Message Queue File System...1989clare # [ 6.535778] systemd[1]: Listening on Credential Encryption/Decryption.1990clare # [ 6.537611] systemd[1]: Listening on Factory Reset Management.1991clare # [ 6.538144] systemd[1]: Listening on Hostname Service Socket.1992clare # [ 6.542173] systemd[1]: Starting Journal Log Access Socket...1993clare # [ 6.544462] systemd[1]: Listening on Journal Audit Socket.1994clare # [ 6.546816] systemd[1]: Listening on Console Output Muting Service Socket.1995clare # [ 6.547418] systemd[1]: Listening on Network Management Metrics Varlink Socket.1996clare # [ 6.547916] systemd[1]: Listening on Network Management Varlink Socket.1997clare # [ 6.548341] systemd[1]: Listening on Network Management Netlink Socket.1998bob # [ 6.546956] systemd[1]: Mounting Kernel Debug File System...1999clare # [ 6.548810] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.2000bob # [ 6.548927] systemd[1]: Mounting Kernel Trace File System...2001clare # [ 6.549111] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os2002clare # [ 6.549394] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki2003alice # [ 6.558567] systemd[1]: Started Rule-based Manager for Device Events and Files.2004clare # [ 6.558559] systemd[1]: Listening on Disk Repartitioning Service Socket.2005clare # [ 6.559086] systemd[1]: Listening on Resolve Monitor Varlink Socket.2006clare # [ 6.559601] systemd[1]: Listening on Resolve Service Varlink Socket.2007clare # [ 6.560125] systemd[1]: Listening on udev Control Socket.2008bob # [ 6.561504] systemd[1]: Starting Create List of Static Device Nodes...2009clare # [ 6.560681] systemd[1]: Listening on udev Varlink Socket.2010bob # [ 6.561915] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2011clare # [ 6.565158] systemd[1]: Mounting Huge Pages File System...2012clare # [ 6.568227] systemd[1]: Mounting POSIX Message Queue File System...2013bob # [ 6.572608] systemd[1]: Mounting Kernel Configuration File System...2014bob # [ 6.572970] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2015bob # [ 6.573247] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2016bob # [ 6.573507] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2017clare # [ 6.582238] systemd[1]: Mounting Kernel Debug File System...2018clare # [ 6.587718] systemd[1]: Mounting Kernel Trace File System...2019clare # [ 6.592049] systemd[1]: Starting Create List of Static Device Nodes...2020bob # [ 6.591098] systemd[1]: Mounting FUSE Control File System...2021bob # [ 6.591814] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672022clare # [ 6.595069] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2023clare # [ 6.606754] systemd[1]: Mounting Kernel Configuration File System...2024clare # [ 6.607182] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2025alice # [ 6.618196] systemd[1]: Mounting /run/wrappers...2026clare # [ 6.611981] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2027clare # [ 6.612604] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2028clare # [ 6.624665] systemd[1]: Mounting FUSE Control File System...2029clare # [ 6.625128] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672030bob # [ 6.622621] systemd[1]: Starting Journal Service...2031bob # [ 6.634606] systemd[1]: Starting Load Kernel Modules...2032bob # [ 6.645696] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2033clare # [ 6.647232] systemd[1]: Starting Journal Service...2034bob # [ 6.656180] systemd[1]: Starting Remount Root and Kernel File Systems...2035bob # [ 6.656561] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2036clare # [ 6.662172] systemd[1]: Starting Load Kernel Modules...2037alice # [ 6.683862] systemd[1]: Mounted /run/wrappers.2038alice # [ 6.684530] systemd[1]: Reached target Local File Systems.2039bob # [ 6.674602] systemd[1]: Starting Coldplug All udev Devices...2040bob # [ 6.676729] systemd[1]: Listening on Journal Log Access Socket.2041bob # [ 6.677130] systemd[1]: Mounted Huge Pages File System.2042bob # [ 6.677487] systemd[1]: Mounted POSIX Message Queue File System.2043bob # [ 6.677821] systemd[1]: Mounted Kernel Debug File System.2044bob # [ 6.678152] systemd[1]: Mounted Kernel Trace File System.2045alice # [ 6.688883] systemd[1]: Listening on Boot Loader Control Service Socket.2046alice # [ 6.694028] systemd[1]: Starting register-nix-paths.service...2047clare # [ 6.689188] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2048alice # [ 6.698248] systemd[1]: Starting Create SUID/SGID Wrappers...2049alice # [ 6.699427] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2050clare # [ 6.698769] systemd[1]: Starting Remount Root and Kernel File Systems...2051clare # [ 6.699162] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2052alice # [ 6.707841] systemd[1]: Starting Save Transient machine-id to Disk...2053bob # [ 6.703561] systemd[1]: Finished Create List of Static Device Nodes.2054alice # [ 6.716182] systemd[1]: Starting Create System Files and Directories...2055bob # [ 6.704151] systemd[1]: Mounted Kernel Configuration File System.2056bob # [ 6.707721] systemd-journald[290]: Collecting audit messages is enabled.2057alice # [ 6.716813] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2058clare # [ 6.714055] systemd[1]: Starting Coldplug All udev Devices...2059bob # [ 6.718272] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2060clare # [ 6.720188] systemd[1]: Listening on Journal Log Access Socket.2061clare # [ 6.720679] systemd[1]: Mounted Huge Pages File System.2062clare # [ 6.721139] systemd[1]: Mounted Kernel Debug File System.2063clare # [ 6.729467] systemd[1]: Finished Create List of Static Device Nodes.2064clare # [ 6.730008] systemd[1]: Mounted POSIX Message Queue File System.2065bob # [ 6.723647] systemd[1]: Queued start job for default target Multi-User System.2066bob # [ 6.724780] systemd[1]: systemd-journald.service: Deactivated successfully.2067bob # [ 6.725662] systemd-modules-load[291]: Module 'atkbd' is built in2068bob # [ 6.726349] systemd-modules-load[291]: Module 'loop' is built in2069clare # [ 6.733886] systemd-journald[281]: Collecting audit messages is enabled.2070bob # [ 6.734075] systemd[1]: Started Journal Service.2071alice # [ 6.744685] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2072clare # [ 6.744824] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2073bob # [ 6.741158] systemd[1]: Finished Load Kernel Modules.2074clare # [ 6.746712] systemd[1]: Queued start job for default target Multi-User System.2075clare # [ 6.748481] systemd[1]: systemd-journald.service: Deactivated successfully.2076clare # [ 6.749369] systemd-modules-load[282]: Module 'atkbd' is built in2077clare # [ 6.750016] systemd-modules-load[282]: Module 'loop' is built in2078clare # [ 6.758854] systemd[1]: Finished Load Kernel Modules.2079clare # [ 6.759363] systemd[1]: Started Journal Service.2080bob # [ 6.759382] systemd[1]: Starting Firewall...2081bob # [ 6.762472] systemd[1]: Starting Apply Kernel Variables...2082clare # [ 6.764259] systemd[1]: Mounted Kernel Trace File System.2083clare # [ 6.786659] systemd[1]: Starting Firewall...2084bob # [ 6.797038] systemd[1]: Mounted FUSE Control File System.2085clare # [ 6.801945] systemd[1]: Starting Apply Kernel Variables...2086clare # [ 6.821103] EXT4-fs (vda): re-mounted 3317e99a-9d03-426d-9dd0-980aa506fcea.2087clare # [ 6.819967] systemd[1]: Mounted Kernel Configuration File System.2088bob # [ 6.824358] systemd-oomd[292]: No swap; memory pressure usage will be degraded2089bob # [ 6.831247] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2090bob # [ 6.834523] EXT4-fs (vda): re-mounted 9a85103c-e61a-45f1-815c-081cff456cc0.2091clare # [ 6.834329] systemd[1]: Finished Remount Root and Kernel File Systems.2092clare # [ 6.834983] systemd[1]: Listening on Disk Image Download Service Socket.2093alice # [ 6.851706] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2094bob # [ 6.840558] systemd[1]: Finished Remount Root and Kernel File Systems.2095clare # [ 6.842262] systemd[1]: Starting Flush Journal to Persistent Storage...2096bob # [ 6.841468] systemd[1]: Listening on Disk Image Download Service Socket.2097clare # [ 6.842926] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2098alice # [ 6.858282] systemd[1]: Finished Save Transient machine-id to Disk.2099clare # [ 6.852148] systemd[1]: Starting Load/Save OS Random Seed...2100clare # [ 6.852771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2101bob # [ 6.854335] systemd[1]: Starting Flush Journal to Persistent Storage...2102clare # [ 6.856189] systemd[1]: Mounted FUSE Control File System.2103bob # [ 6.854967] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2104clare # [ 6.860405] systemd-oomd[283]: No swap; memory pressure usage will be degraded2105bob # [ 6.865844] systemd[1]: Starting Load/Save OS Random Seed...2106bob # [ 6.866405] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2107alice # [ 6.894311] systemd[1]: Finished Create System Files and Directories.2108clare # [ 6.884452] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2109clare # [ 6.916302] systemd-journald[281]: Received client request to flush runtime journal.2110bob # [ 6.914847] systemd[1]: Finished Apply Kernel Variables.2111alice # [ 6.931221] systemd[1]: Starting Rebuild Journal Catalog...2112bob # [ 6.929017] systemd-journald[290]: Received client request to flush runtime journal.2113alice # [ 6.938460] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2114clare # [ 6.964459] systemd[1]: Finished Load/Save OS Random Seed.2115clare # [ 6.965066] systemd[1]: Reached target First Boot Complete.2116clare # [ 6.967499] systemd[1]: Finished Flush Journal to Persistent Storage.2117clare # [ 6.981860] systemd[1]: Finished Apply Kernel Variables.2118clare # [ 6.984809] systemd[1]: Starting Network Name Resolution...2119bob # [ 6.984580] systemd[1]: Starting Network Name Resolution...2120bob # [ 6.987478] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2121bob # [ 6.990362] systemd[1]: Finished Load/Save OS Random Seed.2122bob # [ 6.990900] systemd[1]: Reached target First Boot Complete.2123bob # [ 6.991395] systemd[1]: Starting Create Static Device Nodes in /dev...2124bob # [ 6.997104] systemd[1]: Finished Flush Journal to Persistent Storage.2125clare # [ 6.999512] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2126clare # [ 7.004961] systemd[1]: Starting Create Static Device Nodes in /dev...2127alice # [ 7.048765] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2128alice # [ 7.066842] systemd[1]: Finished Rebuild Journal Catalog.2129alice # [ 7.074911] systemd[1]: Starting Update is Completed...2130alice # [ 7.093325] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2131bob # [ 7.102581] systemd-resolved[316]: Positive Trust Anchors:2132bob # [ 7.103166] systemd-resolved[316]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2133bob # [ 7.104389] systemd-resolved[316]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162134bob # [ 7.105246] 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 test2135alice # [ 7.122181] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2136clare # [ 7.144790] systemd-resolved[312]: Positive Trust Anchors:2137clare # [ 7.145396] systemd-resolved[312]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2138clare # [ 7.146282] systemd-resolved[312]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162139clare # [ 7.147175] systemd-resolved[312]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test2140alice # [ 7.185788] systemd[1]: Finished Update is Completed.2141bob # [ 7.231957] systemd[1]: Finished Create Static Device Nodes in /dev.2142bob # [ 7.232642] systemd[1]: Reached target Preparation for Local File Systems.2143bob # [ 7.240752] systemd[1]: Starting Rule-based Manager for Device Events and Files...2144clare # [ 7.271461] systemd[1]: Finished Create Static Device Nodes in /dev.2145clare # [ 7.272145] systemd[1]: Reached target Preparation for Local File Systems.2146clare # [ 7.280192] systemd[1]: Starting Rule-based Manager for Device Events and Files...2147bob # [ 7.295145] systemd-resolved[316]: Using system hostname 'bob'.2148bob # [ 7.296256] systemd[1]: Finished Coldplug All udev Devices.2149bob # [ 7.299216] systemd[1]: Started Network Name Resolution.2150clare # [ 7.325436] systemd[1]: Finished Coldplug All udev Devices.2151clare # [ 7.326783] systemd-resolved[312]: Using system hostname 'clare'.2152clare # [ 7.331096] systemd[1]: Started Network Name Resolution.2153bob # [ 7.335164] systemd-udevd[329]: Using default interface naming scheme 'v261'.2154clare # [ 7.365339] systemd-udevd[323]: Using default interface naming scheme 'v261'.2155alice # [ 7.387179] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.2156alice # [ 7.391887] (udev-worker)[346]: Network interface NamePolicy= disabled on kernel command line.2157bob # [ 7.388128] systemd[1]: Started Rule-based Manager for Device Events and Files.2158clare # [ 7.416140] systemd[1]: Started Rule-based Manager for Device Events and Files.2159bob # [ 7.467550] systemd[1]: Mounting /run/wrappers...2160clare # [ 7.504823] systemd[1]: Mounting /run/wrappers...2161bob # [ 7.512160] systemd[1]: Mounted /run/wrappers.2162bob # [ 7.514438] systemd[1]: Reached target Local File Systems.2163bob # [ 7.516681] systemd[1]: Listening on Boot Loader Control Service Socket.2164bob # [ 7.521281] systemd[1]: Starting register-nix-paths.service...2165bob # [ 7.525892] systemd[1]: Starting Create SUID/SGID Wrappers...2166bob # [ 7.527082] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2167bob # [ 7.530349] systemd[1]: Starting Save Transient machine-id to Disk...2168bob # [ 7.541471] systemd[1]: Starting Create System Files and Directories...2169bob # [ 7.542091] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2170clare # [ 7.542846] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2171clare # [ 7.551643] systemd[1]: Mounted /run/wrappers.2172clare # [ 7.552830] systemd[1]: Reached target Local File Systems.2173clare # [ 7.556537] systemd[1]: Listening on Boot Loader Control Service Socket.2174clare # [ 7.561241] systemd[1]: Starting register-nix-paths.service...2175clare # [ 7.565606] systemd[1]: Starting Create SUID/SGID Wrappers...2176clare # [ 7.566193] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2177clare # [ 7.569698] systemd[1]: Starting Save Transient machine-id to Disk...2178bob # [ 7.569094] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2179alice # [ 7.585140] systemd[1]: Finished register-nix-paths.service.2180clare # [ 7.579701] systemd[1]: Starting Create System Files and Directories...2181clare # [ 7.581069] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse2182alice # [ 7.592518] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2183alice # [ 7.594003] systemd[1]: Finished Create SUID/SGID Wrappers.2184alice # [ 7.596347] systemd[1]: Reached target System Initialization.2185alice # [ 7.599594] systemd[1]: Started Discard unused filesystem blocks once a week.2186alice # [ 7.603775] systemd[1]: Started Daily Cleanup of Temporary Directories.[ 7.608230] mousedev: PS/2 mouse device common for all mice2187alice # 2188alice # [ 7.606187] systemd[1]: Reached target Timer Units.2189alice # [ 7.606695] systemd[1]: Listening on D-Bus System Message Bus Socket.2190alice # [ 7.607275] systemd[1]: Listening on Nix Daemon Socket.2191alice # [ 7.607748] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2192alice # [ 7.616269] systemd[1]: Reached target Socket Units.2193alice # [ 7.616777] systemd[1]: Reached target Basic System.2194alice # [ 7.617256] systemd[1]: Started backdoor.service.2195alice # [ 7.617716] systemd[1]: Starting Import lastlog data into lastlog2 database...2196alice # [ 7.618339] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2197alice # [ 7.625859] systemd[1]: Starting Post-Boot Actions...2198bob # [ 7.625107] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2199bob # [ 7.629086] systemd[1]: Finished Save Transient machine-id to Disk.2200alice # [ 7.659138] systemd[1]: Started Reset console on configuration changes.2201alice # [ 7.689762] systemd[1]: Starting D-Bus System Message Bus...2202clare # [ 7.683550] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2203clare # [ 7.691757] systemd[1]: Finished Save Transient machine-id to Disk.2204bob # [ 7.708818] systemd[1]: Finished Create System Files and Directories.2205bob # [ 7.718630] systemd[1]: Starting Rebuild Journal Catalog...2206bob # [ 7.724632] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2207alice # [ 7.746271] systemd[1]: Finished Post-Boot Actions.2208alice # connecting to host...2209clare # [ 7.752578] systemd[1]: Finished Create System Files and Directories.2210clare # [ 7.760511] systemd[1]: Starting Rebuild Journal Catalog...2211clare # [ 7.767266] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2212alice # [ 7.779454] systemd[1]: Started Name Service Cache Daemon (nsncd).2213alice # [ 7.783081] systemd[1]: Reached target Host and Network Name Lookups.2214alice # [ 7.783680] systemd[1]: Reached target User and Group Name Lookups.2215alice # [ 7.788779] nsncd[469]: Oct 04 15:27:19.625 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2216alice # [ 7.798890] systemd[1]: Starting User Login Management...2217alice # [ 7.817347] systemd[1]: Finished Import lastlog data into lastlog2 database.2218bob # [ 7.824174] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2219clare # [ 7.845147] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2220bob # [ 7.858158] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2221clare # [ 7.865641] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2222bob # [ 7.864912] systemd[1]: Finished Rebuild Journal Catalog.2223bob # [ 7.871576] systemd[1]: Starting Update is Completed...2224clare # [ 7.891016] systemd[1]: Finished Rebuild Journal Catalog.2225alice # [ 7.904390] dbus-broker-launch[475]: Looking up NSS user entry for 'systemd-timesync'...2226clare # [ 7.896197] systemd[1]: Starting Update is Completed...2227alice # [ 7.915046] systemd-logind[493]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2228alice # [ 7.918515] systemd-logind[493]: Watching system buttons on /dev/input/event0 (gpio-keys)2229alice # [ 7.920833] dbus-broker-launch[475]: NSS returned no entry for 'systemd-timesync'2230bob # [ 7.909636] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2231alice # [ 7.921437] dbus-broker-launch[475]: Invalid user-name in /nix/store/b1fb9lxs8ykr9ig9ywgxry5j83pbx1i1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2232alice # [ 7.922764] systemd-logind[493]: New seat seat0.2233alice # [ 7.930416] systemd[1]: Started User Login Management.2234alice # [ 7.930934] systemd[1]: Starting linger-users.service...2235clare # [ 7.943316] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2236alice # [ 7.957724] systemd[1]: Started D-Bus System Message Bus.2237bob # [ 7.962767] systemd[1]: Finished Update is Completed.2238clare # [ 7.981092] systemd[1]: Finished Update is Completed.2239alice # [ 7.994928] dbus-broker-launch[475]: Ready2240alice # [ 8.004286] systemd[1]: linger-users.service: Deactivated successfully.2241alice # [ 8.006536] systemd[1]: Finished linger-users.service.2242bob # [ 8.109303] (udev-worker)[355]: Network interface NamePolicy= disabled on kernel command line.2243alice # [ 8.124761] systemd[1]: Finished Firewall.2244bob # [ 8.113208] (udev-worker)[353]: Network interface NamePolicy= disabled on kernel command line.2245alice # [ 8.126129] systemd[1]: Reached target Preparation for Network.2246alice # [ 8.129396] systemd[1]: Listening on Network Management Resolve Hook Socket.2247alice # [ 8.134177] systemd[1]: Starting Network Management...2248clare # [ 8.141473] (udev-worker)[351]: Network interface NamePolicy= disabled on kernel command line.2249clare # [ 8.148672] (udev-worker)[343]: Network interface NamePolicy= disabled on kernel command line.2250alice # [ 8.311681] cfg80211: Loading compiled-in X.509 certificates for regulatory database2251alice # [ 8.359358] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2252alice # [ 8.360400] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2253alice # [ 8.362420] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22254alice # [ 8.362807] cfg80211: failed to load regulatory.db2255bob # [ 8.357407] systemd[1]: Finished register-nix-paths.service.2256bob # [ 8.368264] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2257bob # [ 8.370628] systemd[1]: Finished Create SUID/SGID Wrappers.2258alice # [ 8.384933] systemd-networkd[538]: lo: Link UP2259alice # [ 8.385420] systemd-networkd[538]: lo: Gained carrier2260bob # [ 8.374401] systemd[1]: Reached target System Initialization.2261bob # [ 8.374979] systemd[1]: Started Discard unused filesystem blocks once a week.2262bob # [ 8.375593] systemd[1]: Started Daily Cleanup of Temporary Directories.2263bob # [ 8.378176] systemd[1]: Reached target Timer Units.2264bob # [ 8.378639] systemd[1]: Listening on D-Bus System Message Bus Socket.2265bob # [ 8.379205] systemd[1]: Listening on Nix Daemon Socket.2266bob # [ 8.379675] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2267alice # [ 8.393842] systemd-networkd[538]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2268alice # [ 8.394724] systemd[1]: Started Network Management.2269bob # [ 8.384795] systemd[1]: Reached target Socket Units.2270bob # [ 8.385287] systemd[1]: Reached target Basic System.2271bob # [ 8.385768] systemd[1]: Started backdoor.service.2272clare # [ 8.393126] mousedev: PS/2 mouse device common for all mice2273alice # [ 8.401199] systemd[1]: Reached target Network.2274bob # [ 8.390545] systemd[1]: Starting Import lastlog data into lastlog2 database...2275alice # [ 8.402519] systemd-networkd[538]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2276alice # [ 8.409715] systemd-networkd[538]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2277alice # [ 8.410433] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2278alice # [ 8.411025] systemd-networkd[538]: eth0: Link UP2279alice # [ 8.411450] systemd-networkd[538]: eth0: Gained carrier2280bob # [ 8.399450] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2281clare # [ 8.408495] systemd[1]: Finished register-nix-paths.service.2282clare # [ 8.409850] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2283alice # [ 8.421353] systemd[1]: Starting Permit User Sessions...2284alice # [ 8.421896] systemd-networkd[538]: eth1: Link UP2285alice # [ 8.422304] systemd-networkd[538]: eth1: Gained carrier2286clare # [ 8.411501] systemd[1]: Finished Create SUID/SGID Wrappers.2287alice # [ 8.422743] systemd-networkd[538]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2288bob # [ 8.412504] systemd[1]: Starting Post-Boot Actions...2289clare # [ 8.415623] systemd[1]: Reached target System Initialization.2290clare # [ 8.416511] systemd[1]: Started Discard unused filesystem blocks once a week.2291clare # [ 8.417144] systemd[1]: Started Daily Cleanup of Temporary Directories.2292clare # [ 8.417730] systemd[1]: Reached target Timer Units.2293clare # [ 8.418197] systemd[1]: Listening on D-Bus System Message Bus Socket.2294alice # [ 8.434203] systemd-networkd[538]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22295clare # [ 8.425735] systemd[1]: Listening on harmonia binary cache socket.2296clare # [ 8.426335] systemd[1]: Listening on Nix Daemon Socket.2297clare # [ 8.426914] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2298clare # [ 8.427633] systemd[1]: Reached target Socket Units.2299bob # [ 8.429976] systemd[1]: Started Reset console on configuration changes.2300clare # [ 8.432643] systemd[1]: Reached target Basic System.2301clare # [ 8.433193] systemd[1]: Started backdoor.service.2302clare # [ 8.433615] systemd[1]: Starting Import lastlog data into lastlog2 database...2303clare # [ 8.440169] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2304clare # [ 8.447561] systemd[1]: Starting Post-Boot Actions...2305clare # [ 8.455815] systemd[1]: Started Reset console on configuration changes.2306bob # [ 8.462081] systemd[1]: Starting D-Bus System Message Bus...2307alice # [ 8.485188] systemd[1]: Finished Permit User Sessions.2308clare # [ 8.477567] systemd[1]: Starting D-Bus System Message Bus...2309alice # [ 8.491059] systemd[1]: Started Getty on tty1.2310bob # [ 8.483818] mousedev: PS/2 mouse device common for all mice2311alice # [ 8.493464] systemd[1]: Reached target Login Prompts.2312alice # [ 8.498563] systemd[1]: Reached target Multi-User System.2313alice # [ 8.502653] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2314bob # connecting to host...2315alice # [ 8.517979] systemd[1]: Startup finished in 708ms (kernel) + 3.627s (initrd) + 4.181s (userspace) = 8.517s.2316bob # [ 8.533382] systemd[1]: Finished Post-Boot Actions.2317clare # [ 8.565702] systemd[1]: Finished Post-Boot Actions.2318bob # [ 8.567653] systemd[1]: Started Name Service Cache Daemon (nsncd).2319bob # [ 8.568368] systemd[1]: Reached target Host and Network Name Lookups.2320bob # [ 8.568917] systemd[1]: Reached target User and Group Name Lookups.2321bob # [ 8.576571] nsncd[479]: Oct 04 15:27:20.398 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2322clare # [ 8.579123] systemd[1]: Started Name Service Cache Daemon (nsncd).2323bob: Guest shell says: b'Spawning backdoor root shell...\n'2324bob # [ 8.581597] systemd[1]: Starting User Login Management...2325clare # [ 8.579755] systemd[1]: Reached target Host and Network Name Lookups.2326clare # [ 8.583781] systemd[1]: Reached target User and Group Name Lookups.2327clare # [ 8.584607] nsncd[471]: Oct 04 15:27:20.402 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2328clare # connecting to host...2329clare # [ 8.597472] systemd[1]: Starting User Login Management...2330bob # [ 8.604346] systemd[1]: Finished Import lastlog data into lastlog2 database.2331clare # [ 8.635404] systemd[1]: Finished Import lastlog data into lastlog2 database.2332alice # [ 8.677158] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32333bob # [ 8.693775] systemd-logind[500]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2334bob # [ 8.696511] systemd-logind[500]: Watching system buttons on /dev/input/event0 (gpio-keys)2335bob: connected to guest root shell2336bob # [ 8.698264] systemd-logind[500]: New seat seat0.2337bob: (connecting took 8.97 seconds)2338bob # [ 8.701960] systemd[1]: Started User Login Management.2339bob: (finished: waiting for the VM to finish booting, in 8.97 seconds)2340bob # [ 8.703785] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'...2341clare # [ 8.708453] dbus-broker-launch[475]: Looking up NSS user entry for 'systemd-timesync'...2342bob # [ 8.709604] systemd[1]: Starting linger-users.service...2343clare # [ 8.718112] dbus-broker-launch[475]: NSS returned no entry for 'systemd-timesync'2344clare # [ 8.718853] dbus-broker-launch[475]: Invalid user-name in /nix/store/adj0502s0rji8cqpinaag61h2xhajgmv-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2345bob # [ 8.727413] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync'2346bob # [ 8.729420] dbus-broker-launch[484]: Invalid user-name in /nix/store/0avqdcl9fwdl570wq2rf6s7lwamv4l0n-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2347clare # [ 8.733063] systemd-logind[495]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2348clare # [ 8.735288] systemd-logind[495]: Watching system buttons on /dev/input/event0 (gpio-keys)2349clare # [ 8.736793] systemd-logind[495]: New seat seat0.2350clare # [ 8.741068] systemd[1]: Started User Login Management.2351clare # [ 8.743769] systemd[1]: Starting linger-users.service...2352bob # [ 8.758221] systemd[1]: Started D-Bus System Message Bus.2353clare # [ 8.761051] systemd[1]: Started D-Bus System Message Bus.2354bob # [ 8.780422] systemd[1]: linger-users.service: Deactivated successfully.2355bob # [ 8.781030] systemd[1]: Finished linger-users.service.2356clare # [ 8.794911] dbus-broker-launch[475]: Ready2357bob # [ 8.798392] dbus-broker-launch[484]: Ready2358clare # [ 8.809975] systemd[1]: linger-users.service: Deactivated successfully.2359clare # [ 8.811909] systemd[1]: Finished linger-users.service.2360bob # [ 8.916773] systemd[1]: Finished Firewall.2361bob # [ 8.918544] systemd[1]: Reached target Preparation for Network.2362bob # [ 8.922018] systemd[1]: Listening on Network Management Resolve Hook Socket.2363bob # [ 8.924935] systemd[1]: Starting Network Management...2364clare # [ 8.931815] systemd[1]: Finished Firewall.2365clare # [ 8.934516] systemd[1]: Reached target Preparation for Network.2366clare # [ 8.935058] systemd[1]: Listening on Network Management Resolve Hook Socket.2367clare # [ 8.939310] systemd[1]: Starting Network Management...2368alice # [ 8.953351] systemd[1]: Starting Virtual Console Setup...2369alice # [ 8.975055] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2370alice # [ 8.988218] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2371alice # [ 8.992150] systemd[1]: Stopped Virtual Console Setup.2372alice # [ 8.996294] systemd[1]: Starting Virtual Console Setup...2373alice # [ 9.002199] systemd-logind[493]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2374alice # [ 9.099496] systemd-vconsole-setup[558]: Configuration of first virtual console was skipped, ignoring remaining ones.2375bob # [ 9.093688] cfg80211: Loading compiled-in X.509 certificates for regulatory database2376alice # [ 9.102613] systemd[1]: Finished Virtual Console Setup.2377clare # [ 9.123841] cfg80211: Loading compiled-in X.509 certificates for regulatory database2378bob # [ 9.136828] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2379bob # [ 9.137341] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2380bob # [ 9.140733] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22381bob # [ 9.141100] cfg80211: failed to load regulatory.db2382clare # [ 9.168129] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2383clare # [ 9.168653] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2384clare # [ 9.170316] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22385clare # [ 9.172700] cfg80211: failed to load regulatory.db2386bob # [ 9.167691] systemd-networkd[557]: lo: Link UP2387bob # [ 9.169016] systemd-networkd[557]: lo: Gained carrier2388bob # [ 9.176447] systemd-networkd[557]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2389bob # [ 9.177299] systemd[1]: Started Network Management.2390bob # [ 9.183569] systemd[1]: Reached target Network.2391bob # [ 9.184068] systemd[1]: Reached target Network is Online.2392bob # [ 9.187147] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2393clare # [ 9.192853] systemd-networkd[541]: lo: Link UP2394clare # [ 9.194279] systemd-networkd[541]: lo: Gained carrier2395bob # [ 9.193632] systemd-networkd[557]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2396bob # [ 9.194376] systemd-networkd[557]: eth0: Link UP2397bob # [ 9.194781] systemd-networkd[557]: eth0: Gained carrier2398bob # [ 9.195210] systemd[1]: Starting ncps binary cache proxy service...2399bob # [ 9.199790] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2400clare # [ 9.201659] systemd[1]: Started Network Management.2401clare # [ 9.202129] systemd[1]: Reached target Network.2402bob # [ 9.202856] systemd-networkd[557]: eth1: Link UP2403bob # [ 9.203285] systemd-networkd[557]: eth1: Gained carrier2404bob # [ 9.203737] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2405clare # [ 9.207429] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2406bob # [ 9.213302] systemd-networkd[557]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22407clare # [ 9.214249] systemd-networkd[541]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2408clare # [ 9.215002] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2409clare # [ 9.215613] systemd[1]: Starting Permit User Sessions...2410clare # [ 9.225679] systemd-networkd[541]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2411clare # [ 9.226548] systemd-networkd[541]: eth1: Link UP2412clare # [ 9.226959] systemd-networkd[541]: eth1: Gained carrier2413clare # [ 9.227407] systemd-networkd[541]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2414bob # [ 9.229920] systemd[1]: Starting Permit User Sessions...2415clare # [ 9.236100] systemd-networkd[541]: eth0: Link UP2416clare # [ 9.236538] systemd-networkd[541]: eth0: Gained carrier2417clare # [ 9.240493] systemd-networkd[541]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22418clare # [ 9.287204] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2419bob # [ 9.288096] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2420bob # [ 9.288756] systemd[1]: Finished Permit User Sessions.2421clare # [ 9.290302] systemd[1]: Finished Permit User Sessions.2422clare # [ 9.294800] systemd[1]: Started Getty on tty1.2423clare # [ 9.295254] systemd[1]: Reached target Login Prompts.2424clare # [ 9.295696] systemd[1]: Reached target Multi-User System.2425clare # [ 9.297051] systemd[1]: Startup finished in 724ms (kernel) + 4.633s (initrd) + 3.937s (userspace) = 9.294s.2426bob # [ 9.299928] systemd[1]: Started Getty on tty1.2427bob # [ 9.300548] systemd[1]: Reached target Login Prompts.2428bob # [ 9.341050] ncps-pre-start[564]: /nix/store/z27dji5sjdkkdpzjlm37nq6d5cwbgl8i-ncps-0.9.4/bin/dbmate-ncps up2429clare # [ 9.433437] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32430bob # [ 9.537727] ncps-pre-start[579]: Creating: /var/lib/ncps/db/db.sqlite2431bob # [ 9.561261] ncps-pre-start[579]: Applying: 20241210054814_create-narinfos-table.sql2432bob # [ 9.569651] ncps-pre-start[579]: Applied: 20241210054814_create-narinfos-table.sql in 8.36176ms2433bob # [ 9.570611] ncps-pre-start[579]: Applying: 20241210054829_create-nars-table.sql2434bob # [ 9.577875] ncps-pre-start[579]: Applied: 20241210054829_create-nars-table.sql in 8.20988ms2435bob # [ 9.578736] ncps-pre-start[579]: Applying: 20241213014846_add-query-to-nars-table.sql2436bob # [ 9.586587] ncps-pre-start[579]: Applied: 20241213014846_add-query-to-nars-table.sql in 8.69772ms2437bob # [ 9.588093] ncps-pre-start[579]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2438bob # [ 9.604511] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input32439bob # [ 9.601706] ncps-pre-start[579]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 15.08968ms2440bob # [ 9.603414] ncps-pre-start[579]: Applying: 20260101000000_add-config-table.sql2441bob # [ 9.608620] ncps-pre-start[579]: Applied: 20260101000000_add-config-table.sql in 6.9156ms2442bob # [ 9.610049] ncps-pre-start[579]: Applying: 20260105025735_remove-redundant-indexes.sql2443bob # [ 9.615688] ncps-pre-start[579]: Applied: 20260105025735_remove-redundant-indexes.sql in 7.05388ms2444bob # [ 9.616688] ncps-pre-start[579]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2445bob # [ 9.624650] ncps-pre-start[579]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 8.9316ms2446bob # [ 9.625742] ncps-pre-start[579]: Applying: 20260117195000_add_narinfo_de_normalized.sql2447bob # [ 9.634921] ncps-pre-start[579]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 10.33844ms2448bob # [ 9.636356] ncps-pre-start[579]: Applying: 20260127223000_allow_multiple_nar_representations.sql2449bob # [ 9.645968] ncps-pre-start[579]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 10.17656ms2450bob # [ 9.648130] ncps-pre-start[579]: Applying: 20260131021850_add_chunks.sql2451bob # [ 9.656216] ncps-pre-start[579]: Applied: 20260131021850_add_chunks.sql in 10.2224ms2452bob # [ 9.657048] ncps-pre-start[579]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2453bob # [ 9.668203] ncps-pre-start[579]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 11.95444ms2454bob # [ 9.669161] ncps-pre-start[579]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2455bob # [ 9.679402] ncps-pre-start[579]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 11.2068ms2456bob # [ 9.680427] ncps-pre-start[579]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2457bob # [ 9.692517] ncps-pre-start[579]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 12.77252ms2458clare # [ 9.717665] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2459clare # [ 9.719862] systemd[1]: Starting Virtual Console Setup...2460clare # [ 9.740060] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2461clare # [ 9.740710] systemd[1]: Stopped Virtual Console Setup.2462clare # [ 9.745474] systemd[1]: Starting Virtual Console Setup...2463clare # [ 9.750062] systemd-logind[495]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2464clare # [ 9.849103] systemd-vconsole-setup[560]: Configuration of first virtual console was skipped, ignoring remaining ones.2465clare # [ 9.852289] systemd[1]: Finished Virtual Console Setup.2466bob # [ 9.866696] systemd[1]: Started ncps binary cache proxy service.2467bob # [ 9.867266] systemd[1]: Reached target Multi-User System.2468bob # [ 9.872646] systemd[1]: Startup finished in 717ms (kernel) + 4.643s (initrd) + 4.511s (userspace) = 9.872s.2469bob: (finished: waiting for unit ncps, in 10.21 seconds)2470bob: must succeed: systemctl status ncps2471bob: (finished: must succeed: systemctl status ncps, in 0.07 seconds)2472clare: waiting for unit harmonia.socket2473clare: waiting for the VM to finish booting2474clare: Guest shell says: b'Spawning backdoor root shell...\n'2475clare: connected to guest root shell2476clare: (connecting took 0.00 seconds)2477clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2478bob # [ 10.055564] systemd[1]: Starting Virtual Console Setup...2479clare: (finished: waiting for unit harmonia.socket, in 0.05 seconds)2480alice: waiting for success: curl bob:8502/nix-cache-info2481alice: waiting for the VM to finish booting2482alice: Guest shell says: b'Spawning backdoor root shell...\n'2483alice: connected to guest root shell2484alice: (connecting took 0.00 seconds)2485alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2486bob # [ 10.100710] systemd-logind[500]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2487bob # [ 10.104926] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2488bob # [ 10.115055] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2489bob # [ 10.116446] systemd[1]: Stopped Virtual Console Setup.2490bob # [ 10.124730] systemd[1]: Starting Virtual Console Setup...2491bob # [ 10.227167] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","log_level":"info","time":"2026-10-04T15:27:22Z","message":"logger created"}2492bob # [ 10.228889] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","xz-binary-path":"/nix/store/csrwf31hprwghnbyiglxa3p787lgrl67-xz-5.8.4-bin/bin/xz","time":"2026-10-04T15:27:22Z","message":"Using xz binary for xz decompression"}2493bob # [ 10.241597] systemd-networkd[557]: eth0: Gained IPv6LL2494bob # [ 10.246124] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","time":"2026-10-04T15:27:22Z","message":"using local locks (single-instance mode)"}2495bob # [ 10.250911] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-10-04T15:27:22Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2496bob # [ 10.256442] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-04T15:27:22Z","message":"setting up tracer provider to discard traces"}2497bob # [ 10.259126] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-04T15:27:22Z","message":"setting up meter provider to discard metrics"}2498bob # [ 10.263085] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-10-04T15:27:22Z","message":"setting up logger provider to discard logs"}2499bob # [ 10.267914] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-10-04T15:27:22Z","message":"Reporting anonymous metrics to the project maintainers"}2500bob # [ 10.271330] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-10-04T15:27:22Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2501bob # [ 10.273613] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-10-04T15:27:22Z","message":"using local storage"}2502clare # [ 10.305465] systemd[1]: Starting harmonia binary cache service...2503bob # [ 10.329550] systemd-vconsole-setup[605]: Configuration of first virtual console was skipped, ignoring remaining ones.2504bob # [ 10.331677] systemd[1]: Finished Virtual Console Setup.2505alice # [ 10.369340] systemd-networkd[538]: eth1: Gained IPv6LL2506bob # [ 10.369247] systemd-networkd[557]: eth1: Gained IPv6LL2507alice # [ 10.433139] systemd-networkd[538]: eth0: Gained IPv6LL2508clare # [ 10.446142] harmonia-cache[567]: 2026-10-04T15:27:22.267559Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2509clare # [ 10.451752] harmonia-cache[567]: 2026-10-04T15:27:22.271896Z INFO actix_server::builder: starting 4 workers2510clare # [ 10.457158] harmonia-cache[567]: 2026-10-04T15:27:22.277359Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2511clare # [ 10.465843] harmonia-cache[567]: 2026-10-04T15:27:22.277440Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2512clare # [ 10.469496] harmonia-cache[567]: 2026-10-04T15:27:22.277548Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002513clare # [ 10.473657] systemd[1]: Started harmonia binary cache service.2514bob # [ 10.494633] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-10-04T15:27:22Z","message":"upstream became healthy and is now available for requests"}2515bob # [ 10.499133] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-10-04T15:27:22Z","message":"Server started"}2516clare # [ 10.691203] systemd-networkd[541]: eth1: Gained IPv6LL2517clare # [ 11.202296] systemd-networkd[541]: eth0: Gained IPv6LL2518bob # [ 11.276848] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: 2026/10/04 15:27:23 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2519alice # curl: (28) Failed to connect to bob:8502 after 134201 ms: Could not connect to server2520alice # % Total % Received % Xferd Average Speed Time Time Time Current2521alice # Dload Upload Total Spent Left Speed2522bob # [ 145.428990] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:39394","trace_id":"ab9d63a89e40f13f051f5cfe63284004","span_id":"d1e046dc757031c9","status":200,"elapsed":0.14136,"bytes":50,"time":"2026-10-04T15:29:37Z","message":"handled request"}2523alice # 0 0 0 0 0 0 0 0 0100 50 100 50 0 0 1957 0 0100 50 100 50 0 0 1665 0 0100 50 100 50 0 0 1454 0 02524alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 135.38 seconds)2525bob: waiting for success: curl clare:5000/nix-cache-info2526bob # % Total % Received % Xferd Average Speed Time Time Time Current2527bob # Dload Upload Total Spent Left Speed2528bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 2730 0 0100 51 100 51 0 0 2277 0 0100 51 100 51 0 0 1934 0 02529bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.10 seconds)2530clare: waiting for unit harmonia2531clare: (finished: waiting for unit harmonia, in 0.08 seconds)2532clare: must succeed: systemctl status harmonia2533clare: (finished: must succeed: systemctl status harmonia, in 0.03 seconds)2534clare: must succeed: nix-build --expr '2535 builtins.derivation {2536 name = "hi";2537 builder = "/bin/sh";2538 args = [ "-c" "echo hi > $out" ];2539 system = "aarch64-linux";2540 }2541' 2>&125422543clare # [ 146.041430] systemd-resolved[312]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2544clare # [ 146.048596] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2545clare # [ 146.052327] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2546clare # [ 146.570978] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2547clare # [ 146.575989] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2548clare # [ 147.931765] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2549clare # [ 147.935842] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2550clare # [ 150.044830] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2551clare # [ 150.049053] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2552clare: (finished: must succeed: nix-build --expr '2553 builtins.derivation {2554 name = "hi";2555 builder = "/bin/sh";2556 args = [ "-c" "echo hi > $out" ];2557 system = "aarch64-linux";2558 }2559' 2>&12560, in 4.80 seconds)2561alice: must succeed: nix-build --expr '2562 builtins.derivation {2563 name = "hi";2564 builder = "/bin/sh";2565 args = [ "-c" "echo hi > $out" ];2566 system = "aarch64-linux";2567 }2568' 2>&125692570bob # [ 150.617101] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:39406","trace_id":"69b9389c141b2f03b6e3c7df4529358a","span_id":"02ed497c8e80c8d1","status":200,"elapsed":0.03352,"bytes":50,"time":"2026-10-04T15:29:42Z","message":"handled request"}2571alice # [ 150.942839] systemd-resolved[312]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2572alice # [ 150.948182] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2573alice # [ 150.951996] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2574alice # [ 151.491802] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2575alice # [ 151.496090] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2576alice # [ 152.862946] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2577alice # [ 152.866666] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2578alice # [ 154.964347] systemd-resolved[312]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.2579alice # [ 154.968330] systemd-resolved[312]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.2580bob # [ 154.963255] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_url":"http://clare.clan:5000/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","upstream_url":"http://clare.clan:5000","time":"2026-10-04T15:29:46Z","message":"download the narinfo from upstream"}2581bob # [ 154.995948] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-04T15:29:46Z","message":"downloading the nar from upstream"}2582bob # [ 155.012746] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"http://clare.clan:5000/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","upstream_url":"http://clare.clan:5000","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-04T15:29:46Z","message":"download the nar from upstream"}2583bob # [ 155.048069] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-10-04T15:29:46Z","message":"storing narinfo and nar_file record in the database"}2584bob # [ 155.062433] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":98.3538,"time":"2026-10-04T15:29:46Z","message":"download of narinfo complete"}2585bob # [ 155.073164] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","status":200,"elapsed":100.4026,"bytes":532,"time":"2026-10-04T15:29:46Z","message":"handled request"}2586bob # [ 155.078452] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:39406","trace_id":"a5e48cfa0e64d7d454607b645f4bd6ad","span_id":"140071157aa662cb","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":66.00988,"time":"2026-10-04T15:29:46Z","message":"download of nar complete"}2587bob # [ 155.087136] 70ya7n6byxa3fdhyxaknx3sks1f7mmwi-ncps-wrapper[586]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:39406","trace_id":"8cc60dd4b831bb034d2eec5ec072b71e","span_id":"bd07b6645570e095","status":200,"elapsed":0.6058,"bytes":95,"time":"2026-10-04T15:29:46Z","message":"handled request"}2588alice: (finished: must succeed: nix-build --expr '2589 builtins.derivation {2590 name = "hi";2591 builder = "/bin/sh";2592 args = [ "-c" "echo hi > $out" ];2593 system = "aarch64-linux";2594 }2595' 2>&12596, in 4.71 seconds)2597(finished: run the VM test script, in 155.91 seconds)2598test script finished in 156.13s2599cleanup2600kill QemuMachine (pid 48)2601alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2602alice # [2026-10-04T15:29:46Z INFO virtiofsd] Client disconnected, shutting down2603alice # [2026-10-04T15:29:46Z INFO virtiofsd] Client disconnected, shutting down2604alice # [2026-10-04T15:29:46Z INFO virtiofsd] Client disconnected, shutting down2605kill QemuMachine (pid 50)2606bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2607bob # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2608bob # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2609bob # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2610kill QemuMachine (pid 49)2611clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2612clare # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2613clare # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2614clare # [2026-10-04T15:29:47Z INFO virtiofsd] Client disconnected, shutting down2615(finished: cleanup, in 0.42 seconds)