vm-test-run-ncps
checks.aarch64-linux.ncps
· build #599
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 alice, bob, clare,8 vlan1,9 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_ssh10start all VMs11alice: starting vm12bob: starting vm13clare: starting vm14alice # Disk image does not exist, creating the virtualisation disk image...15clare # Disk image does not exist, creating the virtualisation disk image...16alice: QEMU running (pid 48)17clare: QEMU running (pid 50)18bob: QEMU running (pid 49)19bob # Disk image does not exist, creating the virtualisation disk image...20clare # Formatting '/build/vm-state-clare/tmp.wctxFiWvlH', fmt=raw size=107374182421bob # Formatting '/build/vm-state-bob/tmp.c5ncRsUJGF', fmt=raw size=107374182422alice # Formatting '/build/vm-state-alice/tmp.7aqp770PXG', fmt=raw size=107374182423(finished: start all VMs, in 0.53 seconds)24clare # mke2fs 1.47.4 (6-Mar-2025)25alice # mke2fs 1.47.4 (6-Mar-2025)26bob # mke2fs 1.47.4 (6-Mar-2025)27bob: waiting for unit ncps28alice # Discarding device blocks: 0/262144 done29bob # Discarding device blocks: 0/262144 done30clare # Discarding device blocks: 0/262144 done31alice # Creating filesystem with 262144 4k blocks and 65536 inodes32bob: waiting for the VM to finish booting33bob # Creating filesystem with 262144 4k blocks and 65536 inodes34clare # Creating filesystem with 262144 4k blocks and 65536 inodes35bob # Filesystem UUID: b36b231d-abb2-4f41-849e-f8058b37278e36clare # Filesystem UUID: 1d0e82a4-33ea-4afb-ad8f-3c9ed31b18d037alice # Filesystem UUID: da92dee5-b767-4b22-b946-f613455bd8ff38clare # Superblock backups stored on blocks:39alice # Superblock backups stored on blocks:40clare # 32768, 98304, 163840, 22937641bob # Superblock backups stored on blocks:42clare # 43bob # 32768, 98304, 163840, 22937644clare # Allocating group tables: 0/8 done45bob # 46clare # Writing inode tables: 0/8 done47bob # Allocating group tables: 0/8 done48clare # Creating journal (8192 blocks): done49bob # Writing inode tables: 0/8 done50clare # Writing superblocks and filesystem accounting information: 0/8 done51bob # Creating journal (8192 blocks): done52clare # 53bob # Writing superblocks and filesystem accounting information: 0/8 done54clare # Virtualisation disk image created.55alice # 32768, 98304, 163840, 22937656bob # 57alice # 58bob # Virtualisation disk image created.59alice # Allocating group tables: 0/8 done60alice # Writing inode tables: 0/8 done61alice # Creating journal (8192 blocks): done62alice # Writing superblocks and filesystem accounting information: 0/8 done63alice # 64alice # Virtualisation disk image created.65clare # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]66clare # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202667clare # [ 0.000000] KASLR enabled68clare # [ 0.000000] random: crng init done69clare # [ 0.000000] Machine model: linux,dummy-virt70alice # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]71clare # [ 0.000000] efi: UEFI not found.72clare # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT73alice # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202674alice # [ 0.000000] KASLR enabled75clare # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]76alice # [ 0.000000] random: crng init done77clare # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]78alice # [ 0.000000] Machine model: linux,dummy-virt79clare # [ 0.000000] Zone ranges:80alice # [ 0.000000] efi: UEFI not found.81clare # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]82alice # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT83clare # [ 0.000000] DMA32 empty84clare # [ 0.000000] Normal empty85clare # [ 0.000000] Device empty86alice # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]87clare # [ 0.000000] Movable zone start for each node88alice # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]89clare # [ 0.000000] Early memory node ranges90alice # [ 0.000000] Zone ranges:91bob # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]92clare # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]93alice # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]94alice # [ 0.000000] DMA32 empty95alice # [ 0.000000] Normal empty96clare # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]97alice # [ 0.000000] Device empty98bob # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202699bob # [ 0.000000] KASLR enabled100alice # [ 0.000000] Movable zone start for each node101clare # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000102bob # [ 0.000000] random: crng init done103alice # [ 0.000000] Early memory node ranges104clare # [ 0.000000] psci: probing for conduit method from DT.105bob # [ 0.000000] Machine model: linux,dummy-virt106clare # [ 0.000000] psci: PSCIv1.3 detected in firmware.107alice # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]108bob # [ 0.000000] efi: UEFI not found.109clare # [ 0.000000] psci: Using standard PSCI v0.2 function IDs110alice # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]111bob # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT112clare # [ 0.000000] psci: Trusted OS migration not required113alice # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000114clare # [ 0.000000] psci: SMC Calling Convention v1.1115bob # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]116alice # [ 0.000000] psci: probing for conduit method from DT.117bob # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]118alice # [ 0.000000] psci: PSCIv1.3 detected in firmware.119clare # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)120bob # [ 0.000000] Zone ranges:121alice # [ 0.000000] psci: Using standard PSCI v0.2 function IDs122clare # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296123bob # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]124bob # [ 0.000000] DMA32 empty125alice # [ 0.000000] psci: Trusted OS migration not required126clare # [ 0.000000] Detected PIPT I-cache on CPU0127bob # [ 0.000000] Normal empty128alice # [ 0.000000] psci: SMC Calling Convention v1.1129bob # [ 0.000000] Device empty130clare # [ 0.000000] CPU features: detected: GICv3 CPU interface131bob # [ 0.000000] Movable zone start for each node132clare # [ 0.000000] CPU features: detected: Spectre-v4133alice # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)134bob # [ 0.000000] Early memory node ranges135clare # [ 0.000000] CPU features: detected: Spectre-BHB136alice # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296137bob # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]138clare # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR139alice # [ 0.000000] Detected PIPT I-cache on CPU0140bob # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]141alice # [ 0.000000] CPU features: detected: GICv3 CPU interface142clare # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)143bob # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000144alice # [ 0.000000] CPU features: detected: Spectre-v4145clare # [ 0.000000] CPU features: detected: ARM erratum 1418040146bob # [ 0.000000] psci: probing for conduit method from DT.147alice # [ 0.000000] CPU features: detected: Spectre-BHB148clare # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion149bob # [ 0.000000] psci: PSCIv1.3 detected in firmware.150alice # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR151clare # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing152bob # [ 0.000000] psci: Using standard PSCI v0.2 function IDs153alice # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)154clare # [ 0.000000] alternatives: applying boot alternatives155bob # [ 0.000000] psci: Trusted OS migration not required156alice # [ 0.000000] CPU features: detected: ARM erratum 1418040157bob # [ 0.000000] psci: SMC Calling Convention v1.1158alice # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion159bob # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)160alice # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing161bob # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296162alice # [ 0.000000] alternatives: applying boot alternatives163bob # [ 0.000000] Detected PIPT I-cache on CPU0164bob # [ 0.000000] CPU features: detected: GICv3 CPU interface165clare # [ 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/vzgl340pr7w7ma0ckpyr42ly661hgzr4-nixos-system-clare-test/init regInfo=/nix/store/n354famxh2vvy7rx231x84md4snvj6df-closure-info/registration console=ttyAMA0,115200n8 console=tty0166bob # [ 0.000000] CPU features: detected: Spectre-v4167bob # [ 0.000000] CPU features: detected: Spectre-BHB168bob # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR169clare # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/n354famxh2vvy7rx231x84md4snvj6df-closure-info/registration", will be passed to user space.170bob # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)171alice # [ 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/6wkfmmambpac0ds2gd0zwz55db65wjaa-nixos-system-alice-test/init regInfo=/nix/store/8nqnwcb71wfrlyvvqn1i52v681dgpx00-closure-info/registration console=ttyAMA0,115200n8 console=tty0172clare # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes173bob # [ 0.000000] CPU features: detected: ARM erratum 1418040174clare # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)175bob # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion176alice # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/8nqnwcb71wfrlyvvqn1i52v681dgpx00-closure-info/registration", will be passed to user space.177clare # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)178bob # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing179bob # [ 0.000000] alternatives: applying boot alternatives180clare # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB181alice # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes182clare # [ 0.000000] software IO TLB: area num 1.183alice # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)184clare # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)185alice # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)186clare # [ 0.000000] Fallback order for Node 0: 0187alice # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB188clare # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144189alice # [ 0.000000] software IO TLB: area num 1.190clare # [ 0.000000] Policy zone: DMA191alice # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)192clare # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off193bob # [ 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/x9ybgr1aficcw55a5ramy62zgm9rbx7g-nixos-system-bob-test/init regInfo=/nix/store/vkd5blz5d4vf3g8rq1g3nlha9k47fizh-closure-info/registration console=ttyAMA0,115200n8 console=tty0194alice # [ 0.000000] Fallback order for Node 0: 0195clare # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1196alice # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144197clare # [ 0.000000] allocated 2097152 bytes of page_ext198alice # [ 0.000000] Policy zone: DMA199clare # [ 0.000000] ftrace: allocating 74886 entries in 294 pages200bob # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vkd5blz5d4vf3g8rq1g3nlha9k47fizh-closure-info/registration", will be passed to user space.201alice # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off202clare # [ 0.000000] ftrace: allocated 294 pages with 4 groups203bob # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes204clare # [ 0.000000] rcu: Hierarchical RCU implementation.205alice # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1206clare # [ 0.000000] rcu: RCU event tracing is enabled.207bob # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)208alice # [ 0.000000] allocated 2097152 bytes of page_ext209alice # [ 0.000000] ftrace: allocating 74886 entries in 294 pages210clare # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.211bob # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)212alice # [ 0.000000] ftrace: allocated 294 pages with 4 groups213clare # [ 0.000000] Trampoline variant of Tasks RCU enabled.214bob # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB215alice # [ 0.000000] rcu: Hierarchical RCU implementation.216clare # [ 0.000000] Rude variant of Tasks RCU enabled.217bob # [ 0.000000] software IO TLB: area num 1.218alice # [ 0.000000] rcu: RCU event tracing is enabled.219clare # [ 0.000000] Tracing variant of Tasks RCU enabled.220bob # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)221alice # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.222clare # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.223bob # [ 0.000000] Fallback order for Node 0: 0224alice # [ 0.000000] Trampoline variant of Tasks RCU enabled.225clare # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1226bob # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144227alice # [ 0.000000] Rude variant of Tasks RCU enabled.228bob # [ 0.000000] Policy zone: DMA229alice # [ 0.000000] Tracing variant of Tasks RCU enabled.230clare # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.231bob # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off232alice # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.233clare # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.234bob # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1235alice # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1236bob # [ 0.000000] allocated 2097152 bytes of page_ext237clare # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.238bob # [ 0.000000] ftrace: allocating 74886 entries in 294 pages239alice # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.240clare # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0241bob # [ 0.000000] ftrace: allocated 294 pages with 4 groups242clare # [ 0.000000] GICv3: 256 SPIs implemented243bob # [ 0.000000] rcu: Hierarchical RCU implementation.244alice # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.245clare # [ 0.000000] GICv3: 0 Extended SPIs implemented246bob # [ 0.000000] rcu: RCU event tracing is enabled.247clare # [ 0.000000] Root IRQ handler: gic_handle_irq248alice # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.249bob # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.250clare # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI251alice # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0252clare # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0253bob # [ 0.000000] Trampoline variant of Tasks RCU enabled.254alice # [ 0.000000] GICv3: 256 SPIs implemented255bob # [ 0.000000] Rude variant of Tasks RCU enabled.256clare # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000257alice # [ 0.000000] GICv3: 0 Extended SPIs implemented258bob # [ 0.000000] Tracing variant of Tasks RCU enabled.259clare # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]260alice # [ 0.000000] Root IRQ handler: gic_handle_irq261alice # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI262bob # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.263clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)264alice # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0265bob # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1266alice # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000267clare # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)268alice # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]269bob # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.270clare # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000271alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)272bob # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.273clare # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000274bob # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.275alice # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)276clare # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.277bob # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0278alice # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000279clare # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns280bob # [ 0.000000] GICv3: 256 SPIs implemented281alice # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000282bob # [ 0.000000] GICv3: 0 Extended SPIs implemented283clare # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040284bob # [ 0.000000] Root IRQ handler: gic_handle_irq285alice # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.286clare # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).287bob # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI288bob # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0289alice # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns290clare # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns291bob # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000292alice # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040293bob # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]294alice # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).295clare # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns296clare # [ 0.000058] arm-pv: using stolen time PV297bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)298alice # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns299clare # [ 0.000373] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)300bob # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)301clare # [ 0.000671] Console: colour dummy device 80x25302alice # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns303alice # [ 0.000066] arm-pv: using stolen time PV304clare # [ 0.000683] printk: legacy console [tty0] enabled305bob # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000306bob # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000307alice # [ 0.000395] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)308clare # [ 0.000890] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)309alice # [ 0.000681] Console: colour dummy device 80x25310bob # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.311clare # [ 0.000895] pid_max: default: 32768 minimum: 301312alice # [ 0.000692] printk: legacy console [tty0] enabled313clare # [ 0.000969] LSM: initializing lsm=capability,landlock,yama,bpf,ima314bob # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns315clare # [ 0.001083] landlock: Up and running.316alice # [ 0.000902] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)317clare # [ 0.001085] Yama: becoming mindful.318bob # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040319clare # [ 0.001477] LSM support for eBPF active320alice # [ 0.000907] pid_max: default: 32768 minimum: 301321bob # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).322alice # [ 0.000988] LSM: initializing lsm=capability,landlock,yama,bpf,ima323clare # [ 0.001653] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)324alice # [ 0.001146] landlock: Up and running.325alice # [ 0.001148] Yama: becoming mindful.326bob # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns327clare # [ 0.001672] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)328alice # [ 0.001544] LSM support for eBPF active329clare # [ 0.003532] cacheinfo: Unable to detect cache hierarchy for CPU 0330bob # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns331alice # [ 0.001744] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)332clare # [ 0.004441] rcu: Hierarchical SRCU implementation.333bob # [ 0.000068] arm-pv: using stolen time PV334clare # [ 0.004445] rcu: Max phase no-delay instances is 1000.335alice # [ 0.001764] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)336clare # [ 0.005387] fsl-mc MSI: its@8080000 domain created337bob # [ 0.000429] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)338alice # [ 0.003628] cacheinfo: Unable to detect cache hierarchy for CPU 0339clare # [ 0.005551] EFI services will not be available.340bob # [ 0.000710] Console: colour dummy device 80x25341alice # [ 0.004499] rcu: Hierarchical SRCU implementation.342clare # [ 0.005641] smp: Bringing up secondary CPUs ...343bob # [ 0.000721] printk: legacy console [tty0] enabled344alice # [ 0.004503] rcu: Max phase no-delay instances is 1000.345clare # [ 0.005668] smp: Brought up 1 node, 1 CPU346alice # [ 0.005425] fsl-mc MSI: its@8080000 domain created347clare # [ 0.005670] SMP: Total of 1 processors activated.348bob # [ 0.000924] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)349alice # [ 0.005573] EFI services will not be available.350clare # [ 0.005672] CPU: All CPU(s) started at EL1351bob # [ 0.000930] pid_max: default: 32768 minimum: 301352alice # [ 0.005671] smp: Bringing up secondary CPUs ...353clare # [ 0.005685] CPU features: detected: 32-bit EL0 Support354alice # [ 0.005701] smp: Brought up 1 node, 1 CPU355bob # [ 0.001007] LSM: initializing lsm=capability,landlock,yama,bpf,ima356bob # [ 0.001215] landlock: Up and running.357alice # [ 0.005704] SMP: Total of 1 processors activated.358clare # [ 0.005688] CPU features: detected: Data cache clean to the PoU not required for I/D coherence359bob # [ 0.001218] Yama: becoming mindful.360alice # [ 0.005706] CPU: All CPU(s) started at EL1361bob # [ 0.001699] LSM support for eBPF active362clare # [ 0.005690] CPU features: detected: Common not Private translations363alice # [ 0.005722] CPU features: detected: 32-bit EL0 Support364clare # [ 0.005693] CPU features: detected: CRC32 instructions365bob # [ 0.001870] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)366alice # [ 0.005725] CPU features: detected: Data cache clean to the PoU not required for I/D coherence367clare # [ 0.005695] CPU features: detected: Data cache clean to Point of Persistence368bob # [ 0.001888] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)369alice # [ 0.005728] CPU features: detected: Common not Private translations370clare # [ 0.005697] CPU features: detected: Enhanced Virtualization Traps371bob # [ 0.003706] cacheinfo: Unable to detect cache hierarchy for CPU 0372alice # [ 0.005730] CPU features: detected: CRC32 instructions373clare # [ 0.005707] CPU features: detected: RCpc load-acquire (LDAPR)374bob # [ 0.004577] rcu: Hierarchical SRCU implementation.375alice # [ 0.005732] CPU features: detected: Data cache clean to Point of Persistence376clare # [ 0.005710] CPU features: detected: LSE atomic instructions377bob # [ 0.004582] rcu: Max phase no-delay instances is 1000.378alice # [ 0.005735] CPU features: detected: Enhanced Virtualization Traps379clare # [ 0.005712] CPU features: detected: Privileged Access Never380bob # [ 0.005524] fsl-mc MSI: its@8080000 domain created381clare # [ 0.005714] CPU features: detected: PMUv3382bob # [ 0.005686] EFI services will not be available.383alice # [ 0.005750] CPU features: detected: RCpc load-acquire (LDAPR)384clare # [ 0.005715] CPU features: detected: RAS Extension Support385alice # [ 0.005752] CPU features: detected: LSE atomic instructions386bob # [ 0.005781] smp: Bringing up secondary CPUs ...387bob # [ 0.005810] smp: Brought up 1 node, 1 CPU388alice # [ 0.005754] CPU features: detected: Privileged Access Never389clare # [ 0.005719] CPU features: detected: Speculative Store Bypassing Safe (SSBS)390bob # [ 0.005813] SMP: Total of 1 processors activated.391alice # [ 0.005756] CPU features: detected: PMUv3392clare # [ 0.005745] alternatives: applying system-wide alternatives393bob # [ 0.005815] CPU: All CPU(s) started at EL1394alice # [ 0.005758] CPU features: detected: RAS Extension Support395bob # [ 0.005826] CPU features: detected: 32-bit EL0 Support396clare # [ 0.007126] CPU features: detected: Hardware dirty bit management on CPU0397alice # [ 0.005762] CPU features: detected: Speculative Store Bypassing Safe (SSBS)398bob # [ 0.005829] CPU features: detected: Data cache clean to the PoU not required for I/D coherence399alice # [ 0.005787] alternatives: applying system-wide alternatives400clare # [ 0.007374] Memory: 892408K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114884K reserved, 32768K cma-reserved)401bob # [ 0.005832] CPU features: detected: Common not Private translations402alice # [ 0.007166] CPU features: detected: Hardware dirty bit management on CPU0403clare # [ 0.007869] devtmpfs: initialized404bob # [ 0.005834] CPU features: detected: CRC32 instructions405clare # [ 0.009362] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)406bob # [ 0.005836] CPU features: detected: Data cache clean to Point of Persistence407alice # [ 0.007442] Memory: 892384K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114888K reserved, 32768K cma-reserved)408alice # [ 0.007916] devtmpfs: initialized409bob # [ 0.005838] CPU features: detected: Enhanced Virtualization Traps410clare # [ 0.009384] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).411bob # [ 0.005847] CPU features: detected: RCpc load-acquire (LDAPR)412alice # [ 0.009531] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)413clare # [ 0.009526] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL414bob # [ 0.005849] CPU features: detected: LSE atomic instructions415clare # [ 0.009530] 0 pages in range for non-PLT usage416alice # [ 0.009553] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).417bob # [ 0.005851] CPU features: detected: Privileged Access Never418clare # [ 0.009530] 508288 pages in range for PLT usage419alice # [ 0.009676] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL420clare # [ 0.009660] pinctrl core: initialized pinctrl subsystem421bob # [ 0.005853] CPU features: detected: PMUv3422clare # [ 0.010421] DMI not present or invalid.423alice # [ 0.009679] 0 pages in range for non-PLT usage424bob # [ 0.005854] CPU features: detected: RAS Extension Support425alice # [ 0.009680] 508288 pages in range for PLT usage426clare # [ 0.014035] NET: Registered PF_NETLINK/PF_ROUTE protocol family427bob # [ 0.005858] CPU features: detected: Speculative Store Bypassing Safe (SSBS)428alice # [ 0.009804] pinctrl core: initialized pinctrl subsystem429clare # [ 0.016535] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations430alice # [ 0.010544] DMI not present or invalid.431bob # [ 0.005884] alternatives: applying system-wide alternatives432alice # [ 0.013753] NET: Registered PF_NETLINK/PF_ROUTE protocol family433clare # [ 0.016671] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations434bob # [ 0.007332] CPU features: detected: Hardware dirty bit management on CPU0435alice # [ 0.016484] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations436clare # [ 0.016822] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations437alice # [ 0.016621] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations438clare # [ 0.016839] audit: initializing netlink subsys (disabled)439bob # [ 0.007568] Memory: 892368K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114888K reserved, 32768K cma-reserved)440bob # [ 0.008057] devtmpfs: initialized441clare # [ 0.017471] thermal_sys: Registered thermal governor 'fair_share'442alice # [ 0.016773] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations443clare # [ 0.017473] thermal_sys: Registered thermal governor 'bang_bang'444bob # [ 0.009566] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)445alice # [ 0.016790] audit: initializing netlink subsys (disabled)446clare # [ 0.017477] thermal_sys: Registered thermal governor 'step_wise'447alice # [ 0.017399] thermal_sys: Registered thermal governor 'fair_share'448bob # [ 0.009590] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).449clare # [ 0.017479] thermal_sys: Registered thermal governor 'user_space'450alice # [ 0.017401] thermal_sys: Registered thermal governor 'bang_bang'451bob # [ 0.009720] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL452clare # [ 0.017481] thermal_sys: Registered thermal governor 'power_allocator'453alice # [ 0.017404] thermal_sys: Registered thermal governor 'step_wise'454bob # [ 0.009724] 0 pages in range for non-PLT usage455bob # [ 0.009725] 508288 pages in range for PLT usage456alice # [ 0.017406] thermal_sys: Registered thermal governor 'user_space'457clare # [ 0.017516] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1458bob # [ 0.009856] pinctrl core: initialized pinctrl subsystem459clare # [ 0.017530] cpuidle: using governor ladder460alice # [ 0.017408] thermal_sys: Registered thermal governor 'power_allocator'461bob # [ 0.010603] DMI not present or invalid.462clare # [ 0.017534] cpuidle: using governor menu463alice # [ 0.017442] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1464bob # [ 0.013955] NET: Registered PF_NETLINK/PF_ROUTE protocol family465clare # [ 0.017660] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.466alice # [ 0.017457] cpuidle: using governor ladder467bob # [ 0.016727] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations468alice # [ 0.017462] cpuidle: using governor menu469clare # [ 0.017681] ASID allocator initialised with 32768 entries470clare # [ 0.018352] Serial: AMBA PL011 UART driver471alice # [ 0.017592] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.472bob # [ 0.016867] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations473alice # [ 0.017612] ASID allocator initialised with 32768 entries474clare # [ 0.021495] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1475bob # [ 0.017021] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations476alice # [ 0.018282] Serial: AMBA PL011 UART driver477clare # [ 0.021665] printk: console [ttyAMA0] enabled478bob # [ 0.017040] audit: initializing netlink subsys (disabled)479alice # [ 0.021600] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1480bob # [ 0.017654] thermal_sys: Registered thermal governor 'fair_share'481alice # [ 0.021741] printk: console [ttyAMA0] enabled482bob # [ 0.017656] thermal_sys: Registered thermal governor 'bang_bang'483bob # [ 0.017659] thermal_sys: Registered thermal governor 'step_wise'484bob # [ 0.017661] thermal_sys: Registered thermal governor 'user_space'485bob # [ 0.017663] thermal_sys: Registered thermal governor 'power_allocator'486bob # [ 0.017697] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1487bob # [ 0.017711] cpuidle: using governor ladder488bob # [ 0.017716] cpuidle: using governor menu489bob # [ 0.017854] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.490bob # [ 0.017875] ASID allocator initialised with 32768 entries491bob # [ 0.018561] Serial: AMBA PL011 UART driver492bob # [ 0.021866] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1493bob # [ 0.022004] printk: console [ttyAMA0] enabled494clare # [ 0.094005] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages495clare # [ 0.094022] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page496clare # [ 0.094030] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages497alice # [ 0.093412] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages498clare # [ 0.094033] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page499alice # [ 0.093429] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page500clare # [ 0.094037] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages501alice # [ 0.093436] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages502clare # [ 0.094040] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page503alice # [ 0.093440] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page504clare # [ 0.094043] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages505alice # [ 0.093443] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages506clare # [ 0.094046] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page507alice # [ 0.093446] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page508alice # [ 0.093450] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages509alice # [ 0.093453] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page510bob # [ 0.093942] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages511clare # [ 0.099139] fbcon: Taking over console512clare # [ 0.099168] ACPI: Interpreter disabled.513bob # [ 0.093959] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page514clare # [ 0.100420] iommu: Default domain type: Translated515bob # [ 0.093966] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages516clare # [ 0.100431] iommu: DMA domain TLB invalidation policy: strict mode517alice # [ 0.098563] fbcon: Taking over console518bob # [ 0.093969] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page519alice # [ 0.098589] ACPI: Interpreter disabled.520clare # [ 0.101599] SCSI subsystem initialized521bob # [ 0.093973] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages522alice # [ 0.099843] iommu: Default domain type: Translated523bob # [ 0.093976] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page524alice # [ 0.099854] iommu: DMA domain TLB invalidation policy: strict mode525bob # [ 0.093979] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages526alice # [ 0.101094] SCSI subsystem initialized527bob # [ 0.093982] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page528bob # [ 0.099157] fbcon: Taking over console529bob # [ 0.099189] ACPI: Interpreter disabled.530clare # [ 0.110263] usbcore: registered new interface driver usbfs531clare # [ 0.110306] usbcore: registered new interface driver hub532bob # [ 0.105679] iommu: Default domain type: Translated533clare # [ 0.110317] usbcore: registered new device driver usb534clare # [ 0.110528] pps_core: LinuxPPS API ver. 1 registered535bob # [ 0.105694] iommu: DMA domain TLB invalidation policy: strict mode536alice # [ 0.109692] usbcore: registered new interface driver usbfs537bob # [ 0.106038] SCSI subsystem initialized538alice # [ 0.109747] usbcore: registered new interface driver hub539clare # [ 0.110534] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>540alice # [ 0.109760] usbcore: registered new device driver usb541clare # [ 0.110540] PTP clock support registered542clare # [ 0.110574] EDAC MC: Ver: 3.0.0543alice # [ 0.110001] pps_core: LinuxPPS API ver. 1 registered544bob # [ 0.107435] usbcore: registered new interface driver usbfs545bob # [ 0.107476] usbcore: registered new interface driver hub546alice # [ 0.110008] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>547clare # [ 0.113568] scmi_core: SCMI protocol bus registered548alice # [ 0.110014] PTP clock support registered549bob # [ 0.107487] usbcore: registered new device driver usb550alice # [ 0.110050] EDAC MC: Ver: 3.0.0551bob # [ 0.107714] pps_core: LinuxPPS API ver. 1 registered552clare # [ 0.114345] FPGA manager framework553alice # [ 0.113001] scmi_core: SCMI protocol bus registered554bob # [ 0.107722] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>555clare # [ 0.115412] vgaarb: loaded556bob # [ 0.107729] PTP clock support registered557bob # [ 0.107775] EDAC MC: Ver: 3.0.0558clare # [ 0.115876] clocksource: Switched to clocksource arch_sys_counter559alice # [ 0.113767] FPGA manager framework560alice # [ 0.114818] vgaarb: loaded561bob # [ 0.110915] scmi_core: SCMI protocol bus registered562alice # [ 0.115267] clocksource: Switched to clocksource arch_sys_counter563bob # [ 0.111656] FPGA manager framework564bob # [ 0.112672] vgaarb: loaded565bob # [ 0.113136] clocksource: Switched to clocksource arch_sys_counter566clare # [ 0.121657] VFS: Disk quotas dquot_6.6.0567clare # [ 0.121695] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)568alice # [ 0.120745] VFS: Disk quotas dquot_6.6.0569alice # [ 0.120784] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)570clare # [ 0.124083] netfs: FS-Cache loaded571clare # [ 0.124200] pnp: PnP ACPI: disabled572alice # [ 0.123135] netfs: FS-Cache loaded573alice # [ 0.123264] pnp: PnP ACPI: disabled574clare # [ 0.126669] NET: Registered PF_INET protocol family575clare # [ 0.126879] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)576bob # [ 0.123100] VFS: Disk quotas dquot_6.6.0577bob # [ 0.123139] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)578alice # [ 0.125718] NET: Registered PF_INET protocol family579alice # [ 0.125920] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)580bob # [ 0.125571] netfs: FS-Cache loaded581bob # [ 0.125699] pnp: PnP ACPI: disabled582bob # [ 0.128186] NET: Registered PF_INET protocol family583bob # [ 0.128390] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)584clare # [ 0.151396] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)585clare # [ 0.151432] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)586clare # [ 0.151446] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)587clare # [ 0.151484] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)588clare # [ 0.151552] TCP: Hash tables configured (established 8192 bind 8192)589clare # [ 0.151656] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)590clare # [ 0.151687] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)591clare # [ 0.151712] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)592clare # [ 0.151846] NET: Registered PF_UNIX/PF_LOCAL protocol family593bob # [ 0.152786] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)594bob # [ 0.152820] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)595bob # [ 0.152834] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)596bob # [ 0.152872] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)597bob # [ 0.152940] TCP: Hash tables configured (established 8192 bind 8192)598alice # [ 0.150527] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)599bob # [ 0.153061] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)600alice # [ 0.150559] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)601bob # [ 0.153092] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)602alice # [ 0.150573] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)603alice # [ 0.150610] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)604alice # [ 0.150678] TCP: Hash tables configured (established 8192 bind 8192)605clare # [ 0.157079] NET: Registered PF_XDP protocol family606alice # [ 0.150794] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)607clare # [ 0.157134] PCI: CLS 0 bytes, default 64608alice # [ 0.150823] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)609clare # [ 0.157361] Trying to unpack rootfs image as initramfs...610alice # [ 0.150886] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)611alice # [ 0.151014] NET: Registered PF_UNIX/PF_LOCAL protocol family612alice # [ 0.151055] NET: Registered PF_XDP protocol family613alice # [ 0.151078] PCI: CLS 0 bytes, default 64614alice # [ 0.151304] Trying to unpack rootfs image as initramfs...615clare # [ 0.165018] kvm [1]: HYP mode not available616bob # [ 0.157287] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)617bob # [ 0.157445] NET: Registered PF_UNIX/PF_LOCAL protocol family618bob # [ 0.157524] NET: Registered PF_XDP protocol family619bob # [ 0.157548] PCI: CLS 0 bytes, default 64620bob # [ 0.157756] Trying to unpack rootfs image as initramfs...621alice # [ 0.165402] kvm [1]: HYP mode not available622bob # [ 0.167281] kvm [1]: HYP mode not available623alice # [ 0.231814] Initialise system trusted keyrings624alice # [ 0.232319] workingset: timestamp_bits=42 max_order=18 bucket_order=0625alice # [ 0.233267] squashfs: version 4.0 (2009/01/31) Phillip Lougher626clare # [ 0.236239] Initialise system trusted keyrings627clare # [ 0.236750] workingset: timestamp_bits=42 max_order=18 bucket_order=0628alice # [ 0.233802] 9p: Installing v9fs 9p2000 file system support629clare # [ 0.237723] squashfs: version 4.0 (2009/01/31) Phillip Lougher630bob # [ 0.234059] Initialise system trusted keyrings631clare # [ 0.238238] 9p: Installing v9fs 9p2000 file system support632bob # [ 0.234608] workingset: timestamp_bits=42 max_order=18 bucket_order=0633bob # [ 0.235569] squashfs: version 4.0 (2009/01/31) Phillip Lougher634bob # [ 0.236108] 9p: Installing v9fs 9p2000 file system support635alice # [ 0.256791] Key type asymmetric registered636alice # [ 0.256824] Asymmetric key parser 'x509' registered637alice # [ 0.256898] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)638alice # [ 0.258289] io scheduler mq-deadline registered639alice # [ 0.258304] io scheduler kyber registered640bob # [ 0.255513] Key type asymmetric registered641clare # [ 0.261142] Key type asymmetric registered642bob # [ 0.255540] Asymmetric key parser 'x509' registered643clare # [ 0.261171] Asymmetric key parser 'x509' registered644bob # [ 0.255602] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)645clare # [ 0.261233] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)646clare # [ 0.262622] io scheduler mq-deadline registered647clare # [ 0.262636] io scheduler kyber registered648bob # [ 0.261195] io scheduler mq-deadline registered649bob # [ 0.261216] io scheduler kyber registered650bob # [ 0.264182] pl061_gpio 9030000.pl061: PL061 GPIO chip registered651alice # [ 0.267412] pl061_gpio 9030000.pl061: PL061 GPIO chip registered652alice # [ 0.267763] ledtrig-cpu: registered to indicate activity on CPUs653alice # [ 0.268064] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:654bob # [ 0.269162] ledtrig-cpu: registered to indicate activity on CPUs655alice # [ 0.268085] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000656bob # [ 0.269538] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:657alice # [ 0.268108] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000658bob # [ 0.269562] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000659clare # [ 0.272001] pl061_gpio 9030000.pl061: PL061 GPIO chip registered660alice # [ 0.268115] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000661clare # [ 0.272344] ledtrig-cpu: registered to indicate activity on CPUs662bob # [ 0.269583] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000663alice # [ 0.268148] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits664clare # [ 0.272645] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:665bob # [ 0.269589] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000666alice # [ 0.268171] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]667clare # [ 0.272664] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000668bob # [ 0.269618] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits669alice # [ 0.268235] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00670clare # [ 0.272685] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000671alice # [ 0.268253] pci_bus 0000:00: root bus resource [bus 00-ff]672bob # [ 0.269641] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]673alice # [ 0.268258] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]674clare # [ 0.272691] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000675bob # [ 0.269710] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00676alice # [ 0.268261] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]677bob # [ 0.269728] pci_bus 0000:00: root bus resource [bus 00-ff]678clare # [ 0.272720] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits679alice # [ 0.268265] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]680bob # [ 0.269733] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]681clare # [ 0.272744] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]682bob # [ 0.269737] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]683alice # [ 0.268355] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint684bob # [ 0.269740] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]685clare # [ 0.272814] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00686alice # [ 0.268820] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint687clare # [ 0.272831] pci_bus 0000:00: root bus resource [bus 00-ff]688alice # [ 0.268953] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]689bob # [ 0.269869] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint690clare # [ 0.272836] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]691alice # [ 0.268965] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]692bob # [ 0.270330] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint693clare # [ 0.272840] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]694alice # [ 0.268986] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]695bob # [ 0.270464] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]696clare # [ 0.272844] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]697alice # [ 0.268997] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]698bob # [ 0.270477] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]699clare # [ 0.272936] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint700alice # [ 0.269322] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint701bob # [ 0.270498] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]702alice # [ 0.269450] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]703bob # [ 0.270509] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]704clare # [ 0.273405] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint705alice # [ 0.269462] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]706clare # [ 0.273540] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]707bob # [ 0.270838] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint708alice # [ 0.269483] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]709clare # [ 0.273552] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]710bob # [ 0.270968] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]711alice # [ 0.269797] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint712clare # [ 0.273574] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]713bob # [ 0.270982] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]714alice # [ 0.269924] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]715clare # [ 0.273586] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]716bob # [ 0.271002] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]717alice # [ 0.269936] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]718clare # [ 0.273913] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint719bob # [ 0.271326] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint720alice # [ 0.269956] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]721clare # [ 0.274043] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]722bob # [ 0.271456] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]723clare # [ 0.274054] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]724alice # [ 0.270280] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint725bob # [ 0.271468] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]726alice # [ 0.270407] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]727clare # [ 0.274076] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]728bob # [ 0.271490] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]729alice # [ 0.270420] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]730clare # [ 0.274395] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint731bob # [ 0.271837] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint732alice # [ 0.270440] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]733clare # [ 0.274522] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]734bob # [ 0.271970] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]735clare # [ 0.274534] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]736alice # [ 0.270761] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint737bob # [ 0.271982] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]738alice # [ 0.270886] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]739clare # [ 0.274555] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]740bob # [ 0.272003] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]741alice # [ 0.270898] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]742clare # [ 0.274876] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint743bob # [ 0.272331] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint744alice # [ 0.270919] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]745clare # [ 0.275004] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]746bob # [ 0.272461] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]747clare # [ 0.275016] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]748alice # [ 0.271233] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint749bob # [ 0.272473] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]750alice # [ 0.271399] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]751clare # [ 0.275036] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]752alice # [ 0.271412] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]753bob # [ 0.272494] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]754clare # [ 0.275361] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint755alice # [ 0.271433] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]756bob # [ 0.272814] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint757clare # [ 0.275492] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]758bob # [ 0.272946] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]759clare # [ 0.275503] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]760alice # [ 0.271767] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint761bob # [ 0.272959] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]762alice # [ 0.271902] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]763clare # [ 0.275524] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]764alice # [ 0.271914] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]765bob # [ 0.272979] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]766clare # [ 0.275845] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint767alice # [ 0.271940] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]768clare # [ 0.275995] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]769alice # [ 0.271952] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]770clare # [ 0.276007] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]771alice # [ 0.272277] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint772clare # [ 0.276027] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]773alice # [ 0.272417] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]774clare # [ 0.276348] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint775alice # [ 0.272439] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]776clare # [ 0.276480] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]777clare # [ 0.276492] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]778alice # [ 0.272763] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint779alice # [ 0.272897] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]780clare # [ 0.276517] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]781alice # [ 0.272919] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]782clare # [ 0.276528] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]783alice # [ 0.273192] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint784clare # [ 0.276860] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint785alice # [ 0.273316] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]786clare # [ 0.277004] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]787clare # [ 0.277026] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]788alice # [ 0.273495] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint789alice # [ 0.273709] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]790clare # [ 0.277363] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint791alice # [ 0.273723] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]792clare # [ 0.277496] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]793alice # [ 0.273744] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]794clare # [ 0.277518] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]795alice # [ 0.274071] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint796clare # [ 0.277796] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint797alice # [ 0.274200] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]798clare # [ 0.277923] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]799alice # [ 0.274212] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]800clare # [ 0.278100] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint801alice # [ 0.274232] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]802clare # [ 0.278333] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]803alice # [ 0.274670] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned804clare # [ 0.278349] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]805alice # [ 0.274681] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned806clare # [ 0.278371] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]807alice # [ 0.274686] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned808clare # [ 0.278720] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint809alice # [ 0.274722] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned810clare # [ 0.278852] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]811clare # [ 0.278865] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]812alice # [ 0.274755] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned813clare # [ 0.278885] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]814alice # [ 0.274788] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned815clare # [ 0.279337] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned816alice # [ 0.274820] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned817clare # [ 0.279349] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned818alice # [ 0.274850] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned819clare # [ 0.279355] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned820alice # [ 0.274882] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned821bob # [ 0.301413] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint822clare # [ 0.279390] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned823alice # [ 0.274917] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned824bob # [ 0.301567] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]825clare # [ 0.279423] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned826bob # [ 0.301580] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]827alice # [ 0.274948] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned828clare # [ 0.279456] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned829bob # [ 0.301606] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]830alice # [ 0.274980] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned831bob # [ 0.301618] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]832clare # [ 0.279489] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned833alice # [ 0.275065] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned834bob # [ 0.301999] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint835clare # [ 0.279522] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned836alice # [ 0.275099] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned837bob # [ 0.302135] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]838alice # [ 0.275113] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned839clare # [ 0.279556] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned840bob # [ 0.302158] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]841alice # [ 0.275128] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned842clare # [ 0.279590] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned843bob # [ 0.302497] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint844alice # [ 0.275142] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned845clare # [ 0.279623] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned846bob # [ 0.302635] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]847alice # [ 0.275156] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned848clare # [ 0.279657] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned849bob # [ 0.302657] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]850alice # [ 0.275172] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned851clare # [ 0.279747] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned852alice # [ 0.275187] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned853bob # [ 0.302947] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint854clare # [ 0.279781] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned855alice # [ 0.275202] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned856bob # [ 0.303081] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]857clare # [ 0.279795] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned858alice # [ 0.275216] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned859bob # [ 0.303261] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint860clare # [ 0.279810] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned861alice # [ 0.275230] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned862bob # [ 0.303493] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]863bob # [ 0.303509] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]864clare # [ 0.279824] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned865alice # [ 0.275244] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned866clare # [ 0.279838] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned867bob # [ 0.303530] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]868alice # [ 0.275258] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned869clare # [ 0.279852] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned870bob # [ 0.303887] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint871clare # [ 0.279867] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned872bob # [ 0.304020] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]873bob # [ 0.304032] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]874bob # [ 0.304054] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]875bob # [ 0.304496] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned876bob # [ 0.304509] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned877bob # [ 0.304514] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned878bob # [ 0.304551] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned879bob # [ 0.304585] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned880bob # [ 0.304619] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned881bob # [ 0.304654] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned882alice # [ 0.323351] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned883alice # [ 0.323380] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned884bob # [ 0.304687] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned885alice # [ 0.323396] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned886bob # [ 0.304722] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned887alice # [ 0.323412] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned888bob # [ 0.304756] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned889alice # [ 0.323433] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned890alice # [ 0.323448] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned891bob # [ 0.304789] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned892alice # [ 0.323464] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned893clare # [ 0.327932] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned894bob # [ 0.304823] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned895alice # [ 0.323479] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned896clare # [ 0.327963] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned897bob # [ 0.304901] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned898alice # [ 0.323494] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned899clare # [ 0.327980] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned900bob # [ 0.304940] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned901alice # [ 0.323521] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]902clare # [ 0.327996] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned903alice # [ 0.323527] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]904bob # [ 0.304955] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned905clare # [ 0.328011] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned906alice # [ 0.323531] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]907bob # [ 0.304969] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned908clare # [ 0.328026] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned909alice # [ 0.324327] pci 0000:00:0a.0: enabling device (0000 -> 0002)910bob # [ 0.304983] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned911clare # [ 0.328042] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned912bob # [ 0.304997] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned913clare # [ 0.328057] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned914bob # [ 0.305012] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned915clare # [ 0.328071] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned916bob # [ 0.305026] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned917clare # [ 0.328091] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned918clare # [ 0.328106] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned919bob # [ 0.305041] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned920clare # [ 0.328122] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned921bob # [ 0.305055] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned922clare # [ 0.328137] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned923bob # [ 0.305069] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned924clare # [ 0.328152] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned925bob # [ 0.305084] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned926clare # [ 0.328177] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]927bob # [ 0.305098] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned928clare # [ 0.328183] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]929bob # [ 0.305113] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned930clare # [ 0.328187] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]931bob # [ 0.305127] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned932clare # [ 0.328984] pci 0000:00:0a.0: enabling device (0000 -> 0002)933bob # [ 0.305157] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned934bob # [ 0.305171] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned935bob # [ 0.305190] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned936bob # [ 0.305204] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned937bob # [ 0.305218] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned938bob # [ 0.305232] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned939bob # [ 0.305246] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned940bob # [ 0.305265] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]941bob # [ 0.305271] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]942bob # [ 0.305274] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]943bob # [ 0.306064] pci 0000:00:0a.0: enabling device (0000 -> 0002)944clare # [ 0.343707] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)945alice # [ 0.344177] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)946alice # [ 0.346067] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)947bob # [ 0.343594] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)948clare # [ 0.353086] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)949clare # [ 0.355160] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)950bob # [ 0.353349] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)951bob # [ 0.355937] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)952alice # [ 0.355828] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)953alice # [ 0.357781] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)954alice # [ 0.359638] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)955alice # [ 0.361545] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)956clare # [ 0.365008] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)957clare # [ 0.368790] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)958clare # [ 0.370566] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)959alice # [ 0.371420] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)960alice # [ 0.373386] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)961bob # [ 0.365747] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)962bob # [ 0.368350] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)963bob # [ 0.370163] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)964bob # [ 0.372036] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)965clare # [ 0.380315] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)966clare # [ 0.382692] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)967clare # [ 0.385759] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)968clare # [ 0.387439] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)969bob # [ 0.382286] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)970bob # [ 0.384333] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)971alice # [ 0.383434] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)972alice # [ 0.385241] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)973alice # [ 0.387212] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)974alice # [ 0.396003] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled975bob # [ 0.390113] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)976bob # [ 0.392128] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)977clare # [ 0.397140] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)978alice # [ 0.397535] msm_serial: driver initialized979alice # [ 0.397619] SuperH (H)SCI(F) driver initialized980alice # [ 0.397654] STM32 USART driver initialized981clare # [ 0.404695] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled982clare # [ 0.406246] msm_serial: driver initialized983clare # [ 0.406335] SuperH (H)SCI(F) driver initialized984clare # [ 0.406370] STM32 USART driver initialized985bob # [ 0.403915] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled986bob # [ 0.405478] msm_serial: driver initialized987bob # [ 0.405553] SuperH (H)SCI(F) driver initialized988bob # [ 0.405588] STM32 USART driver initialized989alice # [ 0.421281] loop: module loaded990alice # [ 0.421426] virtio_blk virtio5: 1/0/0 default/read/poll queues991alice # [ 0.422012] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)992clare # [ 0.430141] loop: module loaded993clare # [ 0.430288] virtio_blk virtio5: 1/0/0 default/read/poll queues994clare # [ 0.430892] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)995bob # [ 0.430516] loop: module loaded996bob # [ 0.430672] virtio_blk virtio5: 1/0/0 default/read/poll queues997bob # [ 0.431289] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)998alice # [ 0.431740] megasas: 07.734.00.00-rc1999alice # [ 0.432203] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1000clare # [ 0.436273] megasas: 07.734.00.00-rc11001clare # [ 0.436717] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1002alice # [ 0.434337] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001003alice # [ 0.434372] Intel/Sharp Extended Query Table at 0x00311004alice # [ 0.436007] Using buffer write method1005alice # [ 0.436061] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1006alice # [ 0.437750] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001007alice # [ 0.437769] Intel/Sharp Extended Query Table at 0x00311008alice # [ 0.447295] Using buffer write method1009alice # [ 0.447316] Concatenating MTD devices:1010alice # [ 0.447319] (0): "0.flash"1011alice # [ 0.447322] (1): "0.flash"1012alice # [ 0.447325] into device "0.flash"1013bob # [ 0.437556] megasas: 07.734.00.00-rc11014bob # [ 0.438027] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1015bob # [ 0.441171] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001016bob # [ 0.441220] Intel/Sharp Extended Query Table at 0x00311017clare # [ 0.448877] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001018bob # [ 0.442927] Using buffer write method1019clare # [ 0.448913] Intel/Sharp Extended Query Table at 0x00311020clare # [ 0.450742] Using buffer write method1021clare # [ 0.450779] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1022bob # [ 0.442959] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1023bob # [ 0.444921] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001024bob # [ 0.444941] Intel/Sharp Extended Query Table at 0x00311025clare # [ 0.460400] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001026bob # [ 0.458113] Using buffer write method1027clare # [ 0.460424] Intel/Sharp Extended Query Table at 0x00311028bob # [ 0.458140] Concatenating MTD devices:1029bob # [ 0.458143] (0): "0.flash"1030clare # [ 0.461969] Using buffer write method1031bob # [ 0.458146] (1): "0.flash"1032clare # [ 0.461992] Concatenating MTD devices:1033bob # [ 0.458149] into device "0.flash"1034clare # [ 0.461995] (0): "0.flash"1035clare # [ 0.461998] (1): "0.flash"1036clare # [ 0.462000] into device "0.flash"1037alice # [ 0.655793] Freeing initrd memory: 26084K1038alice # [ 0.662489] tun: Universal TUN/TAP device driver, 1.61039clare # [ 0.663982] Freeing initrd memory: 26080K1040alice # [ 0.665194] thunder_xcv, ver 1.01041alice # [ 0.665223] thunder_bgx, ver 1.01042alice # [ 0.665235] nicpf, ver 1.01043alice # [ 0.665547] e1000: Intel(R) PRO/1000 Network Driver1044clare # [ 0.670667] tun: Universal TUN/TAP device driver, 1.61045alice # [ 0.665555] e1000: Copyright (c) 1999-2006 Intel Corporation.1046alice # [ 0.665570] e1000e: Intel(R) PRO/1000 Network Driver1047alice # [ 0.665577] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1048alice # [ 0.665590] igb: Intel(R) Gigabit Ethernet Network Driver1049alice # [ 0.665593] igb: Copyright (c) 2007-2014 Intel Corporation.1050alice # [ 0.665604] igbvf: Intel(R) Gigabit Virtual Function Network Driver1051alice # [ 0.665607] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1052alice # [ 0.665669] sky2: driver version 1.301053alice # [ 0.666421] usbcore: registered new interface driver usb-storage1054alice # [ 0.666507] usbcore: registered new interface driver usbserial_generic1055clare # [ 0.673287] thunder_xcv, ver 1.01056alice # [ 0.666516] usbserial: USB Serial support registered for generic1057clare # [ 0.673317] thunder_bgx, ver 1.01058clare # [ 0.673331] nicpf, ver 1.01059alice # [ 0.666783] hv_vmbus: registering driver hyperv_keyboard1060clare # [ 0.673628] e1000: Intel(R) PRO/1000 Network Driver1061alice # [ 0.667838] ehci-pci 0000:00:0a.0: EHCI Host Controller1062bob # [ 0.671057] Freeing initrd memory: 26084K1063clare # [ 0.673636] e1000: Copyright (c) 1999-2006 Intel Corporation.1064alice # [ 0.667882] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 11065clare # [ 0.673653] e1000e: Intel(R) PRO/1000 Network Driver1066alice # [ 0.668109] ehci-pci 0000:00:0a.0: irq 15, io mem 0x100890001067clare # [ 0.673659] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1068clare # [ 0.673674] igb: Intel(R) Gigabit Ethernet Network Driver1069clare # [ 0.673678] igb: Copyright (c) 2007-2014 Intel Corporation.1070alice # [ 0.676138] rtc-pl031 9010000.pl031: registered as rtc01071clare # [ 0.673688] igbvf: Intel(R) Gigabit Virtual Function Network Driver1072clare # [ 0.673692] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1073alice # [ 0.676190] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T04:41:40 UTC (1788842500)1074clare # [ 0.673755] sky2: driver version 1.301075alice # [ 0.676383] i2c_dev: i2c /dev entries driver1076clare # [ 0.674550] usbcore: registered new interface driver usb-storage1077clare # [ 0.674633] usbcore: registered new interface driver usbserial_generic1078clare # [ 0.674641] usbserial: USB Serial support registered for generic1079clare # [ 0.674922] hv_vmbus: registering driver hyperv_keyboard1080alice # [ 0.679149] sdhci: Secure Digital Host Controller Interface driver1081alice # [ 0.679165] sdhci: Copyright(c) Pierre Ossman1082alice # [ 0.679356] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.001083clare # [ 0.682467] ehci-pci 0000:00:0a.0: EHCI Host Controller1084alice # [ 0.679695] hub 1-0:1.0: USB hub found1085alice # [ 0.679720] hub 1-0:1.0: 6 ports detected1086bob # [ 0.677862] tun: Universal TUN/TAP device driver, 1.61087clare # [ 0.682515] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 11088clare # [ 0.682747] ehci-pci 0000:00:0a.0: irq 15, io mem 0x100890001089clare # [ 0.684457] rtc-pl031 9010000.pl031: registered as rtc01090alice # [ 0.681957] Synopsys Designware Multimedia Card Interface Driver1091alice # [ 0.682137] sdhci-pltfm: SDHCI platform and OF driver helper1092clare # [ 0.684501] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T04:41:40 UTC (1788842500)1093alice # [ 0.683018] hid: raw HID events driver (C) Jiri Kosina1094clare # [ 0.684673] i2c_dev: i2c /dev entries driver1095alice # [ 0.683180] usbcore: registered new interface driver usbhid1096bob # [ 0.680407] thunder_xcv, ver 1.01097alice # [ 0.683186] usbhid: USB HID core driver1098bob # [ 0.680438] thunder_bgx, ver 1.01099bob # [ 0.680450] nicpf, ver 1.01100bob # [ 0.680738] e1000: Intel(R) PRO/1000 Network Driver1101bob # [ 0.680746] e1000: Copyright (c) 1999-2006 Intel Corporation.1102clare # [ 0.687395] sdhci: Secure Digital Host Controller Interface driver1103bob # [ 0.680761] e1000e: Intel(R) PRO/1000 Network Driver1104clare # [ 0.687412] sdhci: Copyright(c) Pierre Ossman1105bob # [ 0.680767] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1106clare # [ 0.687542] Synopsys Designware Multimedia Card Interface Driver1107bob # [ 0.680780] igb: Intel(R) Gigabit Ethernet Network Driver1108alice # [ 0.685886] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1109clare # [ 0.687741] sdhci-pltfm: SDHCI platform and OF driver helper1110bob # [ 0.680783] igb: Copyright (c) 2007-2014 Intel Corporation.1111alice # [ 0.686585] drop_monitor: Initializing network drop monitor service1112bob # [ 0.680794] igbvf: Intel(R) Gigabit Virtual Function Network Driver1113alice # [ 0.686706] NET: Registered PF_INET6 protocol family1114bob # [ 0.680798] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1115bob # [ 0.680861] sky2: driver version 1.301116alice # [ 0.689009] Segment Routing with IPv61117alice # [ 0.689029] In-situ OAM (IOAM) with IPv61118clare # [ 0.690355] hid: raw HID events driver (C) Jiri Kosina1119alice # [ 0.689078] NET: Registered PF_PACKET protocol family1120clare # [ 0.690528] usbcore: registered new interface driver usbhid1121bob # [ 0.686243] usbcore: registered new interface driver usb-storage1122clare # [ 0.690534] usbhid: USB HID core driver1123alice # [ 0.690124] 9pnet: Installing 9P2000 support1124bob # [ 0.686366] usbcore: registered new interface driver usbserial_generic1125clare # [ 0.691985] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.001126clare # [ 0.692398] hub 1-0:1.0: USB hub found1127bob # [ 0.686375] usbserial: USB Serial support registered for generic1128clare # [ 0.692418] hub 1-0:1.0: 6 ports detected1129bob # [ 0.686662] hv_vmbus: registering driver hyperv_keyboard1130bob # [ 0.689560] ehci-pci 0000:00:0a.0: EHCI Host Controller1131clare # [ 0.694040] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1132bob # [ 0.689608] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 11133clare # [ 0.694771] drop_monitor: Initializing network drop monitor service1134bob # [ 0.689781] ehci-pci 0000:00:0a.0: irq 15, io mem 0x100890001135clare # [ 0.694934] NET: Registered PF_INET6 protocol family1136alice # [ 0.692206] Key type dns_resolver registered1137clare # [ 0.697278] Segment Routing with IPv61138bob # [ 0.691463] rtc-pl031 9010000.pl031: registered as rtc01139clare # [ 0.697297] In-situ OAM (IOAM) with IPv61140clare # [ 0.697363] NET: Registered PF_PACKET protocol family1141bob # [ 0.691510] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T04:41:40 UTC (1788842500)1142bob # [ 0.691682] i2c_dev: i2c /dev entries driver1143clare # [ 0.698436] 9pnet: Installing 9P2000 support1144alice # [ 0.695426] registered taskstats version 11145alice # [ 0.695578] Loading compiled-in X.509 certificates1146bob # [ 0.694502] sdhci: Secure Digital Host Controller Interface driver1147bob # [ 0.694518] sdhci: Copyright(c) Pierre Ossman1148bob # [ 0.694653] Synopsys Designware Multimedia Card Interface Driver1149alice # [ 0.700904] Demotion targets for Node 0: null1150bob # [ 0.694819] sdhci-pltfm: SDHCI platform and OF driver helper1151clare # [ 0.700429] Key type dns_resolver registered1152alice # [ 0.700980] Key type .fscrypt registered1153bob # [ 0.695682] hid: raw HID events driver (C) Jiri Kosina1154alice # [ 0.700987] Key type fscrypt-provisioning registered1155clare # [ 0.703635] registered taskstats version 11156bob # [ 0.695860] usbcore: registered new interface driver usbhid1157alice # [ 0.701094] ima: No TPM chip found, activating TPM-bypass!1158clare # [ 0.703801] Loading compiled-in X.509 certificates1159bob # [ 0.695867] usbhid: USB HID core driver1160alice # [ 0.701106] ima: Allocated hash algorithm: sha11161alice # [ 0.701155] ima: No architecture policies found1162alice # [ 0.704164] input: gpio-keys as /devices/platform/gpio-keys/input/input01163bob # [ 0.699363] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available1164bob # [ 0.700177] drop_monitor: Initializing network drop monitor service1165bob # [ 0.700345] NET: Registered PF_INET6 protocol family1166bob # [ 0.702273] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.001167bob # [ 0.702600] hub 1-0:1.0: USB hub found1168bob # [ 0.703372] hub 1-0:1.0: 6 ports detected1169clare # [ 0.709105] Demotion targets for Node 0: null1170clare # [ 0.709185] Key type .fscrypt registered1171bob # [ 0.704504] Segment Routing with IPv61172clare # [ 0.709191] Key type fscrypt-provisioning registered1173bob # [ 0.704525] In-situ OAM (IOAM) with IPv61174clare # [ 0.709295] ima: No TPM chip found, activating TPM-bypass!1175bob # [ 0.704576] NET: Registered PF_PACKET protocol family1176clare # [ 0.709308] ima: Allocated hash algorithm: sha11177clare # [ 0.709372] ima: No architecture policies found1178clare # [ 0.712026] input: gpio-keys as /devices/platform/gpio-keys/input/input01179bob # [ 0.705731] 9pnet: Installing 9P2000 support1180bob # [ 0.707550] Key type dns_resolver registered1181alice # [ 0.714110] clk: Disabling unused clocks1182alice # [ 0.714131] PM: genpd: Disabling unused power domains1183bob # [ 0.711158] registered taskstats version 11184bob # [ 0.711327] Loading compiled-in X.509 certificates1185alice # [ 0.717238] Freeing unused kernel memory: 4736K1186alice # [ 0.717331] Run /init as init process1187bob # [ 0.716729] Demotion targets for Node 0: null1188bob # [ 0.716812] Key type .fscrypt registered1189bob # [ 0.716818] Key type fscrypt-provisioning registered1190bob # [ 0.716928] ima: No TPM chip found, activating TPM-bypass!1191clare # [ 0.722435] clk: Disabling unused clocks1192bob # [ 0.716941] ima: Allocated hash algorithm: sha11193clare # [ 0.722455] PM: genpd: Disabling unused power domains1194bob # [ 0.716994] ima: No architecture policies found1195bob # [ 0.719993] input: gpio-keys as /devices/platform/gpio-keys/input/input01196clare # [ 0.725575] Freeing unused kernel memory: 4736K1197clare # [ 0.725671] Run /init as init process1198bob # [ 0.730439] clk: Disabling unused clocks1199bob # [ 0.730458] PM: genpd: Disabling unused power domains1200bob # [ 0.733572] Freeing unused kernel memory: 4736K1201alice # [ 0.737604] systemd[1]: Successfully made /usr/ read-only.1202bob # [ 0.733664] Run /init as init process1203clare # [ 0.746688] systemd[1]: Successfully made /usr/ read-only.1204bob # [ 0.751514] systemd[1]: Successfully made /usr/ read-only.1205alice # [ 0.927340] usb 1-1: new high-speed USB device number 2 using ehci-pci1206clare # [ 0.939930] usb 1-1: new high-speed USB device number 2 using ehci-pci1207bob # [ 0.949187] usb 1-1: new high-speed USB device number 2 using ehci-pci1208alice # [ 1.072425] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1209alice # [ 1.079559] systemd[1]: Detected virtualization qemu.1210alice # [ 1.080848] systemd[1]: Detected architecture arm64.1211alice # [ 1.082189] systemd[1]: Running in initrd.1212alice # [ 1.084102] systemd[1]: Initializing machine ID from random generator.1213clare # [ 1.081433] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1214alice # [ 1.086089] systemd[1]: Hostname set to <alice>.1215clare # [ 1.088459] systemd[1]: Detected virtualization qemu.1216clare # [ 1.089964] systemd[1]: Detected architecture arm64.1217clare # [ 1.091333] systemd[1]: Running in initrd.1218clare # [ 1.093154] systemd[1]: Initializing machine ID from random generator.1219clare # [ 1.095164] systemd[1]: Hostname set to <clare>.1220alice # [ 1.092750] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11221bob # [ 1.085927] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1222bob # [ 1.093266] systemd[1]: Detected virtualization qemu.1223bob # [ 1.094810] systemd[1]: Detected architecture arm64.1224bob # [ 1.096154] systemd[1]: Running in initrd.1225bob # [ 1.098163] systemd[1]: Initializing machine ID from random generator.1226clare # [ 1.102552] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11227bob # [ 1.100240] systemd[1]: Hostname set to <bob>.1228bob # [ 1.109557] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11229alice # [ 1.171538] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input01230clare # [ 1.184051] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input01231bob # [ 1.193328] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input01232alice # [ 1.291315] usb 1-2: new high-speed USB device number 3 using ehci-pci1233clare # [ 1.303904] usb 1-2: new high-speed USB device number 3 using ehci-pci1234bob # [ 1.313162] usb 1-2: new high-speed USB device number 3 using ehci-pci1235clare # [ 1.346923] systemd[1]: bpf-restrict-fs: LSM BPF program attached1236bob # [ 1.359603] systemd[1]: bpf-restrict-fs: LSM BPF program attached1237alice # [ 1.365566] systemd[1]: bpf-restrict-fs: LSM BPF program attached1238clare # [ 1.399607] systemd[1]: Queued start job for default target Initrd Default Target.1239clare # [ 1.409767] systemd[1]: Created slice Slice /system/modprobe.1240clare # [ 1.410514] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1241clare # [ 1.411279] systemd[1]: Expecting device /dev/disk/by-label/nixos...1242clare # [ 1.411909] systemd[1]: Reached target Path Units.1243clare # [ 1.412393] systemd[1]: Reached target Slice Units.1244clare # [ 1.412869] systemd[1]: Reached target Swaps.1245clare # [ 1.413345] systemd[1]: Reached target Timer Units.1246clare # [ 1.414009] systemd[1]: Listening on D-Bus System Message Bus Socket.1247clare # [ 1.414788] systemd[1]: Listening on Journal Socket (/dev/log).1248clare # [ 1.415467] systemd[1]: Listening on Journal Sockets.1249clare # [ 1.416106] systemd[1]: Listening on udev Control Socket.1250clare # [ 1.416736] systemd[1]: Listening on udev Kernel Socket.1251clare # [ 1.417283] systemd[1]: Reached target Socket Units.1252clare # [ 1.418968] systemd[1]: Starting Create List of Static Device Nodes...1253bob # [ 1.420869] systemd[1]: Queued start job for default target Initrd Default Target.1254clare # [ 1.428386] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1255clare # [ 1.428445] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1256bob # [ 1.430633] systemd[1]: Created slice Slice /system/modprobe.1257bob # [ 1.431350] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1258bob # [ 1.432112] systemd[1]: Expecting device /dev/disk/by-label/nixos...1259bob # [ 1.432713] systemd[1]: Reached target Path Units.1260bob # [ 1.433224] systemd[1]: Reached target Slice Units.1261bob # [ 1.433996] systemd[1]: Reached target Swaps.1262bob # [ 1.434602] systemd[1]: Reached target Timer Units.1263bob # [ 1.435224] systemd[1]: Listening on D-Bus System Message Bus Socket.1264bob # [ 1.435987] systemd[1]: Listening on Journal Socket (/dev/log).1265bob # [ 1.436752] systemd[1]: Listening on Journal Sockets.1266bob # [ 1.437383] systemd[1]: Listening on udev Control Socket.1267bob # [ 1.438016] systemd[1]: Listening on udev Kernel Socket.1268bob # [ 1.438549] systemd[1]: Reached target Socket Units.1269bob # [ 1.440170] systemd[1]: Starting Create List of Static Device Nodes...1270clare # [ 1.443391] systemd[1]: Mounting Kernel Configuration File System...1271clare # [ 1.446286] systemd[1]: Starting Journal Service...1272alice # [ 1.446941] systemd[1]: Queued start job for default target Initrd Default Target.1273clare # [ 1.450994] systemd[1]: Starting Load Kernel Modules...1274clare # [ 1.451608] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1275alice # [ 1.450184] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21276alice # [ 1.451993] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input01277bob # [ 1.449389] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1278bob # [ 1.449448] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1279alice # [ 1.457354] systemd[1]: Created slice Slice /system/modprobe.1280alice # [ 1.458305] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1281clare # [ 1.460125] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21282alice # [ 1.459451] systemd[1]: Expecting device /dev/disk/by-label/nixos...1283clare # [ 1.460246] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input01284alice # [ 1.460252] systemd[1]: Reached target Path Units.1285alice # [ 1.461018] systemd[1]: Reached target Slice Units.1286alice # [ 1.461706] systemd[1]: Reached target Swaps.1287bob # [ 1.458173] systemd[1]: Mounting Kernel Configuration File System...1288alice # [ 1.462273] systemd[1]: Reached target Timer Units.1289alice # [ 1.463120] systemd[1]: Listening on D-Bus System Message Bus Socket.1290alice # [ 1.464224] systemd[1]: Listening on Journal Socket (/dev/log).1291alice # [ 1.465099] systemd[1]: Listening on Journal Sockets.1292alice # [ 1.465863] systemd[1]: Listening on udev Control Socket.1293alice # [ 1.466767] systemd[1]: Listening on udev Kernel Socket.1294bob # [ 1.463335] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21295alice # [ 1.467525] systemd[1]: Reached target Socket Units.1296bob # [ 1.464572] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input01297bob # [ 1.466091] systemd[1]: Starting Journal Service...1298alice # [ 1.469576] systemd[1]: Starting Create List of Static Device Nodes...1299alice # [ 1.475701] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1300alice # [ 1.476541] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1301clare # [ 1.480149] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1302alice # [ 1.483366] systemd[1]: Mounting Kernel Configuration File System...1303bob # [ 1.480294] systemd[1]: Starting Load Kernel Modules...1304bob # [ 1.480388] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1305clare # [ 1.487996] systemd[1]: Starting Coldplug All udev Devices...1306bob # [ 1.482906] systemd[1]: Starting Coldplug All udev Devices...1307bob # [ 1.486687] systemd[1]: Finished Create List of Static Device Nodes.1308bob # [ 1.488814] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1309clare # [ 1.495983] systemd[1]: Finished Create List of Static Device Nodes.1310alice # [ 1.495863] systemd[1]: Starting Journal Service...1311clare # [ 1.497002] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1312clare # [ 1.497196] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1313clare # [ 1.499536] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1314bob # [ 1.501351] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1315bob # [ 1.501809] systemd[1]: Mounted Kernel Configuration File System.1316clare # [ 1.508074] [drm] pci: virtio-gpu-pci detected at 0000:00:08.01317bob # [ 1.503782] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1318clare # [ 1.508329] [drm] features: -virgl +edid -resource_blob -host_visible1319clare # [ 1.508353] [drm] features: -context_init1320clare # [ 1.508836] [drm] number of scanouts: 11321clare # [ 1.508850] [drm] number of cap sets: 01322clare # [ 1.511674] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1323clare # [ 1.511869] systemd[1]: Mounted Kernel Configuration File System.1324alice # [ 1.519588] systemd[1]: Starting Load Kernel Modules...1325alice # [ 1.519683] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1326clare # [ 1.524416] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic1327clare # [ 1.524433] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 01328clare # [ 1.532430] systemd-journald[73]: Collecting audit messages is disabled.1329alice # [ 1.529227] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1330alice # [ 1.532420] systemd[1]: Starting Coldplug All udev Devices...1331alice # [ 1.533884] systemd[1]: Finished Create List of Static Device Nodes.1332bob # [ 1.531642] systemd-journald[73]: Collecting audit messages is disabled.1333alice # [ 1.535258] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1334alice # [ 1.536664] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1335alice # [ 1.539364] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1336bob # [ 1.540952] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1337alice # [ 1.544790] [drm] pci: virtio-gpu-pci detected at 0000:00:08.01338alice # [ 1.545004] [drm] features: -virgl +edid -resource_blob -host_visible1339alice # [ 1.545009] [drm] features: -context_init1340alice # [ 1.545478] [drm] number of scanouts: 11341alice # [ 1.545493] [drm] number of cap sets: 01342alice # [ 1.549456] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1343clare # [ 1.548212] Console: switching to colour frame buffer device 160x501344bob # [ 1.545621] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1345alice # [ 1.549623] systemd[1]: Mounted Kernel Configuration File System.1346clare # [ 1.551833] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device1347bob # [ 1.547319] systemd[1]: Starting Create Static Device Nodes in /dev...1348bob # [ 1.553197] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1349clare # [ 1.560350] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1350clare # [ 1.562488] systemd[1]: Starting Create Static Device Nodes in /dev...1351bob # [ 1.561111] [drm] pci: virtio-gpu-pci detected at 0000:00:08.01352alice # [ 1.567620] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic1353alice # [ 1.567638] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 01354clare # [ 1.574260] systemd[1]: Finished Load Kernel Modules.1355bob # [ 1.569389] [drm] features: -virgl +edid -resource_blob -host_visible1356bob # [ 1.569400] [drm] features: -context_init1357bob # [ 1.569889] [drm] number of scanouts: 11358bob # [ 1.569904] [drm] number of cap sets: 01359clare # [ 1.575964] systemd[1]: Starting Apply Kernel Variables...1360bob # [ 1.577725] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic1361bob # [ 1.577741] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 01362alice # [ 1.586357] systemd-journald[73]: Collecting audit messages is disabled.1363alice # [ 1.587207] Console: switching to colour frame buffer device 160x501364alice # [ 1.593014] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device1365alice # [ 1.594980] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1366alice # [ 1.597404] systemd[1]: Starting Create Static Device Nodes in /dev...1367bob # [ 1.595923] systemd[1]: Finished Create Static Device Nodes in /dev.1368bob # [ 1.596654] systemd[1]: Reached target Preparation for Local File Systems.1369clare # [ 1.601785] systemd[1]: Finished Apply Kernel Variables.1370bob # [ 1.597333] systemd[1]: Reached target Local File Systems.1371bob # [ 1.601451] systemd[1]: Starting Rule-based Manager for Device Events and Files...1372clare # [ 1.604266] systemd[1]: Finished Create Static Device Nodes in /dev.1373clare # [ 1.604402] systemd[1]: Reached target Preparation for Local File Systems.1374clare # [ 1.604441] systemd[1]: Reached target Local File Systems.1375clare # [ 1.605522] systemd[1]: Starting Rule-based Manager for Device Events and Files...1376alice # [ 1.610098] systemd[1]: Finished Load Kernel Modules.1377bob # [ 1.605632] Console: switching to colour frame buffer device 160x501378bob # [ 1.611058] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device1379clare # [ 1.612233] systemd-modules-load[74]: Inserted module 'dm_mod'1380clare # [ 1.613090] systemd-modules-load[74]: Module 'virtio_balloon' is built in1381clare # [ 1.613804] systemd-modules-load[74]: Module 'virtio_console' is built in1382clare # [ 1.614639] systemd-modules-load[74]: Inserted module 'virtio_gpu'1383clare # [ 1.615293] systemd-modules-load[74]: Module 'virtio_rng' is built in1384alice # [ 1.619575] systemd[1]: Starting Apply Kernel Variables...1385clare # [ 1.624048] systemd[1]: Started Journal Service.1386bob # [ 1.624186] systemd[1]: Started Journal Service.1387bob # [ 1.617326] systemd-modules-load[74]: Inserted module 'dm_mod'1388bob # [ 1.620307] systemd-modules-load[74]: Module 'virtio_balloon' is built in1389clare # [ 1.627791] systemd[1]: Starting Create System Files and Directories...1390bob # [ 1.628232] systemd-modules-load[74]: Module 'virtio_console' is built in1391alice # [ 1.643710] systemd[1]: Finished Apply Kernel Variables.1392bob # [ 1.632214] systemd-modules-load[74]: Inserted module 'virtio_gpu'1393bob # [ 1.632908] systemd-modules-load[74]: Module 'virtio_rng' is built in1394bob # [ 1.633606] systemd[1]: Starting Create System Files and Directories...1395alice # [ 1.645211] systemd[1]: Finished Create Static Device Nodes in /dev.1396alice # [ 1.645340] systemd[1]: Reached target Preparation for Local File Systems.1397alice # [ 1.645375] systemd[1]: Reached target Local File Systems.1398bob # [ 1.637419] systemd[1]: Finished Load Kernel Modules.1399clare # [ 1.644479] systemd[1]: Finished Create System Files and Directories.1400alice # [ 1.651554] systemd[1]: Starting Rule-based Manager for Device Events and Files...1401clare # [ 1.670323] systemd-udevd[80]: Using default interface naming scheme 'v261'.1402bob # [ 1.665161] systemd[1]: Starting Apply Kernel Variables...1403bob # [ 1.665737] systemd[1]: Finished Create System Files and Directories.1404alice # [ 1.671452] systemd-modules-load[74]: Inserted module 'dm_mod'1405alice # [ 1.679608] systemd[1]: Started Journal Service.1406alice # [ 1.674352] systemd-modules-load[74]: Module 'virtio_balloon' is built in1407alice # [ 1.675065] systemd-modules-load[74]: Module 'virtio_console' is built in1408alice # [ 1.675747] systemd-modules-load[74]: Inserted module 'virtio_gpu'1409bob # [ 1.677149] systemd-udevd[80]: Using default interface naming scheme 'v261'.1410alice # [ 1.683392] systemd-modules-load[74]: Module 'virtio_rng' is built in1411alice # [ 1.688167] systemd[1]: Starting Create System Files and Directories...1412clare # [ 1.693830] systemd[1]: Started Rule-based Manager for Device Events and Files.1413bob # [ 1.692853] systemd[1]: Finished Apply Kernel Variables.1414alice # [ 1.710551] systemd[1]: Finished Create System Files and Directories.1415bob # [ 1.708651] systemd[1]: Started Rule-based Manager for Device Events and Files.1416alice # [ 1.717171] systemd-udevd[82]: Using default interface naming scheme 'v261'.1417alice # [ 1.740146] systemd[1]: Started Rule-based Manager for Device Events and Files.1418clare # [ 1.744550] systemd[1]: Starting Virtual Console Setup...1419bob # [ 1.760871] systemd[1]: Starting Virtual Console Setup...1420alice # [ 1.780933] systemd[1]: Starting Virtual Console Setup...1421clare # [ 1.796918] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.1422clare # [ 1.798759] systemd[1]: Finished Virtual Console Setup.1423bob # [ 1.804431] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.1424bob # [ 1.806786] systemd[1]: Finished Virtual Console Setup.1425alice # [ 1.816361] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1426alice # [ 1.818533] systemd[1]: Finished Virtual Console Setup.1427clare # [ 2.000950] systemd[1]: Finished Coldplug All udev Devices.1428clare # [ 2.001556] systemd[1]: Reached target System Initialization.1429clare # [ 2.002065] systemd[1]: Reached target Basic System.1430bob # [ 2.019437] systemd[1]: Finished Coldplug All udev Devices.1431bob # [ 2.020522] systemd[1]: Reached target System Initialization.1432bob # [ 2.024090] systemd[1]: Reached target Basic System.1433alice # [ 2.035428] systemd[1]: Finished Coldplug All udev Devices.1434alice # [ 2.036058] systemd[1]: Reached target System Initialization.1435alice # [ 2.040100] systemd[1]: Reached target Basic System.1436clare # [ 2.094015] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.1437clare # [ 2.121240] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1438bob # [ 2.126025] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.1439alice # [ 2.135490] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1440bob # [ 2.142301] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1441alice # [ 2.159661] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1442clare # [ 2.163889] systemd[1]: Found device /dev/disk/by-label/nixos.1443clare # [ 2.166741] systemd[1]: Reached target Initrd Root Device.1444clare # [ 2.172091] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1445clare # [ 2.213654] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks1446bob # [ 2.216687] systemd[1]: Found device /dev/disk/by-label/nixos.1447clare # [ 2.224213] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1448bob # [ 2.218413] systemd[1]: Reached target Initrd Root Device.1449bob # [ 2.220121] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1450alice # [ 2.227359] systemd[1]: Found device /dev/disk/by-label/nixos.1451alice # [ 2.230025] systemd[1]: Reached target Initrd Root Device.1452alice # [ 2.235566] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1453bob # [ 2.253754] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks1454alice # [ 2.263625] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks1455bob # [ 2.258556] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1456alice # [ 2.271105] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1457clare # [ 2.483170] systemd[1]: Mounting /sysroot...1458bob # [ 2.480119] systemd[1]: Mounting /sysroot...1459bob # [ 2.509292] EXT4-fs (vda): mounted filesystem b36b231d-abb2-4f41-849e-f8058b37278e r/w with ordered data mode. Quota mode: none.1460bob # [ 2.503445] systemd[1]: Mounted /sysroot.1461clare # [ 2.516940] EXT4-fs (vda): mounted filesystem 1d0e82a4-33ea-4afb-ad8f-3c9ed31b18d0 r/w with ordered data mode. Quota mode: none.1462bob # [ 2.504512] systemd[1]: Reached target Initrd Root File System.1463clare # [ 2.513742] systemd[1]: Mounted /sysroot.1464bob # [ 2.508606] systemd[1]: Mounting /sysroot/nix/.ro-store...1465clare # [ 2.515329] systemd[1]: Reached target Initrd Root File System.1466clare # [ 2.518443] systemd[1]: Starting Mountpoints Configured in the Real Root...1467bob # [ 2.518871] systemd[1]: Mounting /sysroot/nix/.rw-store...1468alice # [ 2.527199] systemd[1]: Mounting /sysroot...1469bob # [ 2.530254] systemd[1]: Mounting /sysroot/run...1470clare # [ 2.539031] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.1471clare # [ 2.545123] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...1472clare # [ 2.548422] systemd[1]: Reloading...1473alice # [ 2.560633] EXT4-fs (vda): mounted filesystem da92dee5-b767-4b22-b946-f613455bd8ff r/w with ordered data mode. Quota mode: none.1474alice # [ 2.557861] systemd[1]: Mounted /sysroot.1475alice # [ 2.559079] systemd[1]: Reached target Initrd Root File System.1476alice # [ 2.561523] systemd[1]: Starting Mountpoints Configured in the Real Root...1477bob # [ 2.557017] systemd[1]: Mounting /sysroot/tmp/shared...1478bob # [ 2.570775] systemd[1]: Mounting /sysroot/tmp/xchg...1479alice # [ 2.582001] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.1480alice # [ 2.586690] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...1481alice # [ 2.588432] systemd[1]: Reloading...1482bob # [ 2.583600] systemd[1]: Starting Mountpoints Configured in the Real Root...1483bob # [ 2.596893] systemd[1]: Mounted /sysroot/nix/.ro-store.1484bob # [ 2.599315] systemd[1]: Mounted /sysroot/nix/.rw-store.1485bob # [ 2.599894] systemd[1]: Mounted /sysroot/run.1486bob # [ 2.626377] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.1487bob # [ 2.629447] systemd[1]: Starting rw-sysroot-nix-store.service...1488bob # [ 2.630075] systemd[1]: Mounted /sysroot/tmp/shared.1489bob # [ 2.633385] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1490bob # [ 2.638861] systemd[1]: Finished rw-sysroot-nix-store.service.1491bob # [ 2.645484] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1492bob # [ 2.649211] systemd[1]: Reloading...1493clare # [ 2.715727] systemd[1]: Reloading finished in 168 ms.1494clare # [ 2.744167] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...1495clare # [ 2.746503] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...1496clare # [ 2.751467] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1497alice # [ 2.754018] systemd[1]: Reloading finished in 165 ms.1498clare # [ 2.755283] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1499clare # [ 2.764903] systemd[1]: Finished Mountpoints Configured in the Real Root.1500clare # [ 2.765627] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1501clare # [ 2.768533] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1502clare # [ 2.770584] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1503alice # [ 2.772114] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1504alice # [ 2.773780] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1505alice # [ 2.777144] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1506alice # [ 2.780141] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1507alice # [ 2.782047] systemd[1]: Finished Mountpoints Configured in the Real Root.1508alice # [ 2.783530] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1509alice # [ 2.801519] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1510alice # [ 2.802825] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1511bob # [ 2.818369] systemd[1]: Reloading finished in 171 ms.1512bob # [ 2.844820] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1513bob # [ 2.847542] systemd[1]: Mounted /sysroot/tmp/xchg.1514bob # [ 2.851637] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1515bob # [ 2.855831] systemd[1]: Starting rw-sysroot-nix-store.service...1516bob # [ 2.857680] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1517bob # [ 2.861228] systemd[1]: Finished Mountpoints Configured in the Real Root.1518bob # [ 2.864143] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1519bob # [ 2.881487] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1520bob # [ 2.882430] systemd[1]: Finished rw-sysroot-nix-store.service.1521clare # [ 2.970382] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1522alice # [ 2.971818] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1523clare # [ 2.974298] (udev-worker)[97]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/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 directory1524clare # [ 2.978244] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1525alice # [ 2.976413] (udev-worker)[96]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/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 directory1526clare # [ 2.980602] systemd[1]: Stopped Virtual Console Setup.1527clare # [ 2.984155] systemd[1]: Stopping Virtual Console Setup...1528clare # [ 2.987624] systemd[1]: Starting Virtual Console Setup...1529clare # [ 2.989319] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1530alice # [ 2.988411] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1531clare # [ 2.990488] systemd[1]: Stopped Virtual Console Setup.1532alice # [ 2.990342] systemd[1]: Stopped Virtual Console Setup.1533alice # [ 2.991175] systemd[1]: Stopping Virtual Console Setup...1534clare # [ 2.996373] systemd[1]: Starting Virtual Console Setup...1535alice # [ 2.995475] systemd[1]: Starting Virtual Console Setup...1536clare # [ 3.015341] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1537clare # [ 3.017209] systemd[1]: Finished Virtual Console Setup.1538alice # [ 3.015606] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1539alice # [ 3.017779] systemd[1]: Finished Virtual Console Setup.1540bob # [ 3.078295] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1541bob # [ 3.082842] (udev-worker)[99]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/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 directory1542bob # [ 3.090193] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1543bob # [ 3.090968] systemd[1]: Stopped Virtual Console Setup.1544bob # [ 3.095760] systemd[1]: Stopping Virtual Console Setup...1545bob # [ 3.096755] systemd[1]: Starting Virtual Console Setup...1546bob # [ 3.115036] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.1547bob # [ 3.116763] systemd[1]: Finished Virtual Console Setup.1548bob # [ 3.477999] systemd[1]: Mounting /sysroot/nix/store...1549clare # [ 3.485411] systemd[1]: Mounting /sysroot/nix/.ro-store...1550clare # [ 3.496308] systemd[1]: Mounting /sysroot/nix/.rw-store...1551clare # [ 3.502888] systemd[1]: Mounting /sysroot/run...1552clare # [ 3.517697] systemd[1]: Mounting /sysroot/tmp/shared...1553bob # [ 3.525900] systemd[1]: Mounted /sysroot/nix/store.1554alice # [ 3.531627] systemd[1]: Mounting /sysroot/nix/.ro-store...1555bob # [ 3.528577] systemd[1]: Reached target Initrd File Systems.1556bob # [ 3.531940] systemd[1]: Starting Find NixOS closure...1557alice # [ 3.540323] systemd[1]: Mounting /sysroot/nix/.rw-store...1558clare # [ 3.544624] systemd[1]: Mounting /sysroot/tmp/xchg...1559bob # [ 3.540338] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1560clare # [ 3.550958] systemd[1]: Mounted /sysroot/nix/.ro-store.1561alice # [ 3.551136] systemd[1]: Mounting /sysroot/run...1562clare # [ 3.569713] systemd[1]: Mounted /sysroot/nix/.rw-store.1563alice # [ 3.568805] systemd[1]: Mounting /sysroot/tmp/shared...1564clare # [ 3.572670] systemd[1]: Mounted /sysroot/run.1565clare # [ 3.577132] systemd[1]: Mounted /sysroot/tmp/shared.1566clare # [ 3.585022] systemd[1]: Starting rw-sysroot-nix-store.service...1567clare # [ 3.588701] systemd[1]: Mounted /sysroot/tmp/xchg.1568alice # [ 3.588319] systemd[1]: Mounting /sysroot/tmp/xchg...1569bob # [ 3.583787] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1570bob # [ 3.590505] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1571alice # [ 3.599176] systemd[1]: Mounted /sysroot/nix/.ro-store.1572clare # [ 3.602842] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1573clare # [ 3.604101] systemd[1]: Finished rw-sysroot-nix-store.service.1574alice # [ 3.605396] systemd[1]: Mounted /sysroot/nix/.rw-store.1575bob # [ 3.606912] systemd[1]: Finished Find NixOS closure.1576alice # [ 3.614626] systemd[1]: Mounted /sysroot/run.1577bob # [ 3.609714] systemd[1]: Reached target Initrd Default Target.1578bob # [ 3.612251] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1579alice # [ 3.619354] systemd[1]: Mounted /sysroot/tmp/shared.1580alice # [ 3.628575] systemd[1]: Starting rw-sysroot-nix-store.service...1581alice # [ 3.634442] systemd[1]: Mounted /sysroot/tmp/xchg.1582alice # [ 3.651568] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1583bob # [ 3.645924] systemd[1]: initrd-cleanup.service: Deactivated successfully.1584alice # [ 3.653005] systemd[1]: Finished rw-sysroot-nix-store.service.1585bob # [ 3.648124] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1586bob # [ 3.651735] systemd[1]: Stopped target Initrd Default Target.1587bob # [ 3.652758] systemd[1]: Stopped target Basic System.1588bob # [ 3.656280] systemd[1]: Stopped target Initrd Root Device.1589bob # [ 3.657116] systemd[1]: Stopped target Path Units.1590bob # [ 3.657829] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1591bob # [ 3.659075] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1592bob # [ 3.664269] systemd[1]: Stopped target Slice Units.1593bob # [ 3.664924] systemd[1]: Stopped target Socket Units.1594bob # [ 3.665552] systemd[1]: Stopped target System Initialization.1595bob # [ 3.666271] systemd[1]: Stopped target Swaps.1596bob # [ 3.666977] systemd[1]: Stopped target Timer Units.1597bob # [ 3.667591] systemd[1]: dbus.socket: Deactivated successfully.1598bob # [ 3.672183] systemd[1]: Closed D-Bus System Message Bus Socket.1599bob # [ 3.672912] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1600bob # [ 3.674921] systemd[1]: Stopped Find NixOS closure.1601bob # [ 3.676172] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1602bob # [ 3.678969] systemd[1]: Starting rw-sysroot-nix-store.service...1603bob # [ 3.682180] systemd[1]: systemd-sysctl.service: Deactivated successfully.1604bob # [ 3.683758] systemd[1]: Stopped Apply Kernel Variables.1605bob # [ 3.693200] systemd[1]: systemd-modules-load.service: Deactivated successfully.1606bob # [ 3.693977] systemd[1]: Stopped Load Kernel Modules.1607bob # [ 3.696566] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1608bob # [ 3.701606] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1609bob # [ 3.705081] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1610bob # [ 3.708402] systemd[1]: Stopped Create System Files and Directories.1611bob # [ 3.709020] systemd[1]: Stopped target Local File Systems.1612bob # [ 3.709521] systemd[1]: Stopped target Preparation for Local File Systems.1613bob # [ 3.711823] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1614bob # [ 3.712758] systemd[1]: Stopped Coldplug All udev Devices.1615bob # [ 3.713271] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1616bob # [ 3.713920] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1617bob # [ 3.714793] systemd[1]: Stopped Virtual Console Setup.1618bob # [ 3.715285] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1619bob # [ 3.715920] systemd[1]: Finished rw-sysroot-nix-store.service.1620bob # [ 3.716602] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1621bob # [ 3.717268] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1622bob # [ 3.717819] systemd[1]: systemd-udevd.service: Deactivated successfully.1623bob # [ 3.718413] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1624bob # [ 3.719072] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1625bob # [ 3.719717] systemd[1]: Closed udev Control Socket.1626bob # [ 3.728160] systemd[1]: Starting Cleanup udev Database...1627bob # [ 3.728710] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1628bob # [ 3.729597] systemd[1]: Stopped Create Static Device Nodes in /dev.1629bob # [ 3.730196] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1630bob # [ 3.730936] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1631bob # [ 3.731576] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1632bob # [ 3.736624] systemd[1]: Stopped Create List of Static Device Nodes.1633bob # [ 3.741507] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1634bob # [ 3.743541] systemd[1]: Finished Cleanup udev Database.1635bob # [ 3.744160] systemd[1]: Reached target Switch Root.1636bob # [ 3.748297] systemd[1]: Starting NixOS Activation...1637bob # [ 3.937419] initrd-nixos-activation-start[179]: booting system configuration /nix/store/x9ybgr1aficcw55a5ramy62zgm9rbx7g-nixos-system-bob-test1638bob # [ 4.005216] initrd-nixos-activation-start[179]: running activation script...1639bob # [ 4.462934] initrd-nixos-activation-start[202]: setting up /etc...1640clare # [ 4.483447] systemd[1]: Mounting /sysroot/nix/store...1641clare # [ 4.528813] systemd[1]: Mounted /sysroot/nix/store.1642clare # [ 4.531005] systemd[1]: Reached target Initrd File Systems.1643alice # [ 4.529143] systemd[1]: Mounting /sysroot/nix/store...1644clare # [ 4.534941] systemd[1]: Starting Find NixOS closure...1645clare # [ 4.544349] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1646alice # [ 4.572912] systemd[1]: Mounted /sysroot/nix/store.1647alice # [ 4.576243] systemd[1]: Reached target Initrd File Systems.1648alice # [ 4.578961] systemd[1]: Starting Find NixOS closure...1649clare # [ 4.586513] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1650clare # [ 4.587968] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1651alice # [ 4.588323] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1652clare # [ 4.602755] systemd[1]: Finished Find NixOS closure.1653clare # [ 4.603862] systemd[1]: Reached target Initrd Default Target.1654clare # [ 4.608161] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1655alice # [ 4.630118] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1656clare # [ 4.634319] systemd[1]: Stopped target Initrd Default Target.1657clare # [ 4.635745] systemd[1]: Stopped target Basic System.1658alice # [ 4.635612] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1659clare # [ 4.640438] systemd[1]: Stopped target Initrd Root Device.1660clare # [ 4.641470] systemd[1]: Stopped target Path Units.1661clare # [ 4.642167] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1662clare # [ 4.643189] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1663clare # [ 4.646106] systemd[1]: Stopped target Slice Units.1664clare # [ 4.648119] systemd[1]: Stopped target Socket Units.1665clare # [ 4.648858] systemd[1]: Stopped target System Initialization.1666clare # [ 4.652118] systemd[1]: Stopped target Swaps.1667alice # [ 4.651078] systemd[1]: Finished Find NixOS closure.1668clare # [ 4.652758] systemd[1]: Stopped target Timer Units.1669clare # [ 4.653545] systemd[1]: dbus.socket: Deactivated successfully.1670alice # [ 4.653552] systemd[1]: Reached target Initrd Default Target.1671clare # [ 4.655087] systemd[1]: Closed D-Bus System Message Bus Socket.1672alice # [ 4.655029] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1673clare # [ 4.659025] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1674clare # [ 4.659950] systemd[1]: Stopped Find NixOS closure.1675clare # [ 4.660688] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1676clare # [ 4.661877] systemd[1]: Starting rw-sysroot-nix-store.service...1677clare # [ 4.663604] systemd[1]: systemd-sysctl.service: Deactivated successfully.1678clare # [ 4.666729] systemd[1]: Stopped Apply Kernel Variables.1679clare # [ 4.667327] systemd[1]: systemd-modules-load.service: Deactivated successfully.1680clare # [ 4.679912] systemd[1]: Stopped Load Kernel Modules.1681clare # [ 4.681891] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1682clare # [ 4.682802] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1683clare # [ 4.683648] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1684clare # [ 4.689097] systemd[1]: Stopped Create System Files and Directories.1685alice # [ 4.689508] systemd[1]: initrd-cleanup.service: Deactivated successfully.1686clare # [ 4.692644] systemd[1]: Stopped target Local File Systems.1687alice # [ 4.692471] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1688clare # [ 4.694986] systemd[1]: Stopped target Preparation for Local File Systems.1689clare # [ 4.695650] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1690alice # [ 4.695014] systemd[1]: Stopped target Initrd Default Target.1691clare # [ 4.697989] systemd[1]: Stopped Coldplug All udev Devices.1692clare # [ 4.699344] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1693alice # [ 4.698406] systemd[1]: Stopped target Basic System.1694alice # [ 4.699198] systemd[1]: Stopped target Initrd Root Device.1695clare # [ 4.701044] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1696alice # [ 4.700780] systemd[1]: Stopped target Path Units.1697clare # [ 4.703111] systemd[1]: Stopped Virtual Console Setup.1698clare # [ 4.703628] systemd[1]: initrd-cleanup.service: Deactivated successfully.1699alice # [ 4.702779] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1700clare # [ 4.704930] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1701alice # [ 4.705477] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1702alice # [ 4.706524] systemd[1]: Stopped target Slice Units.1703clare # [ 4.708136] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1704alice # [ 4.707185] systemd[1]: Stopped target Socket Units.1705clare # [ 4.708809] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1706alice # [ 4.707850] systemd[1]: Stopped target System Initialization.1707clare # [ 4.709370] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1708clare # [ 4.710023] systemd[1]: Finished rw-sysroot-nix-store.service.1709clare # [ 4.711189] systemd[1]: systemd-udevd.service: Deactivated successfully.1710clare # [ 4.711885] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1711clare # [ 4.712813] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1712clare # [ 4.713462] systemd[1]: Closed udev Control Socket.1713clare # [ 4.713913] systemd[1]: Starting Cleanup udev Database...1714clare # [ 4.714408] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1715clare # [ 4.715097] systemd[1]: Stopped Create Static Device Nodes in /dev.1716clare # [ 4.715671] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1717alice # [ 4.715855] systemd[1]: Stopped target Swaps.1718alice # [ 4.718092] systemd[1]: Stopped target Timer Units.1719clare # [ 4.719509] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1720alice # [ 4.718578] systemd[1]: dbus.socket: Deactivated successfully.1721alice # [ 4.719183] systemd[1]: Closed D-Bus System Message Bus Socket.1722alice # [ 4.719725] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1723clare # [ 4.724222] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1724clare # [ 4.725063] systemd[1]: Stopped Create List of Static Device Nodes.1725bob # [ 4.721402] initrd-nixos-activation-start[202]: setting up age secrets...1726alice # [ 4.733572] systemd[1]: Stopped Find NixOS closure.1727alice # [ 4.734102] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1728alice # [ 4.734736] systemd[1]: Starting rw-sysroot-nix-store.service...1729alice # [ 4.735352] systemd[1]: systemd-sysctl.service: Deactivated successfully.1730clare # [ 4.736520] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1731clare # [ 4.737275] systemd[1]: Finished Cleanup udev Database.1732clare # [ 4.737774] systemd[1]: Reached target Switch Root.1733alice # [ 4.735982] systemd[1]: Stopped Apply Kernel Variables.1734clare # [ 4.741299] systemd[1]: Starting NixOS Activation...1735alice # [ 4.740751] systemd[1]: systemd-modules-load.service: Deactivated successfully.1736alice # [ 4.741442] systemd[1]: Stopped Load Kernel Modules.1737alice # [ 4.741913] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1738alice # [ 4.743519] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1739alice # [ 4.744813] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1740alice # [ 4.746149] systemd[1]: Stopped Create System Files and Directories.1741alice # [ 4.747312] systemd[1]: Stopped target Local File Systems.1742alice # [ 4.747835] systemd[1]: Stopped target Preparation for Local File Systems.1743alice # [ 4.748558] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1744alice # [ 4.749200] systemd[1]: Stopped Coldplug All udev Devices.1745alice # [ 4.749706] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1746alice # [ 4.750356] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1747alice # [ 4.750988] systemd[1]: Stopped Virtual Console Setup.1748alice # [ 4.751461] systemd[1]: systemd-udevd.service: Deactivated successfully.1749alice # [ 4.760135] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1750alice # [ 4.760817] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1751alice # [ 4.761665] systemd[1]: Closed udev Control Socket.1752alice # [ 4.762149] systemd[1]: Starting Cleanup udev Database...1753alice # [ 4.762648] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1754alice # [ 4.763324] systemd[1]: Stopped Create Static Device Nodes in /dev.1755alice # [ 4.763878] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1756alice # [ 4.768719] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1757alice # [ 4.769365] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1758alice # [ 4.769956] systemd[1]: Stopped Create List of Static Device Nodes.1759alice # [ 4.770497] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1760alice # [ 4.771111] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1761alice # [ 4.771641] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1762alice # [ 4.776136] systemd[1]: Finished rw-sysroot-nix-store.service.1763alice # [ 4.779051] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1764alice # [ 4.779759] systemd[1]: Finished Cleanup udev Database.1765alice # [ 4.783640] systemd[1]: Reached target Switch Root.1766alice # [ 4.784299] systemd[1]: Starting NixOS Activation...1767clare # [ 4.894233] initrd-nixos-activation-start[181]: booting system configuration /nix/store/vzgl340pr7w7ma0ckpyr42ly661hgzr4-nixos-system-clare-test1768bob # [ 4.928513] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1769bob # [ 4.930295] systemd[1]: Finished NixOS Activation.1770bob # [ 4.931106] systemd[1]: Starting Switch Root...1771alice # [ 4.952100] initrd-nixos-activation-start[179]: booting system configuration /nix/store/6wkfmmambpac0ds2gd0zwz55db65wjaa-nixos-system-alice-test1772bob # [ 4.949027] systemd[1]: Switching root.1773clare # [ 4.956045] initrd-nixos-activation-start[181]: running activation script...1774alice # [ 5.016479] initrd-nixos-activation-start[179]: running activation script...1775bob # [ 5.127997] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1776clare # [ 5.402748] initrd-nixos-activation-start[204]: setting up /etc...1777alice # [ 5.462157] initrd-nixos-activation-start[202]: setting up /etc...1778clare # [ 5.635848] initrd-nixos-activation-start[204]: setting up age secrets...1779alice # [ 5.697426] initrd-nixos-activation-start[202]: setting up age secrets...1780bob # [ 5.743253] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1781bob # [ 5.750483] systemd[1]: Detected virtualization qemu.1782bob # [ 5.752085] systemd[1]: Detected architecture arm64.1783bob # [ 5.754157] systemd[1]: Detected first boot.1784bob # [ 5.759603] systemd[1]: Initializing machine ID from random generator.1785clare # [ 5.787838] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1786clare # [ 5.789796] systemd[1]: Finished NixOS Activation.1787clare # [ 5.792070] systemd[1]: Starting Switch Root...1788clare # [ 5.809220] systemd[1]: Switching root.1789alice # [ 5.854532] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1790alice # [ 5.856148] systemd[1]: Finished NixOS Activation.1791alice # [ 5.857182] systemd[1]: Starting Switch Root...1792alice # [ 5.873181] systemd[1]: Switching root.1793clare # [ 5.986390] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1794alice # [ 6.053300] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1795bob # [ 6.049766] systemd[1]: bpf-restrict-fs: LSM BPF program attached1796bob # [ 6.215968] systemd[1]: Applying preset policy.1797clare # [ 6.558096] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1798clare # [ 6.561695] systemd[1]: Detected virtualization qemu.1799clare # [ 6.562727] systemd[1]: Detected architecture arm64.1800clare # [ 6.563913] systemd[1]: Detected first boot.1801clare # [ 6.568513] systemd[1]: Initializing machine ID from random generator.1802alice # [ 6.637640] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1803alice # [ 6.644933] systemd[1]: Detected virtualization qemu.1804alice # [ 6.646571] systemd[1]: Detected architecture arm64.1805alice # [ 6.648621] systemd[1]: Detected first boot.1806alice # [ 6.652898] systemd[1]: Initializing machine ID from random generator.1807bob # [ 6.664017] systemd[1]: Populated /etc with preset unit settings.1808clare # [ 6.801353] systemd[1]: bpf-restrict-fs: LSM BPF program attached1809clare # [ 6.930608] systemd[1]: Applying preset policy.1810alice # [ 6.939635] systemd[1]: bpf-restrict-fs: LSM BPF program attached1811alice # [ 7.124638] systemd[1]: Applying preset policy.1812bob # [ 7.128152] systemd[1]: initrd-switch-root.service: Deactivated successfully.1813bob # [ 7.129608] systemd[1]: Stopped initrd-switch-root.service.1814bob # [ 7.131903] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1815bob # [ 7.135097] systemd[1]: Created slice Slice /system/getty.1816bob # [ 7.136590] systemd[1]: Created slice User and Session Slice.1817bob # [ 7.137862] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1818bob # [ 7.139150] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1819bob # [ 7.140361] systemd[1]: Expecting device /dev/hvc0...1820bob # [ 7.141482] systemd[1]: Expecting device /dev/ttyAMA0...1821bob # [ 7.142470] systemd[1]: Reached target Local Encrypted Volumes.1822bob # [ 7.143489] systemd[1]: Stopped target initrd-fs.target.1823bob # [ 7.144411] systemd[1]: Stopped target initrd-root-fs.target.1824bob # [ 7.145488] systemd[1]: Stopped target initrd-switch-root.target.1825bob # [ 7.146527] systemd[1]: Reached target Virtual Machines and Containers.1826bob # [ 7.147609] systemd[1]: Reached target Path Units.1827bob # [ 7.148540] systemd[1]: Reached target Remote File Systems.1828bob # [ 7.149913] systemd[1]: Reached target Slice Units.1829bob # [ 7.151137] systemd[1]: Reached target Swaps.1830bob # [ 7.154462] systemd[1]: Listening on Query the User Interactively for a Password.1831bob # [ 7.158113] systemd[1]: Listening on Process Core Dump Socket.1832bob # [ 7.161066] systemd[1]: Listening on Credential Encryption/Decryption.1833bob # [ 7.164086] systemd[1]: Listening on Factory Reset Management.1834bob # [ 7.165123] systemd[1]: Listening on Hostname Service Socket.1835bob # [ 7.169687] systemd[1]: Starting Journal Log Access Socket...1836bob # [ 7.170997] systemd[1]: Listening on Journal Audit Socket.1837bob # [ 7.174818] systemd[1]: Listening on Console Output Muting Service Socket.1838bob # [ 7.176636] systemd[1]: Listening on Network Management Metrics Varlink Socket.1839bob # [ 7.178579] systemd[1]: Listening on Network Management Varlink Socket.1840bob # [ 7.180002] systemd[1]: Listening on Network Management Netlink Socket.1841bob # [ 7.182020] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1842bob # [ 7.183462] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1843bob # [ 7.185899] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1844bob # [ 7.195108] systemd[1]: Listening on Disk Repartitioning Service Socket.1845bob # [ 7.195625] systemd[1]: Listening on Resolve Monitor Varlink Socket.1846bob # [ 7.196012] systemd[1]: Listening on Resolve Service Varlink Socket.1847bob # [ 7.196380] systemd[1]: Listening on udev Control Socket.1848bob # [ 7.196739] systemd[1]: Listening on udev Varlink Socket.1849bob # [ 7.201999] systemd[1]: Mounting Huge Pages File System...1850bob # [ 7.205826] systemd[1]: Mounting POSIX Message Queue File System...1851bob # [ 7.214813] systemd[1]: Mounting Kernel Debug File System...1852bob # [ 7.221435] systemd[1]: Mounting Kernel Trace File System...1853bob # [ 7.231403] systemd[1]: Starting Create List of Static Device Nodes...1854bob # [ 7.243754] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1855bob # [ 7.245415] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1856bob # [ 7.257891] systemd[1]: Mounting Kernel Configuration File System...1857bob # [ 7.259971] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1858bob # [ 7.262488] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1859bob # [ 7.280826] systemd[1]: Starting Load Kernel Module fuse...1860bob # [ 7.289348] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671861bob # [ 7.322122] systemd[1]: Starting Journal Service...1862bob # [ 7.346044] systemd[1]: Starting Load Kernel Modules...1863bob # [ 7.363729] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1864bob # [ 7.379380] systemd[1]: Starting Remount Root and Kernel File Systems...1865bob # [ 7.390414] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1866bob # [ 7.427810] systemd[1]: Starting Coldplug All udev Devices...1867clare # [ 7.449987] systemd[1]: Populated /etc with preset unit settings.1868bob # [ 7.445486] fuse: init (API version 7.45)1869bob # [ 7.449577] EXT4-fs (vda): re-mounted b36b231d-abb2-4f41-849e-f8058b37278e.1870bob # [ 7.456649] systemd[1]: Listening on Journal Log Access Socket.1871bob # [ 7.462743] systemd[1]: Mounted Huge Pages File System.1872bob # [ 7.465914] systemd[1]: Mounted POSIX Message Queue File System.1873bob # [ 7.469413] systemd[1]: Mounted Kernel Debug File System.1874bob # [ 7.471822] systemd[1]: Mounted Kernel Trace File System.1875bob # [ 7.475600] systemd[1]: Finished Create List of Static Device Nodes.1876bob # [ 7.480894] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1877bob # [ 7.485468] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1878bob # [ 7.486154] systemd[1]: Mounted Kernel Configuration File System.1879bob # [ 7.486671] systemd[1]: modprobe@fuse.service: Deactivated successfully.1880bob # [ 7.487134] systemd[1]: Finished Load Kernel Module fuse.1881bob # [ 7.487764] systemd[1]: Finished Load Kernel Modules.1882bob # [ 7.488338] systemd[1]: Finished Remount Root and Kernel File Systems.1883bob # [ 7.488957] systemd[1]: Listening on Disk Image Download Service Socket.1884bob # [ 7.508208] systemd[1]: Mounting FUSE Control File System...1885bob # [ 7.521551] systemd[1]: Starting Firewall...1886bob # [ 7.523339] systemd-journald[296]: Collecting audit messages is enabled.1887alice # [ 7.538785] systemd[1]: Populated /etc with preset unit settings.1888bob # [ 7.533250] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1889bob # [ 7.532437] systemd[1]: Queued start job for default target Multi-User System.1890bob # [ 7.534792] systemd[1]: systemd-journald.service: Deactivated successfully.1891bob # [ 7.535603] systemd-modules-load[297]: Module 'atkbd' is built in1892bob # [ 7.541194] systemd-modules-load[297]: Module 'loop' is built in1893bob # [ 7.551697] systemd[1]: Starting Load/Save OS Random Seed...1894bob # [ 7.573329] systemd[1]: Starting Apply Kernel Variables...1895bob # [ 7.566379] systemd-oomd[298]: No swap; memory pressure usage will be degraded1896bob # [ 7.595735] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1897bob # [ 7.602533] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1898bob # [ 7.623361] systemd[1]: Started Journal Service.1899bob # [ 7.628789] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1900bob # [ 7.673442] systemd[1]: Finished Load/Save OS Random Seed.1901bob # [ 7.693327] systemd[1]: Mounted FUSE Control File System.1902bob # [ 7.697703] systemd[1]: Finished Apply Kernel Variables.1903bob # [ 7.711172] systemd[1]: Reached target First Boot Complete.1904bob # [ 7.720133] systemd[1]: Starting Flush Journal to Persistent Storage...1905bob # [ 7.723043] systemd[1]: Starting Network Name Resolution...1906bob # [ 7.771192] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1907bob # [ 7.775111] systemd[1]: Starting Create Static Device Nodes in /dev...1908bob # [ 7.788151] systemd-journald[296]: Received client request to flush runtime journal.1909clare # [ 7.838105] systemd[1]: initrd-switch-root.service: Deactivated successfully.1910clare # [ 7.838996] systemd[1]: Stopped initrd-switch-root.service.1911clare # [ 7.841123] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1912clare # [ 7.844184] systemd[1]: Created slice Slice /system/getty.1913clare # [ 7.845661] systemd[1]: Created slice User and Session Slice.1914clare # [ 7.846735] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1915clare # [ 7.848029] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1916clare # [ 7.849206] systemd[1]: Expecting device /dev/hvc0...1917clare # [ 7.850423] systemd[1]: Expecting device /dev/ttyAMA0...1918clare # [ 7.851656] systemd[1]: Reached target Local Encrypted Volumes.1919clare # [ 7.853018] systemd[1]: Stopped target initrd-fs.target.1920clare # [ 7.854252] systemd[1]: Stopped target initrd-root-fs.target.1921clare # [ 7.855525] systemd[1]: Stopped target initrd-switch-root.target.1922clare # [ 7.856861] systemd[1]: Reached target Virtual Machines and Containers.1923clare # [ 7.858219] systemd[1]: Reached target Path Units.1924clare # [ 7.859386] systemd[1]: Reached target Remote File Systems.1925clare # [ 7.860700] systemd[1]: Reached target Slice Units.1926clare # [ 7.861614] systemd[1]: Reached target Swaps.1927clare # [ 7.864834] systemd[1]: Listening on Query the User Interactively for a Password.1928clare # [ 7.868565] systemd[1]: Listening on Process Core Dump Socket.1929clare # [ 7.871420] systemd[1]: Listening on Credential Encryption/Decryption.1930clare # [ 7.874511] systemd[1]: Listening on Factory Reset Management.1931clare # [ 7.875527] systemd[1]: Listening on Hostname Service Socket.1932clare # [ 7.879519] systemd[1]: Starting Journal Log Access Socket...1933clare # [ 7.881479] systemd[1]: Listening on Journal Audit Socket.1934bob # [ 7.869419] systemd[1]: Finished Flush Journal to Persistent Storage.1935clare # [ 7.884717] systemd[1]: Listening on Console Output Muting Service Socket.1936clare # [ 7.886224] systemd[1]: Listening on Network Management Metrics Varlink Socket.1937clare # [ 7.887767] systemd[1]: Listening on Network Management Varlink Socket.1938clare # [ 7.889511] systemd[1]: Listening on Network Management Netlink Socket.1939clare # [ 7.891361] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1940clare # [ 7.892960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1941clare # [ 7.894579] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1942clare # [ 7.902457] systemd[1]: Listening on Disk Repartitioning Service Socket.1943clare # [ 7.903945] systemd[1]: Listening on Resolve Monitor Varlink Socket.1944clare # [ 7.904984] systemd[1]: Listening on Resolve Service Varlink Socket.1945clare # [ 7.906354] systemd[1]: Listening on udev Control Socket.1946clare # [ 7.907345] systemd[1]: Listening on udev Varlink Socket.1947clare # [ 7.910412] systemd[1]: Mounting Huge Pages File System...1948clare # [ 7.913695] systemd[1]: Mounting POSIX Message Queue File System...1949bob # [ 7.904070] systemd[1]: Finished Create Static Device Nodes in /dev.1950bob # [ 7.904729] systemd[1]: Reached target Preparation for Local File Systems.1951clare # [ 7.921108] systemd[1]: Mounting Kernel Debug File System...1952clare # [ 7.923859] systemd[1]: Mounting Kernel Trace File System...1953bob # [ 7.916983] systemd[1]: Starting Rule-based Manager for Device Events and Files...1954clare # [ 7.933856] systemd[1]: Starting Create List of Static Device Nodes...1955clare # [ 7.945164] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1956clare # [ 7.946551] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1957alice # [ 7.950096] systemd[1]: initrd-switch-root.service: Deactivated successfully.1958alice # [ 7.950998] systemd[1]: Stopped initrd-switch-root.service.1959alice # [ 7.953091] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1960alice # [ 7.955945] systemd[1]: Created slice Slice /system/getty.1961clare # [ 7.957764] systemd[1]: Mounting Kernel Configuration File System...1962alice # [ 7.957366] systemd[1]: Created slice User and Session Slice.1963bob # [ 7.946343] systemd-resolved[326]: Positive Trust Anchors:1964alice # [ 7.958398] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1965alice # [ 7.960050] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1966clare # [ 7.961774] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1967alice # [ 7.961162] systemd[1]: Expecting device /dev/hvc0...1968bob # [ 7.947897] systemd-resolved[326]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1969alice # [ 7.962323] systemd[1]: Expecting device /dev/ttyAMA0...1970alice # [ 7.963665] systemd[1]: Reached target Local Encrypted Volumes.1971alice # [ 7.964594] systemd[1]: Stopped target initrd-fs.target.1972bob # [ 7.952677] systemd-resolved[326]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161973alice # [ 7.966062] systemd[1]: Stopped target initrd-root-fs.target.1974clare # [ 7.968014] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1975alice # [ 7.967570] systemd[1]: Stopped target initrd-switch-root.target.1976alice # [ 7.968518] systemd[1]: Reached target Virtual Machines and Containers.1977alice # [ 7.970072] systemd[1]: Reached target Path Units.1978alice # [ 7.971478] systemd[1]: Reached target Remote File Systems.1979alice # [ 7.972346] systemd[1]: Reached target Slice Units.1980alice # [ 7.973721] systemd[1]: Reached target Swaps.1981alice # [ 7.977798] systemd[1]: Listening on Query the User Interactively for a Password.1982bob # [ 7.956250] systemd-resolved[326]: 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 test1983alice # [ 7.982296] systemd[1]: Listening on Process Core Dump Socket.1984alice # [ 7.985217] systemd[1]: Listening on Credential Encryption/Decryption.1985alice # [ 7.988268] systemd[1]: Listening on Factory Reset Management.1986alice # [ 7.989242] systemd[1]: Listening on Hostname Service Socket.1987alice # [ 7.993028] systemd[1]: Starting Journal Log Access Socket...1988alice # [ 7.994553] systemd[1]: Listening on Journal Audit Socket.1989alice # [ 7.997943] systemd[1]: Listening on Console Output Muting Service Socket.1990alice # [ 7.999057] systemd[1]: Listening on Network Management Metrics Varlink Socket.1991alice # [ 8.000472] systemd[1]: Listening on Network Management Varlink Socket.1992alice # [ 8.002061] systemd[1]: Listening on Network Management Netlink Socket.1993alice # [ 8.003964] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1994alice # [ 8.005447] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1995alice # [ 8.007010] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1996alice # [ 8.016617] systemd[1]: Listening on Disk Repartitioning Service Socket.1997alice # [ 8.017099] systemd[1]: Listening on Resolve Monitor Varlink Socket.1998alice # [ 8.017452] systemd[1]: Listening on Resolve Service Varlink Socket.1999alice # [ 8.017771] systemd[1]: Listening on udev Control Socket.2000alice # [ 8.018097] systemd[1]: Listening on udev Varlink Socket.2001alice # [ 8.023801] systemd[1]: Mounting Huge Pages File System...2002alice # [ 8.027253] systemd[1]: Mounting POSIX Message Queue File System...2003clare # [ 8.029895] systemd[1]: Starting Load Kernel Module fuse...2004alice # [ 8.030304] systemd[1]: Mounting Kernel Debug File System...2005clare # [ 8.034393] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672006alice # [ 8.039130] systemd[1]: Mounting Kernel Trace File System...2007alice # [ 8.053484] systemd[1]: Starting Create List of Static Device Nodes...2008bob # [ 8.046852] systemd-udevd[340]: Using default interface naming scheme 'v261'.2009clare # [ 8.064835] systemd[1]: Starting Journal Service...2010alice # [ 8.064306] systemd[1]: Starting Load Kernel Module 9pnet_virtio...2011alice # [ 8.066578] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2012clare # [ 8.076712] systemd[1]: Starting Load Kernel Modules...2013alice # [ 8.086488] systemd[1]: Mounting Kernel Configuration File System...2014alice # [ 8.088569] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm2015alice # [ 8.092119] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore2016clare # [ 8.097158] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2017clare # [ 8.112964] systemd[1]: Starting Remount Root and Kernel File Systems...2018clare # [ 8.117049] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2019clare # [ 8.119422] fuse: init (API version 7.45)2020clare # [ 8.144170] systemd[1]: Starting Coldplug All udev Devices...2021alice # [ 8.143001] systemd[1]: Starting Load Kernel Module fuse...2022bob # [ 8.133402] systemd[1]: Mounting /run/wrappers...2023alice # [ 8.145728] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc672024clare # [ 8.163200] systemd[1]: Listening on Journal Log Access Socket.2025alice # [ 8.169115] systemd[1]: Starting Journal Service...2026clare # [ 8.180628] systemd-journald[290]: Collecting audit messages is enabled.2027clare # [ 8.189523] systemd[1]: Mounted Huge Pages File System.2028alice # [ 8.190182] systemd[1]: Starting Load Kernel Modules...2029clare # [ 8.191742] systemd[1]: Mounted POSIX Message Queue File System.2030clare # [ 8.201690] systemd[1]: Mounted Kernel Debug File System.2031clare # [ 8.196303] systemd[1]: Queued start job for default target Multi-User System.2032clare # [ 8.197382] systemd[1]: systemd-journald.service: Deactivated successfully.2033clare # [ 8.206224] systemd[1]: Started Journal Service.2034clare # [ 8.204671] systemd-modules-load[291]: Module 'atkbd' is built in2035clare # [ 8.206375] systemd-modules-load[291]: Module 'loop' is built in2036clare # [ 8.207670] systemd[1]: Mounted Kernel Trace File System.2037clare # [ 8.213845] systemd[1]: Finished Create List of Static Device Nodes.2038alice # [ 8.220598] fuse: init (API version 7.45)2039alice # [ 8.222423] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...2040clare # [ 8.217184] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.2041clare # [ 8.221980] systemd[1]: Finished Load Kernel Module 9pnet_virtio.2042clare # [ 8.230757] EXT4-fs (vda): re-mounted 1d0e82a4-33ea-4afb-ad8f-3c9ed31b18d0.2043clare # [ 8.225693] systemd[1]: Mounted Kernel Configuration File System.2044bob # [ 8.221319] systemd[1]: Mounted /run/wrappers.2045clare # [ 8.228041] systemd[1]: modprobe@fuse.service: Deactivated successfully.2046bob # [ 8.222686] systemd[1]: Reached target Local File Systems.2047alice # [ 8.238316] systemd[1]: Starting Remount Root and Kernel File Systems...2048clare # [ 8.233847] systemd[1]: Finished Load Kernel Module fuse.2049clare # [ 8.236346] systemd[1]: Finished Load Kernel Modules.2050alice # [ 8.243682] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2051bob # [ 8.232273] systemd[1]: Listening on Boot Loader Control Service Socket.2052bob # [ 8.236335] systemd[1]: Starting register-nix-paths.service...2053clare # [ 8.244107] systemd[1]: Finished Remount Root and Kernel File Systems.2054clare # [ 8.253739] systemd[1]: Listening on Disk Image Download Service Socket.2055bob # [ 8.247828] systemd[1]: Starting Create SUID/SGID Wrappers...2056bob # [ 8.252691] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2057bob # [ 8.256057] systemd-resolved[326]: Using system hostname 'bob'.2058clare # [ 8.264276] systemd-oomd[292]: No swap; memory pressure usage will be degraded2059alice # [ 8.269312] systemd[1]: Starting Coldplug All udev Devices...2060alice # [ 8.273315] systemd[1]: Listening on Journal Log Access Socket.2061clare # [ 8.269286] systemd[1]: Mounting FUSE Control File System...2062clare # [ 8.270357] systemd[1]: Starting Firewall...2063alice # [ 8.277391] systemd[1]: Mounted Huge Pages File System.2064alice # [ 8.283740] systemd[1]: Mounted POSIX Message Queue File System.2065clare # [ 8.279436] systemd[1]: Starting Flush Journal to Persistent Storage...2066alice # [ 8.288028] systemd[1]: Mounted Kernel Debug File System.2067clare # [ 8.287808] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2068alice # [ 8.294030] systemd[1]: Mounted Kernel Trace File System.2069alice # [ 8.304187] systemd[1]: Finished Create List of Static Device Nodes.2070alice # [ 8.304847] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.2071alice # [ 8.307811] systemd[1]: Finished Load Kernel Module 9pnet_virtio.2072clare # [ 8.304977] systemd[1]: Starting Load/Save OS Random Seed...2073bob # [ 8.301945] systemd[1]: Starting Save Transient machine-id to Disk...2074alice # [ 8.312824] systemd-journald[288]: Collecting audit messages is enabled.2075alice # [ 8.316811] systemd[1]: Mounted Kernel Configuration File System.2076alice # [ 8.319107] systemd[1]: modprobe@fuse.service: Deactivated successfully.2077alice # [ 8.322534] systemd[1]: Finished Load Kernel Module fuse.2078bob # [ 8.310941] systemd[1]: Starting Create System Files and Directories...2079alice # [ 8.324454] EXT4-fs (vda): re-mounted da92dee5-b767-4b22-b946-f613455bd8ff.2080bob # [ 8.317158] systemd[1]: Started Network Name Resolution.2081bob # [ 8.319053] systemd[1]: Started Rule-based Manager for Device Events and Files.2082clare # [ 8.327659] systemd[1]: Starting Apply Kernel Variables...2083alice # [ 8.324851] systemd[1]: Queued start job for default target Multi-User System.2084alice # [ 8.334512] systemd[1]: Finished Load Kernel Modules.2085alice # [ 8.335056] systemd[1]: Started Journal Service.2086alice # [ 8.332901] systemd[1]: systemd-journald.service: Deactivated successfully.2087alice # [ 8.333753] systemd-modules-load[289]: Module 'atkbd' is built in2088alice # [ 8.334361] systemd-modules-load[289]: Module 'loop' is built in2089alice # [ 8.340290] systemd[1]: Finished Remount Root and Kernel File Systems.2090clare # [ 8.360030] systemd-journald[290]: Received client request to flush runtime journal.2091alice # [ 8.352126] systemd[1]: Listening on Disk Image Download Service Socket.2092alice # [ 8.357760] systemd[1]: Mounting FUSE Control File System...2093alice # [ 8.364139] systemd[1]: Starting Firewall...2094alice # [ 8.367173] systemd[1]: Starting Flush Journal to Persistent Storage...2095alice # [ 8.373834] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore2096alice # [ 8.396897] systemd-oomd[290]: No swap; memory pressure usage will be degraded2097alice # [ 8.406178] systemd[1]: Starting Load/Save OS Random Seed...2098alice # [ 8.423385] systemd[1]: Starting Apply Kernel Variables...2099alice # [ 8.437994] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2100alice # [ 8.440171] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2101alice # [ 8.446073] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2102bob # [ 8.444147] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2103clare # [ 8.459020] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...2104bob # [ 8.456869] systemd[1]: Finished Save Transient machine-id to Disk.2105alice # [ 8.471107] systemd-journald[288]: Received client request to flush runtime journal.2106clare # [ 8.466775] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2107clare # [ 8.477378] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.2108clare # [ 8.478093] systemd[1]: Mounted FUSE Control File System.2109clare # [ 8.478603] systemd[1]: Finished Load/Save OS Random Seed.2110clare # [ 8.479099] systemd[1]: Reached target First Boot Complete.2111clare # [ 8.479602] systemd[1]: Finished Flush Journal to Persistent Storage.2112clare # [ 8.491310] systemd[1]: Finished Apply Kernel Variables.2113clare # [ 8.495659] systemd[1]: Starting Network Name Resolution...2114bob # [ 8.547514] systemd[1]: Finished Create System Files and Directories.2115alice # [ 8.557601] systemd[1]: Mounted FUSE Control File System.2116alice # [ 8.559974] systemd[1]: Finished Load/Save OS Random Seed.2117alice # [ 8.565891] systemd[1]: Reached target First Boot Complete.2118clare # [ 8.568082] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2119bob # [ 8.563537] systemd[1]: Starting Rebuild Journal Catalog...2120alice # [ 8.569856] systemd[1]: Finished Flush Journal to Persistent Storage.2121clare # [ 8.578715] systemd[1]: Starting Create Static Device Nodes in /dev...2122alice # [ 8.582838] systemd[1]: Finished Apply Kernel Variables.2123bob # [ 8.567391] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2124alice # [ 8.586965] systemd[1]: Starting Network Name Resolution...2125alice # [ 8.629453] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.2126alice # [ 8.634672] systemd[1]: Starting Create Static Device Nodes in /dev...2127clare # [ 8.645085] systemd-resolved[325]: Positive Trust Anchors:2128clare # [ 8.646046] systemd-resolved[325]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2129clare # [ 8.649144] systemd-resolved[325]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162130clare # [ 8.652748] systemd-resolved[325]: 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 test2131clare # [ 8.681972] systemd[1]: Finished Create Static Device Nodes in /dev.2132clare # [ 8.685208] systemd[1]: Reached target Preparation for Local File Systems.2133clare # [ 8.690463] systemd[1]: Starting Rule-based Manager for Device Events and Files...2134bob # [ 8.702574] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2135alice # [ 8.727177] systemd-resolved[321]: Positive Trust Anchors:2136alice # [ 8.730024] systemd-resolved[321]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d2137alice # [ 8.732154] systemd-resolved[321]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b162138bob # [ 8.739719] systemd[1]: Finished Coldplug All udev Devices.2139alice # [ 8.736679] systemd-resolved[321]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test2140alice # [ 8.769586] systemd[1]: Finished Create Static Device Nodes in /dev.2141alice # [ 8.770741] systemd[1]: Reached target Preparation for Local File Systems.2142alice # [ 8.772908] systemd[1]: Starting Rule-based Manager for Device Events and Files...2143bob # [ 8.773642] systemd[1]: Finished Rebuild Journal Catalog.2144bob # [ 8.776066] systemd[1]: Starting Update is Completed...2145clare # [ 8.820209] systemd-udevd[340]: Using default interface naming scheme 'v261'.2146clare # [ 8.834119] systemd[1]: Mounting /run/wrappers...2147bob # [ 8.850553] systemd[1]: Finished Update is Completed.2148alice # [ 8.889179] systemd-udevd[333]: Using default interface naming scheme 'v261'.2149clare # [ 8.908356] systemd[1]: Mounted /run/wrappers.2150clare # [ 8.908960] systemd[1]: Reached target Local File Systems.2151bob # [ 8.902276] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2152clare # [ 8.912657] systemd[1]: Listening on Boot Loader Control Service Socket.2153clare # [ 8.917399] systemd[1]: Starting register-nix-paths.service...2154clare # [ 8.928299] systemd-resolved[325]: Using system hostname 'clare'.2155clare # [ 8.936485] systemd[1]: Starting Create SUID/SGID Wrappers...2156clare # [ 8.940060] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2157alice # [ 8.950070] systemd[1]: Mounting /run/wrappers...2158clare # [ 8.971918] systemd[1]: Starting Save Transient machine-id to Disk...2159clare # [ 8.975731] systemd[1]: Starting Create System Files and Directories...2160clare # [ 8.979368] systemd[1]: Started Network Name Resolution.2161alice # [ 8.994775] systemd-resolved[321]: Using system hostname 'alice'.2162alice # [ 9.003186] systemd[1]: Started Network Name Resolution.2163alice # [ 9.022235] systemd[1]: Mounted /run/wrappers.2164alice # [ 9.025069] systemd[1]: Reached target Local File Systems.2165alice # [ 9.033082] systemd[1]: Listening on Boot Loader Control Service Socket.2166alice # [ 9.036188] systemd[1]: Starting register-nix-paths.service...2167alice # [ 9.039560] systemd[1]: Starting Create SUID/SGID Wrappers...2168alice # [ 9.048214] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.2169alice # [ 9.050761] systemd[1]: Starting Save Transient machine-id to Disk...2170alice # [ 9.071619] systemd[1]: Starting Create System Files and Directories...2171clare # [ 9.101781] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2172clare # [ 9.107244] systemd[1]: Finished Save Transient machine-id to Disk.2173clare # [ 9.140995] systemd[1]: Started Rule-based Manager for Device Events and Files.2174clare # [ 9.160728] systemd[1]: Finished Create System Files and Directories.2175alice # [ 9.164950] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.2176clare # [ 9.176939] systemd[1]: Starting Rebuild Journal Catalog...2177alice # [ 9.176478] systemd[1]: Finished Save Transient machine-id to Disk.2178clare # [ 9.182982] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2179bob # [ 9.204788] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2180bob # [ 9.208870] systemd[1]: Finished Create SUID/SGID Wrappers.2181alice # [ 9.221253] systemd[1]: Started Rule-based Manager for Device Events and Files.2182bob # [ 9.232573] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2183alice # [ 9.247771] systemd[1]: Finished Create System Files and Directories.2184alice # [ 9.266332] systemd[1]: Starting Rebuild Journal Catalog...2185alice # [ 9.269542] systemd[1]: Starting Record System Boot/Shutdown in UTMP...2186bob # [ 9.286154] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2187clare # [ 9.313883] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2188clare # [ 9.374488] systemd[1]: Finished Rebuild Journal Catalog.2189clare # [ 9.385606] systemd[1]: Starting Update is Completed...2190alice # [ 9.386045] systemd[1]: Finished Record System Boot/Shutdown in UTMP.2191alice # [ 9.421051] systemd[1]: Finished Coldplug All udev Devices.2192clare # [ 9.427248] systemd[1]: Finished Coldplug All udev Devices.2193clare # [ 9.452953] systemd[1]: Finished Update is Completed.2194alice # [ 9.461926] systemd[1]: Finished Rebuild Journal Catalog.2195alice # [ 9.464360] systemd[1]: Starting Update is Completed...2196bob # [ 9.455348] systemd[1]: Finished register-nix-paths.service.2197bob # [ 9.461880] systemd[1]: Reached target System Initialization.2198bob # [ 9.462415] systemd[1]: Started Discard unused filesystem blocks once a week.2199bob # [ 9.463051] systemd[1]: Started Daily Cleanup of Temporary Directories.2200bob # [ 9.463636] systemd[1]: Reached target Timer Units.2201bob # [ 9.465921] systemd[1]: Listening on D-Bus System Message Bus Socket.2202bob # [ 9.467030] systemd[1]: Listening on Nix Daemon Socket.2203bob # [ 9.470498] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2204bob # [ 9.474463] systemd[1]: Reached target Socket Units.2205bob # [ 9.477361] systemd[1]: Reached target Basic System.2206bob # [ 9.480131] systemd[1]: Started backdoor.service.2207bob # [ 9.484176] systemd[1]: Starting Import lastlog data into lastlog2 database...2208bob # [ 9.492576] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2209alice # [ 9.522868] systemd[1]: Finished Update is Completed.2210bob # [ 9.518316] systemd[1]: Starting Post-Boot Actions...2211bob # [ 9.530499] systemd[1]: Started Reset console on configuration changes.2212bob # [ 9.586125] systemd[1]: Starting D-Bus System Message Bus...2213bob # [ 9.589617] systemd[1]: Finished Firewall.2214bob # connecting to host...2215bob # [ 9.631669] systemd[1]: Started Name Service Cache Daemon (nsncd).2216bob # [ 9.635885] nsncd[514]: Sep 08 04:41:49.451 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2217bob # [ 9.647126] systemd[1]: Finished Post-Boot Actions.2218bob # [ 9.656218] systemd[1]: Reached target Preparation for Network.2219bob # [ 9.656905] systemd[1]: Reached target Host and Network Name Lookups.2220bob # [ 9.657454] systemd[1]: Reached target User and Group Name Lookups.2221bob # [ 9.657981] systemd[1]: Listening on Network Management Resolve Hook Socket.2222bob # [ 9.666096] systemd[1]: Starting User Login Management...2223bob # [ 9.676381] systemd[1]: Starting Network Management...2224bob: Guest shell says: b'Spawning backdoor root shell...\n'2225alice # [ 9.688764] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2226clare # [ 9.691448] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs2227bob # [ 9.706043] (udev-worker)[373]: Network interface NamePolicy= disabled on kernel command line.2228bob # [ 9.711357] systemd[1]: Finished Import lastlog data into lastlog2 database.2229bob # [ 9.721847] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line.2230bob: connected to guest root shell2231bob: (connecting took 10.01 seconds)2232bob: (finished: waiting for the VM to finish booting, in 10.01 seconds)2233clare # [ 9.809157] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2234clare # [ 9.810753] systemd[1]: Finished Create SUID/SGID Wrappers.2235bob # [ 9.852916] dbus-broker-launch[524]: Looking up NSS user entry for 'systemd-timesync'...2236alice # [ 9.880557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.2237alice # [ 9.882956] systemd[1]: Finished Create SUID/SGID Wrappers.2238bob # [ 9.878147] dbus-broker-launch[524]: NSS returned no entry for 'systemd-timesync'2239bob # [ 9.879164] dbus-broker-launch[524]: Invalid user-name in /nix/store/ryqrsrky148q2rss9z72qkg357i3wzck-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2240bob # [ 9.894033] systemd-logind[542]: Watching system buttons on /dev/input/event0 (gpio-keys)2241bob # [ 9.902180] systemd-logind[542]: New seat seat0.2242bob # [ 9.906348] systemd[1]: Started User Login Management.2243bob # [ 9.906960] systemd[1]: Starting linger-users.service...2244clare # [ 9.913172] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2245alice # [ 9.926315] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.2246bob # [ 9.925619] systemd[1]: Started D-Bus System Message Bus.2247alice # [ 9.944103] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2248clare # [ 9.951402] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.2249bob # [ 9.992074] systemd[1]: linger-users.service: Deactivated successfully.2250bob # [ 9.994720] systemd[1]: Finished linger-users.service.2251bob # [ 9.995385] dbus-broker-launch[524]: Ready2252bob # [ 10.019107] mousedev: PS/2 mouse device common for all mice2253bob # [ 10.048736] cfg80211: Loading compiled-in X.509 certificates for regulatory database2254bob # [ 10.069269] systemd-logind[542]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2255bob # [ 10.092226] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2256bob # [ 10.092768] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2257bob # [ 10.097291] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22258bob # [ 10.097705] cfg80211: failed to load regulatory.db2259clare # [ 10.137618] systemd[1]: Finished register-nix-paths.service.2260clare # [ 10.140518] systemd[1]: Reached target System Initialization.2261clare # [ 10.142677] systemd[1]: Started Discard unused filesystem blocks once a week.2262clare # [ 10.145885] systemd[1]: Started Daily Cleanup of Temporary Directories.2263clare # [ 10.148378] systemd[1]: Reached target Timer Units.2264bob # [ 10.144269] systemd-networkd[543]: lo: Link UP2265clare # [ 10.150543] systemd[1]: Listening on D-Bus System Message Bus Socket.2266bob # [ 10.145989] systemd-networkd[543]: lo: Gained carrier2267clare # [ 10.154288] systemd[1]: Listening on harmonia binary cache socket.2268clare # [ 10.156264] systemd[1]: Listening on Nix Daemon Socket.2269clare # [ 10.157931] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2270bob # [ 10.152963] systemd[1]: Started Network Management.2271bob # [ 10.153492] systemd-networkd[543]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2272bob # [ 10.154806] systemd-networkd[543]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2273clare # [ 10.161713] systemd[1]: Reached target Socket Units.2274clare # [ 10.162825] systemd[1]: Reached target Basic System.2275clare # [ 10.165293] systemd[1]: Started backdoor.service.2276bob # [ 10.161075] systemd[1]: Reached target Network.2277clare # [ 10.168664] systemd[1]: Starting Import lastlog data into lastlog2 database...2278bob # [ 10.167346] systemd[1]: Reached target Network is Online.2279bob # [ 10.167862] systemd[1]: Starting ncps binary cache proxy service...2280clare # [ 10.176590] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2281bob # [ 10.171702] systemd-networkd[543]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2282bob # [ 10.176833] systemd-networkd[543]: eth1: Link UP2283bob # [ 10.177276] systemd-networkd[543]: eth1: Gained carrier2284bob # [ 10.177736] systemd-networkd[543]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2285bob # [ 10.183559] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2286bob # [ 10.187361] systemd-networkd[543]: eth0: Link UP2287bob # [ 10.187819] systemd-networkd[543]: eth0: Gained carrier2288clare # [ 10.195164] systemd[1]: Starting Post-Boot Actions...2289bob # [ 10.194855] systemd[1]: Starting Permit User Sessions...2290bob # [ 10.200583] systemd-networkd[543]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22291clare # [ 10.216160] systemd[1]: Started Reset console on configuration changes.2292alice # [ 10.226330] systemd[1]: Finished register-nix-paths.service.2293alice # [ 10.228504] systemd[1]: Reached target System Initialization.2294alice # [ 10.231976] systemd[1]: Started Discard unused filesystem blocks once a week.2295alice # [ 10.234533] systemd[1]: Started Daily Cleanup of Temporary Directories.2296alice # [ 10.238123] systemd[1]: Reached target Timer Units.2297alice # [ 10.242937] systemd[1]: Listening on D-Bus System Message Bus Socket.2298alice # [ 10.245166] systemd[1]: Listening on Nix Daemon Socket.2299alice # [ 10.245771] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2300alice # [ 10.246541] systemd[1]: Reached target Socket Units.2301alice # [ 10.247032] systemd[1]: Reached target Basic System.2302alice # [ 10.247518] systemd[1]: Started backdoor.service.2303clare # [ 10.249632] systemd[1]: Finished Firewall.2304clare # [ 10.253172] systemd[1]: Reached target Preparation for Network.2305alice # [ 10.255559] systemd[1]: Starting Import lastlog data into lastlog2 database...2306clare # [ 10.255455] systemd[1]: Listening on Network Management Resolve Hook Socket.2307alice # [ 10.259247] (udev-worker)[430]: Network interface NamePolicy= disabled on kernel command line.2308alice # [ 10.262843] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2309clare # [ 10.265430] systemd[1]: Starting D-Bus System Message Bus...2310alice # [ 10.269857] (udev-worker)[434]: Network interface NamePolicy= disabled on kernel command line.2311alice # [ 10.275103] systemd[1]: Starting Post-Boot Actions...2312bob # [ 10.278207] systemd[1]: Finished Permit User Sessions.2313alice # [ 10.289703] systemd[1]: Started Reset console on configuration changes.2314bob # [ 10.285570] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2315clare # [ 10.292345] systemd[1]: Starting Network Management...2316bob # [ 10.289940] systemd[1]: Started Getty on tty1.2317bob # [ 10.290408] systemd[1]: Reached target Login Prompts.2318alice # [ 10.296624] systemd[1]: Finished Firewall.2319clare # [ 10.308506] systemd[1]: Finished Post-Boot Actions.2320clare # [ 10.320502] nsncd[512]: Sep 08 04:41:50.142 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2321alice # [ 10.322784] systemd[1]: Reached target Preparation for Network.2322clare # [ 10.325306] systemd[1]: Started Name Service Cache Daemon (nsncd).2323clare # connecting to host...2324alice # [ 10.333593] systemd[1]: Listening on Network Management Resolve Hook Socket.2325bob # [ 10.328889] ncps-pre-start[572]: /nix/store/d2vays9afywl2r9vl08dyfc2dwclald8-ncps-0.9.4/bin/dbmate-ncps up2326clare # [ 10.343066] (udev-worker)[447]: Network interface NamePolicy= disabled on kernel command line.2327alice # [ 10.343650] systemd[1]: Starting D-Bus System Message Bus...2328clare # [ 10.352922] systemd[1]: Reached target Host and Network Name Lookups.2329alice # [ 10.352572] systemd[1]: Starting Network Management...2330alice # connecting to host...2331clare # [ 10.355705] (udev-worker)[443]: Network interface NamePolicy= disabled on kernel command line.2332clare # [ 10.365778] systemd[1]: Reached target User and Group Name Lookups.2333clare # [ 10.376434] systemd[1]: Starting User Login Management...2334clare # [ 10.383880] systemd[1]: Finished Import lastlog data into lastlog2 database.2335alice # [ 10.401430] systemd[1]: Finished Post-Boot Actions.2336alice # [ 10.436505] systemd[1]: Started Name Service Cache Daemon (nsncd).2337alice # [ 10.437122] systemd[1]: Reached target Host and Network Name Lookups.2338alice # [ 10.437662] systemd[1]: Reached target User and Group Name Lookups.2339alice # [ 10.444217] nsncd[510]: Sep 08 04:41:50.264 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2340alice # [ 10.453250] systemd[1]: Starting User Login Management...2341alice # [ 10.481744] systemd[1]: Finished Import lastlog data into lastlog2 database.2342clare # [ 10.527792] dbus-broker-launch[520]: Looking up NSS user entry for 'systemd-timesync'...2343clare # [ 10.531381] dbus-broker-launch[520]: NSS returned no entry for 'systemd-timesync'2344clare # [ 10.534222] dbus-broker-launch[520]: Invalid user-name in /nix/store/rwsibfl09ghaqnbffvh4g5z3wa0bgn81-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2345clare # [ 10.543723] systemd-logind[540]: Watching system buttons on /dev/input/event0 (gpio-keys)2346clare # [ 10.547038] systemd-logind[540]: New seat seat0.2347clare # [ 10.550701] systemd[1]: Started User Login Management.2348alice # [ 10.559305] mousedev: PS/2 mouse device common for all mice2349clare # [ 10.555507] systemd[1]: Starting linger-users.service...2350clare # [ 10.586001] systemd[1]: Started D-Bus System Message Bus.2351alice # [ 10.597220] dbus-broker-launch[518]: Looking up NSS user entry for 'systemd-timesync'...2352alice # [ 10.603105] systemd-logind[537]: Watching system buttons on /dev/input/event0 (gpio-keys)2353alice # [ 10.606046] systemd-logind[537]: New seat seat0.2354alice # [ 10.610920] systemd[1]: Started User Login Management.2355alice # [ 10.614441] systemd[1]: Starting linger-users.service...2356alice # [ 10.635160] dbus-broker-launch[518]: NSS returned no entry for 'systemd-timesync'2357alice # [ 10.638953] dbus-broker-launch[518]: Invalid user-name in /nix/store/84d99r4q8sy8ifpnv20y008yimckh3lw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2358alice # [ 10.645537] systemd-logind[537]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2359clare # [ 10.648444] systemd[1]: linger-users.service: Deactivated successfully.2360clare # [ 10.649074] systemd[1]: Finished linger-users.service.2361clare # [ 10.649764] dbus-broker-launch[520]: Ready2362bob # [ 10.646603] ncps-pre-start[586]: Creating: /var/lib/ncps/db/db.sqlite2363clare # [ 10.665752] cfg80211: Loading compiled-in X.509 certificates for regulatory database2364clare # [ 10.669344] mousedev: PS/2 mouse device common for all mice2365alice # [ 10.684383] systemd[1]: Started D-Bus System Message Bus.2366clare # [ 10.685430] systemd-logind[540]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2367clare # [ 10.698792] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2368clare # [ 10.699337] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2369bob # [ 10.690384] ncps-pre-start[586]: Applying: 20241210054814_create-narinfos-table.sql2370clare # [ 10.703865] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22371clare # [ 10.704274] cfg80211: failed to load regulatory.db2372alice # [ 10.701355] systemd[1]: linger-users.service: Deactivated successfully.2373alice # [ 10.703792] systemd[1]: Finished linger-users.service.2374bob # [ 10.698410] ncps-pre-start[586]: Applied: 20241210054814_create-narinfos-table.sql in 8.01176ms2375bob # [ 10.700505] ncps-pre-start[586]: Applying: 20241210054829_create-nars-table.sql2376alice # [ 10.716018] cfg80211: Loading compiled-in X.509 certificates for regulatory database2377bob # [ 10.707071] ncps-pre-start[586]: Applied: 20241210054829_create-nars-table.sql in 8.69612ms2378bob # [ 10.708697] ncps-pre-start[586]: Applying: 20241213014846_add-query-to-nars-table.sql2379bob # [ 10.715552] ncps-pre-start[586]: Applied: 20241213014846_add-query-to-nars-table.sql in 7.44028ms2380bob # [ 10.717327] ncps-pre-start[586]: Applying: 20251230224159_add-cascade-to-nars-fk.sql2381alice # [ 10.724369] dbus-broker-launch[518]: Ready2382bob # [ 10.727647] ncps-pre-start[586]: Applied: 20251230224159_add-cascade-to-nars-fk.sql in 10.85376ms2383bob # [ 10.729472] ncps-pre-start[586]: Applying: 20260101000000_add-config-table.sql2384clare # [ 10.742036] systemd-networkd[521]: lo: Link UP2385bob # [ 10.734994] ncps-pre-start[586]: Applied: 20260101000000_add-config-table.sql in 6.41252ms2386bob # [ 10.736874] ncps-pre-start[586]: Applying: 20260105025735_remove-redundant-indexes.sql2387alice # [ 10.750596] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2388alice # [ 10.751101] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2389clare # [ 10.746681] systemd-networkd[521]: lo: Gained carrier2390bob # [ 10.742125] ncps-pre-start[586]: Applied: 20260105025735_remove-redundant-indexes.sql in 7.17168ms2391alice # [ 10.754842] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22392alice # [ 10.755216] cfg80211: failed to load regulatory.db2393clare # [ 10.750857] systemd[1]: Started Network Management.2394clare # [ 10.751350] systemd[1]: Reached target Network.2395bob # [ 10.743898] ncps-pre-start[586]: Applying: 20260105030513_support_shared_nars_between_narinfos.sql2396clare # [ 10.755406] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2397bob # [ 10.751254] ncps-pre-start[586]: Applied: 20260105030513_support_shared_nars_between_narinfos.sql in 8.2938ms2398clare # [ 10.758888] systemd-networkd[521]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2399bob # [ 10.752695] ncps-pre-start[586]: Applying: 20260117195000_add_narinfo_de_normalized.sql2400clare # [ 10.764133] systemd-networkd[521]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2401clare # [ 10.765483] systemd-networkd[521]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2402bob # [ 10.761802] ncps-pre-start[586]: Applied: 20260117195000_add_narinfo_de_normalized.sql in 9.29988ms2403bob # [ 10.763801] ncps-pre-start[586]: Applying: 20260127223000_allow_multiple_nar_representations.sql2404clare # [ 10.772490] systemd-networkd[521]: eth0: Link UP2405clare # [ 10.772983] systemd-networkd[521]: eth0: Gained carrier2406clare # [ 10.773471] systemd[1]: Starting Permit User Sessions...2407bob # [ 10.771144] ncps-pre-start[586]: Applied: 20260127223000_allow_multiple_nar_representations.sql in 9.37152ms2408clare # [ 10.778321] systemd-networkd[521]: eth1: Link UP2409clare # [ 10.778788] systemd-networkd[521]: eth1: Gained carrier2410bob # [ 10.772814] ncps-pre-start[586]: Applying: 20260131021850_add_chunks.sql2411clare # [ 10.779260] systemd-networkd[521]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2412bob # [ 10.778954] ncps-pre-start[586]: Applied: 20260131021850_add_chunks.sql in 6.68112ms2413alice # [ 10.786039] systemd-networkd[519]: lo: Link UP2414bob # [ 10.780646] ncps-pre-start[586]: Applying: 20260205063651_add_total_chunks_to_nar_files.sql2415alice # [ 10.787358] systemd-networkd[519]: lo: Gained carrier2416clare # [ 10.792680] systemd-networkd[521]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22417bob # [ 10.787083] ncps-pre-start[586]: Applied: 20260205063651_add_total_chunks_to_nar_files.sql in 8.13064ms2418alice # [ 10.793632] systemd-networkd[519]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2419bob # [ 10.789114] ncps-pre-start[586]: Applying: 20260217071237_add_chunking_started_at_to_nar_files.sql2420alice # [ 10.798218] systemd-networkd[519]: eth1: Configuring with /etc/systemd/network/40-eth1.network.2421bob # [ 10.794538] ncps-pre-start[586]: Applied: 20260217071237_add_chunking_started_at_to_nar_files.sql in 7.48076ms2422alice # [ 10.800828] systemd[1]: Started Network Management.2423bob # [ 10.796485] ncps-pre-start[586]: Applying: 20260301000000_add_verified_at_to_nar_files.sql2424alice # [ 10.805751] systemd[1]: Reached target Network.2425alice # [ 10.806188] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...2426alice # [ 10.810191] systemd-networkd[519]: eth0: Configuring with /etc/systemd/network/99-ethernet-default-dhcp.network.2427bob # [ 10.803666] ncps-pre-start[586]: Applied: 20260301000000_add_verified_at_to_nar_files.sql in 7.85272ms2428alice # [ 10.815462] systemd-networkd[519]: eth1: Link UP2429alice # [ 10.817115] systemd-networkd[519]: eth1: Gained carrier2430alice # [ 10.817597] systemd-networkd[519]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network2431alice # [ 10.818849] systemd[1]: Starting Permit User Sessions...2432alice # [ 10.825387] systemd-networkd[519]: eth0: Link UP2433alice # [ 10.825833] systemd-networkd[519]: eth0: Gained carrier2434clare # [ 10.831273] systemd[1]: Finished Permit User Sessions.2435alice # [ 10.836595] systemd-networkd[519]: eth0: DHCPv4 address 10.0.2.15/24, gateway 10.0.2.2 acquired from 10.0.2.22436clare # [ 10.838936] systemd[1]: Started Getty on tty1.2437clare # [ 10.841402] systemd[1]: Reached target Login Prompts.2438clare # [ 10.844148] systemd[1]: Reached target Multi-User System.2439clare # [ 10.847132] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2440clare # [ 10.847797] systemd[1]: Startup finished in 723ms (kernel) + 5.346s (initrd) + 4.777s (userspace) = 10.847s.2441alice # [ 10.880935] systemd[1]: Finished Permit User Sessions.2442alice # [ 10.887474] systemd[1]: Started Getty on tty1.2443alice # [ 10.888883] systemd[1]: Reached target Login Prompts.2444alice # [ 10.890742] systemd[1]: Reached target Multi-User System.2445alice # [ 10.892436] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.2446alice # [ 10.896280] systemd[1]: Startup finished in 715ms (kernel) + 5.416s (initrd) + 4.762s (userspace) = 10.893s.2447bob # [ 10.904513] systemd[1]: Started ncps binary cache proxy service.2448bob # [ 10.908148] systemd[1]: Reached target Multi-User System.2449bob # [ 10.911853] systemd[1]: Startup finished in 729ms (kernel) + 4.512s (initrd) + 5.664s (userspace) = 10.906s.2450bob: (finished: waiting for unit ncps, in 11.36 seconds)2451bob: must succeed: systemctl status ncps2452bob: (finished: must succeed: systemctl status ncps, in 0.05 seconds)2453clare: waiting for unit harmonia.socket2454clare: waiting for the VM to finish booting2455clare: Guest shell says: b'Spawning backdoor root shell...\n'2456clare: connected to guest root shell2457clare: (connecting took 0.00 seconds)2458clare: (finished: waiting for the VM to finish booting, in 0.00 seconds)2459clare: (finished: waiting for unit harmonia.socket, in 0.09 seconds)2460alice: waiting for success: curl bob:8502/nix-cache-info2461alice: waiting for the VM to finish booting2462alice: Guest shell says: b'Spawning backdoor root shell...\n'2463alice: connected to guest root shell2464alice: (connecting took 0.00 seconds)2465alice: (finished: waiting for the VM to finish booting, in 0.00 seconds)2466bob # [ 11.270956] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input32467clare # [ 11.349888] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input32468alice # [ 11.361683] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input32469bob # [ 11.490613] systemd-networkd[543]: eth1: Gained IPv6LL2470bob # [ 11.491131] systemd-networkd[543]: eth0: Gained IPv6LL2471bob # [ 11.509654] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","log_level":"info","time":"2026-09-08T04:41:51Z","message":"logger created"}2472bob # [ 11.510826] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","xz-binary-path":"/nix/store/fklavd7qagzs74a6jp2c6rcj7zj2hfa2-xz-5.8.3-bin/bin/xz","time":"2026-09-08T04:41:51Z","message":"Using xz binary for xz decompression"}2473bob # [ 11.521401] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","operation":"auto-max-procs","time":"2026-09-08T04:41:51Z","message":"maxprocs: Leaving GOMAXPROCS=1: CPU quota undefined"}2474bob # [ 11.561040] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","time":"2026-09-08T04:41:51Z","message":"using local locks (single-instance mode)"}2475bob # [ 11.572249] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-08T04:41:51Z","message":"setting up tracer provider to discard traces"}2476bob # [ 11.576454] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-08T04:41:51Z","message":"setting up meter provider to discard metrics"}2477bob # [ 11.585846] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","otel-enabled":false,"otel-grpc-url":"","time":"2026-09-08T04:41:51Z","message":"setting up logger provider to discard logs"}2478clare # [ 11.605574] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2479bob # [ 11.601401] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","endpoint":"otlp.ncps.dev:443","time":"2026-09-08T04:41:51Z","message":"Reporting anonymous metrics to the project maintainers"}2480bob # [ 11.605775] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"warn","cmd":"serve","error":"open /var/empty/.netrc: no such file or directory","time":"2026-09-08T04:41:51Z","message":"failed to parse netrc file, proceeding without netrc authentication"}2481bob # [ 11.607598] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","path":"/var/lib/ncps","time":"2026-09-08T04:41:51Z","message":"using local storage"}2482alice # [ 11.623419] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2483clare # [ 11.637288] systemd[1]: Starting Virtual Console Setup...2484clare # [ 11.663970] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2485clare # [ 11.664756] systemd[1]: Stopped Virtual Console Setup.2486alice # [ 11.668552] systemd-logind[537]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2487clare # [ 11.671437] systemd[1]: Starting Virtual Console Setup...2488clare # [ 11.678525] systemd-logind[540]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2489alice # [ 11.679833] systemd[1]: Starting Virtual Console Setup...2490clare # [ 11.692449] systemd[1]: Starting harmonia binary cache service...2491bob # [ 11.701366] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2492bob # [ 11.727764] systemd[1]: Starting Virtual Console Setup...2493bob # [ 11.742903] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.2494bob # [ 11.745667] systemd[1]: Stopped Virtual Console Setup.2495bob # [ 11.747962] systemd[1]: Starting Virtual Console Setup...2496bob # [ 11.751555] systemd-logind[542]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2497clare # [ 11.813433] harmonia-cache[577]: 2026-09-08T04:41:51.635876Z INFO harmonia_cache: listening on inherited fd 3 (Ok([::]:5000))2498clare # [ 11.815326] harmonia-cache[577]: 2026-09-08T04:41:51.638073Z INFO actix_server::builder: starting 4 workers2499clare # [ 11.817977] harmonia-cache[577]: 2026-09-08T04:41:51.639962Z INFO harmonia_cache::systemd: systemd watchdog enabled, pinging every 7.5s2500clare # [ 11.820176] systemd[1]: Started harmonia binary cache service.2501clare # [ 11.821136] harmonia-cache[577]: 2026-09-08T04:41:51.642903Z INFO actix_server::server: Actix runtime found; starting in Actix runtime2502clare # [ 11.822543] harmonia-cache[577]: 2026-09-08T04:41:51.642928Z INFO actix_server::server: starting service: "actix-web-service-[::]:5000", workers: 4, listening on: [::]:50002503bob # [ 11.829183] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","upstream":"clare.clan","time":"2026-09-08T04:41:51Z","message":"upstream became healthy and is now available for requests"}2504bob # [ 11.833229] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","server_addr":":8502","time":"2026-09-08T04:41:51Z","message":"Server started"}2505alice # [ 12.045137] systemd-vconsole-setup[571]: Configuration of first virtual console was skipped, ignoring remaining ones.2506alice # [ 12.047608] systemd[1]: Finished Virtual Console Setup.2507clare # [ 12.089265] systemd-vconsole-setup[576]: Configuration of first virtual console was skipped, ignoring remaining ones.2508clare # [ 12.091902] systemd[1]: Finished Virtual Console Setup.2509bob # [ 12.137971] systemd-vconsole-setup[622]: Configuration of first virtual console was skipped, ignoring remaining ones.2510bob # [ 12.141587] systemd[1]: Finished Virtual Console Setup.2511clare # [ 12.194032] systemd-networkd[521]: eth1: Gained IPv6LL2512clare # [ 12.256833] systemd-networkd[521]: eth0: Gained IPv6LL2513alice # [ 12.449794] systemd-networkd[519]: eth1: Gained IPv6LL2514bob # [ 12.611254] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: 2026/09/08 04:41:52 Post "https://otlp.ncps.dev:443/v1/logs": dial tcp: lookup otlp.ncps.dev: no such host2515alice # [ 12.802396] systemd-networkd[519]: eth0: Gained IPv6LL2516alice # curl: (28) Failed to connect to bob:8502 after 135069 ms: Could not connect to server2517alice # % Total % Received % Xferd Average Speed Time Time Time Current2518alice # Dload Upload Total Spent Left Speed2519bob # [ 147.478635] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:35564","trace_id":"1dc884bbbdf4fc6c16ed0b12e652847c","span_id":"61be289a93035999","status":200,"elapsed":0.0538,"bytes":50,"time":"2026-09-08T04:44:07Z","message":"handled request"}2520alice # 0 0 0 0 0 0 0 0 0100 50 100 50 0 0 5115 0 0100 50 100 50 0 0 3549 0 0100 50 100 50 0 0 2754 0 02521alice: (finished: waiting for success: curl bob:8502/nix-cache-info, in 136.29 seconds)2522bob: waiting for success: curl clare:5000/nix-cache-info2523bob # % Total % Received % Xferd Average Speed Time Time Time Current2524bob # Dload Upload Total Spent Left Speed2525bob # 0 0 0 0 0 0 0 0 0100 51 100 51 0 0 4062 0 0100 51 100 51 0 0 3439 0 0100 51 100 51 0 0 3011 0 02526bob: (finished: waiting for success: curl clare:5000/nix-cache-info, in 0.11 seconds)2527clare: waiting for unit harmonia2528clare: (finished: waiting for unit harmonia, in 0.12 seconds)2529clare: must succeed: systemctl status harmonia2530clare: (finished: must succeed: systemctl status harmonia, in 0.03 seconds)2531clare: must succeed: nix-build --expr '2532 builtins.derivation {2533 name = "hi";2534 builder = "/bin/sh";2535 args = [ "-c" "echo hi > $out" ];2536 system = "aarch64-linux";2537 }2538' 2>&125392540clare # [ 147.954787] systemd-resolved[325]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2541clare: (finished: must succeed: nix-build --expr '2542 builtins.derivation {2543 name = "hi";2544 builder = "/bin/sh";2545 args = [ "-c" "echo hi > $out" ];2546 system = "aarch64-linux";2547 }2548' 2>&12549, in 5.11 seconds)2550alice: must succeed: nix-build --expr '2551 builtins.derivation {2552 name = "hi";2553 builder = "/bin/sh";2554 args = [ "-c" "echo hi > $out" ];2555 system = "aarch64-linux";2556 }2557' 2>&125582559alice # [ 153.035988] systemd-resolved[321]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.2560bob # [ 153.025826] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nix-cache-info","from":"[2001:db8:1::1]:60870","trace_id":"2b85e5babd2ab9ccd4a8fb713c9c111f","span_id":"46b11bf7882753f0","status":200,"elapsed":0.02696,"bytes":50,"time":"2026-09-08T04:44:12Z","message":"handled request"}2561bob # [ 157.318990] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_url":"http://clare.clan:5000/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","upstream_url":"http://clare.clan:5000","time":"2026-09-08T04:44:17Z","message":"download the narinfo from upstream"}2562bob # [ 157.366202] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-08T04:44:17Z","message":"downloading the nar from upstream"}2563bob # [ 157.378466] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"http://clare.clan:5000/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","upstream_url":"http://clare.clan:5000","nar_hash":"1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h","nar_compression":"none","nar_query":"hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-08T04:44:17Z","message":"download the nar from upstream"}2564bob # [ 157.411895] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":45.68484,"time":"2026-09-08T04:44:17Z","message":"download of nar complete"}2565bob # [ 157.436086] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","time":"2026-09-08T04:44:17Z","message":"storing narinfo and nar_file record in the database"}2566bob # [ 157.447090] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","narinfo_hash":"dijrshgr0dg50jkvhxs7kzxmvz9zci8p","nar_url":"nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","elapsed":127.59352,"time":"2026-09-08T04:44:17Z","message":"download of narinfo complete"}2567bob # [ 157.458217] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/dijrshgr0dg50jkvhxs7kzxmvz9zci8p.narinfo","from":"[2001:db8:1::1]:60870","trace_id":"55108dc5e4da7225033ebdfe8cec6a3b","span_id":"3fbe98a365eceb08","status":200,"elapsed":129.45376,"bytes":532,"time":"2026-09-08T04:44:17Z","message":"handled request"}2568bob # [ 157.464576] zcr19apx2x118lli47ka2qffilyqg46q-ncps-wrapper[591]: {"level":"info","cmd":"serve","method":"GET","request_uri":"/nar/1xmr8jicvzszfzpz46g37mlpvbzjl2wpwvl2b05psipssyp1sm8h.nar?hash=dijrshgr0dg50jkvhxs7kzxmvz9zci8p","from":"[2001:db8:1::1]:60870","trace_id":"a98757d90a59490d50c1638091c55cf4","span_id":"e6e12cb050349760","status":200,"elapsed":0.65852,"bytes":95,"time":"2026-09-08T04:44:17Z","message":"handled request"}2569alice: (finished: must succeed: nix-build --expr '2570 builtins.derivation {2571 name = "hi";2572 builder = "/bin/sh";2573 args = [ "-c" "echo hi > $out" ];2574 system = "aarch64-linux";2575 }2576' 2>&12577, in 4.62 seconds)2578(finished: run the VM test script, in 158.31 seconds)2579test script finished in 158.51s2580cleanup2581kill QemuMachine (pid 48)2582alice # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2583kill QemuMachine (pid 49)2584bob # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2585kill QemuMachine (pid 50)2586clare # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2587(finished: cleanup, in 0.37 seconds)