nixbot

builds

succeeded vm-test-run-flakelet-transfer checks.aarch64-linux.vm-transfer · build #35 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7start all VMs8a: starting vm9b: starting vm10b # Disk image does not exist, creating the virtualisation disk image...11b: QEMU running (pid 48)12b # Formatting '/build/vm-state-b/tmp.y1dsQJNeR6', fmt=raw size=107374182413b # mke2fs 1.47.4 (6-Mar-2025)14b # Discarding device blocks: 0/262144 done15b # Creating filesystem with 262144 4k blocks and 65536 inodes16b # Filesystem UUID: d85ce34a-18b8-4e79-9ccc-eb000c7ad1fd17b # Superblock backups stored on blocks:18b # 32768, 98304, 163840, 22937619a # Disk image does not exist, creating the virtualisation disk image...20b # 21a # Formatting '/build/vm-state-a/tmp.liqpqoain9', fmt=raw size=107374182422b # Allocating group tables: 0/8 done23a # mke2fs 1.47.4 (6-Mar-2025)24b # Writing inode tables: 0/8 done25a # Discarding device blocks: 0/262144 done26b # Creating journal (8192 blocks): done27a # Creating filesystem with 262144 4k blocks and 65536 inodes28b # Writing superblocks and filesystem accounting information: 0/8 done29a # Filesystem UUID: 5f8fdcde-cb6f-4667-985d-8cc812dfe97b30b # 31a # Superblock backups stored on blocks:32b # Virtualisation disk image created.33a # 32768, 98304, 163840, 22937634a: QEMU running (pid 47)35a # 36a # Allocating group tables: 0/8 done37a # Writing inode tables: 0/8 done38a # Creating journal (8192 blocks): done39a # Writing superblocks and filesystem accounting information: 0/8 done40a # 41a # Virtualisation disk image created.42(finished: start all VMs, in 0.51 seconds)43a: must succeed: mkdir -p /srv/kv && echo bucket-data > /srv/kv/web44a: waiting for the VM to finish booting45b # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]46b # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 202647b # [ 0.000000] KASLR enabled48b # [ 0.000000] random: crng init done49b # [ 0.000000] Machine model: linux,dummy-virt50b # [ 0.000000] efi: UEFI not found.51b # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT52b # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]53b # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf]54b # [ 0.000000] Zone ranges:55b # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]56b # [ 0.000000] DMA32 empty57b # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]58b # [ 0.000000] Device empty59b # [ 0.000000] Movable zone start for each node60b # [ 0.000000] Early memory node ranges61b # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]62b # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]63b # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe00000064b # [ 0.000000] psci: probing for conduit method from DT.65b # [ 0.000000] psci: PSCIv1.3 detected in firmware.66a # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]67b # [ 0.000000] psci: Using standard PSCI v0.2 function IDs68b # [ 0.000000] psci: Trusted OS migration not required69b # [ 0.000000] psci: SMC Calling Convention v1.170a # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 202671a # [ 0.000000] KASLR enabled72b # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)73a # [ 0.000000] random: crng init done74a # [ 0.000000] Machine model: linux,dummy-virt75b # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u31129676a # [ 0.000000] efi: UEFI not found.77b # [ 0.000000] Detected PIPT I-cache on CPU078b # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)79a # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT80b # [ 0.000000] CPU features: detected: GICv3 CPU interface81b # [ 0.000000] CPU features: detected: Spectre-v482a # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000013fffffff]83b # [ 0.000000] CPU features: detected: Spectre-BHB84a # [ 0.000000] NODE_DATA(0) allocated [mem 0x13fdeb740-0x13fdeeebf]85b # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3886a # [ 0.000000] Zone ranges:87b # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2388b # [ 0.000000] alternatives: applying boot alternatives89a # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000ffffffff]90a # [ 0.000000] DMA32 empty91a # [ 0.000000] Normal [mem 0x0000000100000000-0x000000013fffffff]92a # [ 0.000000] Device empty93a # [ 0.000000] Movable zone start for each node94b # [ 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/ib3ijb1h4nkfn2nqvajpzsq2kslranh8-nixos-system-b-test/init regInfo=/nix/store/m90mq5xhyr53qbhca2zby8rr8p0kkb6v-closure-info/registration console=ttyAMA0,115200n8 console=tty095a # [ 0.000000] Early memory node ranges96a # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000013fffffff]97b # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/m90mq5xhyr53qbhca2zby8rr8p0kkb6v-closure-info/registration", will be passed to user space.98b # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes99a # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000013fffffff]100b # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)101a # [ 0.000000] cma: Reserved 32 MiB at 0x00000000fe000000102b # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)103b # [ 0.000000] software IO TLB: area num 4.104a # [ 0.000000] psci: probing for conduit method from DT.105b # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)106b # [ 0.000000] Fallback order for Node 0: 0107a # [ 0.000000] psci: PSCIv1.3 detected in firmware.108b # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576109b # [ 0.000000] Policy zone: Normal110a # [ 0.000000] psci: Using standard PSCI v0.2 function IDs111b # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off112a # [ 0.000000] psci: Trusted OS migration not required113b # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1114a # [ 0.000000] psci: SMC Calling Convention v1.1115b # [ 0.000000] allocated 8388608 bytes of page_ext116b # [ 0.000000] ftrace: allocating 74754 entries in 294 pages117b # [ 0.000000] ftrace: allocated 294 pages with 4 groups118b # [ 0.000000] rcu: Hierarchical RCU implementation.119a # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)120b # [ 0.000000] rcu: RCU event tracing is enabled.121b # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.122a # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296123b # [ 0.000000] Trampoline variant of Tasks RCU enabled.124a # [ 0.000000] Detected PIPT I-cache on CPU0125b # [ 0.000000] Rude variant of Tasks RCU enabled.126b # [ 0.000000] Tracing variant of Tasks RCU enabled.127b # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.128a # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)129b # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4130a # [ 0.000000] CPU features: detected: GICv3 CPU interface131b # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.132a # [ 0.000000] CPU features: detected: Spectre-v4133a # [ 0.000000] CPU features: detected: Spectre-BHB134b # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.135b # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.136a # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38137b # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0138b # [ 0.000000] GICv3: 256 SPIs implemented139a # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23140b # [ 0.000000] GICv3: 0 Extended SPIs implemented141b # [ 0.000000] Root IRQ handler: gic_handle_irq142a # [ 0.000000] alternatives: applying boot alternatives143b # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI144b # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0145b # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000146b # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]147b # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b00000 (indirect, esz 8, psz 64K, shr 1)148b # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b10000 (flat, esz 8, psz 64K, shr 1)149b # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000150b # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000151a # [ 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/k4gaapa9y09x502f5xjqxfdkqkj18gad-nixos-system-a-test/init regInfo=/nix/store/3bkg0i8q5l4l8cf20wzppyqgdn5sm34a-closure-info/registration console=ttyAMA0,115200n8 console=tty0152b # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.153b # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns154b # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).155a # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/3bkg0i8q5l4l8cf20wzppyqgdn5sm34a-closure-info/registration", will be passed to user space.156b # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns157a # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes158b # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns159b # [ 0.000033] arm-pv: using stolen time PV160a # [ 0.000000] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)161b # [ 0.000442] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)162a # [ 0.000000] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)163b # [ 0.000686] Console: colour dummy device 80x25164b # [ 0.000694] printk: legacy console [tty0] enabled165a # [ 0.000000] software IO TLB: area num 4.166b # [ 0.000881] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)167a # [ 0.000000] software IO TLB: mapped [mem 0x00000000fa000000-0x00000000fe000000] (64MB)168b # [ 0.000888] pid_max: default: 32768 minimum: 301169a # [ 0.000000] Fallback order for Node 0: 0170b # [ 0.000980] LSM: initializing lsm=capability,landlock,yama,bpf,ima171b # [ 0.001123] landlock: Up and running.172b # [ 0.001127] Yama: becoming mindful.173a # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 1048576174b # [ 0.001597] LSM support for eBPF active175a # [ 0.000000] Policy zone: Normal176b # [ 0.001758] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)177a # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off178b # [ 0.001822] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)179b # [ 0.003419] cacheinfo: Unable to detect cache hierarchy for CPU 0180a # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1181b # [ 0.004124] rcu: Hierarchical SRCU implementation.182a # [ 0.000000] allocated 8388608 bytes of page_ext183b # [ 0.004129] rcu: Max phase no-delay instances is 1000.184a # [ 0.000000] ftrace: allocating 74754 entries in 294 pages185b # [ 0.004296] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level186a # [ 0.000000] ftrace: allocated 294 pages with 4 groups187b # [ 0.005293] fsl-mc MSI: its@8080000 domain created188b # [ 0.005395] EFI services will not be available.189a # [ 0.000000] rcu: Hierarchical RCU implementation.190b # [ 0.005558] smp: Bringing up secondary CPUs ...191a # [ 0.000000] rcu: RCU event tracing is enabled.192b # [ 0.006206] Detected PIPT I-cache on CPU1193b # [ 0.006318] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000194a # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.195b # [ 0.006455] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000196a # [ 0.000000] Trampoline variant of Tasks RCU enabled.197b # [ 0.006593] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40]198a # [ 0.000000] Rude variant of Tasks RCU enabled.199b # [ 0.007848] Detected PIPT I-cache on CPU2200a # [ 0.000000] Tracing variant of Tasks RCU enabled.201b # [ 0.007965] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000202b # [ 0.008103] GICv3: CPU2: using allocated LPI pending table @0x0000000100b60000203a # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.204b # [ 0.008239] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40]205a # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4206b # [ 0.009432] Detected PIPT I-cache on CPU3207b # [ 0.009559] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000208a # [ 0.000000] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.209b # [ 0.009695] GICv3: CPU3: using allocated LPI pending table @0x0000000100b70000210b # [ 0.009836] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40]211a # [ 0.000000] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.212b # [ 0.010438] smp: Brought up 1 node, 4 CPUs213b # [ 0.010465] SMP: Total of 4 processors activated.214b # [ 0.010468] CPU: All CPU(s) started at EL1215a # [ 0.000000] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.216b # [ 0.010478] CPU features: detected: Branch Target Identification217a # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0218b # [ 0.010481] CPU features: detected: ARMv8.4 Translation Table Level219a # [ 0.000000] GICv3: 256 SPIs implemented220a # [ 0.000000] GICv3: 0 Extended SPIs implemented221b # [ 0.010484] CPU features: detected: Instruction cache invalidation not required for I/D coherence222a # [ 0.000000] Root IRQ handler: gic_handle_irq223b # [ 0.010488] CPU features: detected: Data cache clean to the PoU not required for I/D coherence224a # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI225b # [ 0.010491] CPU features: detected: Common not Private translations226a # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0227b # [ 0.010494] CPU features: detected: CRC32 instructions228a # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000229b # [ 0.010497] CPU features: detected: Data cache clean to Point of Deep Persistence230a # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]231b # [ 0.010501] CPU features: detected: Data cache clean to Point of Persistence232b # [ 0.010504] CPU features: detected: Data independent timing control (DIT)233a # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @100b10000 (indirect, esz 8, psz 64K, shr 1)234b # [ 0.010507] CPU features: detected: E0PD235b # [ 0.010509] CPU features: detected: Enhanced Counter Virtualization236a # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @100b20000 (flat, esz 8, psz 64K, shr 1)237b # [ 0.010512] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)238a # [ 0.000000] GICv3: using LPI property table @0x0000000100b30000239b # [ 0.010515] CPU features: detected: Enhanced Virtualization Traps240b # [ 0.010518] CPU features: detected: Fine Grained Traps241a # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000100b40000242b # [ 0.010522] CPU features: detected: Generic authentication (architected QARMA5 algorithm)243a # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.244b # [ 0.010526] CPU features: detected: RCpc load-acquire (LDAPR)245b # [ 0.010529] CPU features: detected: LSE atomic instructions246a # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns247b # [ 0.010531] CPU features: detected: Privileged Access Never248a # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).249b # [ 0.010534] CPU features: detected: PMUv3250b # [ 0.010537] CPU features: detected: RAS Extension Support251b # [ 0.010540] CPU features: detected: RASv1p1 Extension Support252a # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns253b # [ 0.010542] CPU features: detected: Random Number Generator254a # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns255b # [ 0.010545] CPU features: detected: Speculation barrier (SB)256a # [ 0.000033] arm-pv: using stolen time PV257b # [ 0.010548] CPU features: detected: Stage-2 Force Write-Back258b # [ 0.010550] CPU features: detected: TLB range maintenance instructions259a # [ 0.000383] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)260b # [ 0.010555] CPU features: detected: Speculative Store Bypassing Safe (SSBS)261a # [ 0.000591] Console: colour dummy device 80x25262b # [ 0.010693] alternatives: applying system-wide alternatives263a # [ 0.000598] printk: legacy console [tty0] enabled264b # [ 0.013730] CPU features: detected: BBM Level 2 without TLB conflict abort265a # [ 0.000782] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)266a # [ 0.000789] pid_max: default: 32768 minimum: 301267b # [ 0.013997] Memory: 3910000K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233736K reserved, 32768K cma-reserved)268a # [ 0.000888] LSM: initializing lsm=capability,landlock,yama,bpf,ima269b # [ 0.015389] devtmpfs: initialized270a # [ 0.001020] landlock: Up and running.271a # [ 0.001023] Yama: becoming mindful.272b # [ 0.019173] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)273a # [ 0.001433] LSM support for eBPF active274b # [ 0.019250] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).275a # [ 0.001594] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)276b # [ 0.019429] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL277b # [ 0.019433] 0 pages in range for non-PLT usage278a # [ 0.001663] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)279b # [ 0.019435] 508320 pages in range for PLT usage280a # [ 0.002951] cacheinfo: Unable to detect cache hierarchy for CPU 0281b # [ 0.019559] pinctrl core: initialized pinctrl subsystem282a # [ 0.003677] rcu: Hierarchical SRCU implementation.283b # [ 0.020368] DMI not present or invalid.284a # [ 0.003681] rcu: Max phase no-delay instances is 1000.285b # [ 0.023825] NET: Registered PF_NETLINK/PF_ROUTE protocol family286a # [ 0.003850] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level287b # [ 0.026338] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations288a # [ 0.004945] fsl-mc MSI: its@8080000 domain created289b # [ 0.026531] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations290a # [ 0.005049] EFI services will not be available.291a # [ 0.005227] smp: Bringing up secondary CPUs ...292b # [ 0.026768] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations293a # [ 0.005951] Detected PIPT I-cache on CPU1294b # [ 0.026791] audit: initializing netlink subsys (disabled)295a # [ 0.006052] GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000296b # [ 0.027140] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1297a # [ 0.006183] GICv3: CPU1: using allocated LPI pending table @0x0000000100b50000298b # [ 0.027614] thermal_sys: Registered thermal governor 'fair_share'299a # [ 0.006313] CPU1: Booted secondary processor 0x0000000001 [0xc00fac40]300b # [ 0.027617] thermal_sys: Registered thermal governor 'bang_bang'301a # [ 0.007453] Detected PIPT I-cache on CPU2302b # [ 0.027622] thermal_sys: Registered thermal governor 'step_wise'303a # [ 0.007561] GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000304b # [ 0.027624] thermal_sys: Registered thermal governor 'user_space'305a # [ 0.007693] GICv3: CPU2: using allocated LPI pending table @0x0000000100b60000306b # [ 0.027627] thermal_sys: Registered thermal governor 'power_allocator'307b # [ 0.027726] cpuidle: using governor ladder308a # [ 0.007825] CPU2: Booted secondary processor 0x0000000002 [0xc00fac40]309b # [ 0.027753] cpuidle: using governor menu310a # [ 0.008906] Detected PIPT I-cache on CPU3311b # [ 0.027959] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.312a # [ 0.009028] GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000313b # [ 0.028188] ASID allocator initialised with 65536 entries314a # [ 0.009160] GICv3: CPU3: using allocated LPI pending table @0x0000000100b70000315b # [ 0.029383] Serial: AMBA PL011 UART driver316a # [ 0.009294] CPU3: Booted secondary processor 0x0000000003 [0xc00fac40]317b # [ 0.034680] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1318a # [ 0.009832] smp: Brought up 1 node, 4 CPUs319b # [ 0.035041] printk: console [ttyAMA0] enabled320a # [ 0.009858] SMP: Total of 4 processors activated.321a # [ 0.009861] CPU: All CPU(s) started at EL1322b # [ 0.051567] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages323a # [ 0.009870] CPU features: detected: Branch Target Identification324b # [ 0.051574] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page325a # [ 0.009873] CPU features: detected: ARMv8.4 Translation Table Level326b # [ 0.051577] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages327b # [ 0.051580] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page328a # [ 0.009876] CPU features: detected: Instruction cache invalidation not required for I/D coherence329b # [ 0.051583] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages330a # [ 0.009880] CPU features: detected: Data cache clean to the PoU not required for I/D coherence331b # [ 0.051585] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page332a # [ 0.009883] CPU features: detected: Common not Private translations333a # [ 0.009886] CPU features: detected: CRC32 instructions334b # [ 0.051588] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages335b # [ 0.051591] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page336a # [ 0.009888] CPU features: detected: Data cache clean to Point of Deep Persistence337b # [ 0.062985] fbcon: Taking over console338b # [ 0.063015] ACPI: Interpreter disabled.339a # [ 0.009891] CPU features: detected: Data cache clean to Point of Persistence340b # [ 0.065783] iommu: Default domain type: Translated341a # [ 0.009894] CPU features: detected: Data independent timing control (DIT)342a # [ 0.009897] CPU features: detected: E0PD343b # [ 0.065795] iommu: DMA domain TLB invalidation policy: strict mode344b # [ 0.073718] SCSI subsystem initialized345a # [ 0.009899] CPU features: detected: Enhanced Counter Virtualization346b # [ 0.074131] usbcore: registered new interface driver usbfs347a # [ 0.009902] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)348b # [ 0.074171] usbcore: registered new interface driver hub349a # [ 0.009905] CPU features: detected: Enhanced Virtualization Traps350b # [ 0.074190] usbcore: registered new device driver usb351a # [ 0.009908] CPU features: detected: Fine Grained Traps352b # [ 0.074539] pps_core: LinuxPPS API ver. 1 registered353a # [ 0.009910] CPU features: detected: Generic authentication (architected QARMA5 algorithm)354b # [ 0.074544] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>355a # [ 0.009914] CPU features: detected: RCpc load-acquire (LDAPR)356b # [ 0.074568] PTP clock support registered357b # [ 0.074613] EDAC MC: Ver: 3.0.0358a # [ 0.009916] CPU features: detected: LSE atomic instructions359b # [ 0.075178] scmi_core: SCMI protocol bus registered360a # [ 0.009919] CPU features: detected: Privileged Access Never361b # [ 0.076091] FPGA manager framework362b # [ 0.077389] vgaarb: loaded363a # [ 0.009921] CPU features: detected: PMUv3364a # [ 0.009924] CPU features: detected: RAS Extension Support365b # [ 0.078280] clocksource: Switched to clocksource arch_sys_counter366b # [ 0.082997] VFS: Disk quotas dquot_6.6.0367a # [ 0.009926] CPU features: detected: RASv1p1 Extension Support368a # [ 0.009928] CPU features: detected: Random Number Generator369b # [ 0.083061] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)370b # [ 0.087107] netfs: FS-Cache loaded371a # [ 0.009931] CPU features: detected: Speculation barrier (SB)372b # [ 0.087392] pnp: PnP ACPI: disabled373a # [ 0.009933] CPU features: detected: Stage-2 Force Write-Back374b # [ 0.098052] NET: Registered PF_INET protocol family375a # [ 0.009936] CPU features: detected: TLB range maintenance instructions376b # [ 0.099669] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)377a # [ 0.009939] CPU features: detected: Speculative Store Bypassing Safe (SSBS)378b # [ 0.158219] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)379a # [ 0.010074] alternatives: applying system-wide alternatives380b # [ 0.158339] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)381a # [ 0.012983] CPU features: detected: BBM Level 2 without TLB conflict abort382b # [ 0.158383] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)383b # [ 0.158630] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)384a # [ 0.013223] Memory: 3910004K/4194304K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 233732K reserved, 32768K cma-reserved)385a # [ 0.014571] devtmpfs: initialized386b # [ 0.159097] TCP: Hash tables configured (established 32768 bind 32768)387a # [ 0.017992] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)388b # [ 0.159249] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)389a # [ 0.018062] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).390b # [ 0.159311] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)391a # [ 0.018238] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL392b # [ 0.159399] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)393a # [ 0.018242] 0 pages in range for non-PLT usage394b # [ 0.159571] NET: Registered PF_UNIX/PF_LOCAL protocol family395a # [ 0.018243] 508320 pages in range for PLT usage396b # [ 0.159613] NET: Registered PF_XDP protocol family397a # [ 0.018373] pinctrl core: initialized pinctrl subsystem398b # [ 0.159637] PCI: CLS 0 bytes, default 64399a # [ 0.019162] DMI not present or invalid.400b # [ 0.160010] Trying to unpack rootfs image as initramfs...401a # [ 0.022474] NET: Registered PF_NETLINK/PF_ROUTE protocol family402b # [ 0.174790] kvm [1]: HYP mode not available403a # [ 0.025222] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations404b # [ 0.249298] Initialise system trusted keyrings405a # [ 0.025405] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations406b # [ 0.249742] workingset: timestamp_bits=42 max_order=20 bucket_order=0407a # [ 0.025628] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations408b # [ 0.250517] squashfs: version 4.0 (2009/01/31) Phillip Lougher409a # [ 0.025649] audit: initializing netlink subsys (disabled)410b # [ 0.250732] 9p: Installing v9fs 9p2000 file system support411a # [ 0.025944] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1412a # [ 0.026378] thermal_sys: Registered thermal governor 'fair_share'413a # [ 0.026381] thermal_sys: Registered thermal governor 'bang_bang'414a # [ 0.026386] thermal_sys: Registered thermal governor 'step_wise'415a # [ 0.026388] thermal_sys: Registered thermal governor 'user_space'416a # [ 0.026391] thermal_sys: Registered thermal governor 'power_allocator'417a # [ 0.026486] cpuidle: using governor ladder418a # [ 0.026510] cpuidle: using governor menu419a # [ 0.026706] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.420a # [ 0.026919] ASID allocator initialised with 65536 entries421a # [ 0.028117] Serial: AMBA PL011 UART driver422a # [ 0.033333] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1423a # [ 0.033678] printk: console [ttyAMA0] enabled424a # [ 0.038528] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages425a # [ 0.038534] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page426a # [ 0.038537] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages427a # [ 0.038540] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page428a # [ 0.038542] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages429a # [ 0.038545] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page430a # [ 0.038548] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages431b # [ 0.266037] Key type asymmetric registered432a # [ 0.038551] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page433a # [ 0.050230] fbcon: Taking over console434b # [ 0.266051] Asymmetric key parser 'x509' registered435a # [ 0.050260] ACPI: Interpreter disabled.436a # [ 0.053004] iommu: Default domain type: Translated437b # [ 0.266109] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)438a # [ 0.053016] iommu: DMA domain TLB invalidation policy: strict mode439b # [ 0.266355] io scheduler mq-deadline registered440a # [ 0.062785] SCSI subsystem initialized441b # [ 0.266360] io scheduler kyber registered442a # [ 0.063169] usbcore: registered new interface driver usbfs443a # [ 0.063194] usbcore: registered new interface driver hub444a # [ 0.063211] usbcore: registered new device driver usb445a # [ 0.063525] pps_core: LinuxPPS API ver. 1 registered446a # [ 0.063529] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>447a # [ 0.063558] PTP clock support registered448a # [ 0.063598] EDAC MC: Ver: 3.0.0449a # [ 0.064072] scmi_core: SCMI protocol bus registered450a # [ 0.064978] FPGA manager framework451a # [ 0.065846] vgaarb: loaded452a # [ 0.067113] clocksource: Switched to clocksource arch_sys_counter453a # [ 0.084379] VFS: Disk quotas dquot_6.6.0454a # [ 0.084443] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)455a # [ 0.085282] netfs: FS-Cache loaded456b # [ 0.275803] pl061_gpio 9030000.pl061: PL061 GPIO chip registered457a # [ 0.085574] pnp: PnP ACPI: disabled458a # [ 0.096760] NET: Registered PF_INET protocol family459a # [ 0.098641] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)460a # [ 0.157753] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)461a # [ 0.157818] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)462a # [ 0.157866] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)463a # [ 0.158077] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)464a # [ 0.158522] TCP: Hash tables configured (established 32768 bind 32768)465a # [ 0.158689] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)466a # [ 0.158766] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)467a # [ 0.158860] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)468a # [ 0.159059] NET: Registered PF_UNIX/PF_LOCAL protocol family469a # [ 0.159090] NET: Registered PF_XDP protocol family470a # [ 0.159170] PCI: CLS 0 bytes, default 64471b # [ 0.286345] ledtrig-cpu: registered to indicate activity on CPUs472a # [ 0.159590] Trying to unpack rootfs image as initramfs...473a # [ 0.175738] kvm [1]: HYP mode not available474b # [ 0.286928] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:475a # [ 0.251300] Initialise system trusted keyrings476a # [ 0.251721] workingset: timestamp_bits=42 max_order=20 bucket_order=0477a # [ 0.252829] squashfs: version 4.0 (2009/01/31) Phillip Lougher478b # [ 0.286950] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000479a # [ 0.252996] 9p: Installing v9fs 9p2000 file system support480b # [ 0.286966] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000481b # [ 0.286974] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000482b # [ 0.287004] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits483b # [ 0.287036] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]484a # [ 0.268455] Key type asymmetric registered485a # [ 0.268470] Asymmetric key parser 'x509' registered486b # [ 0.287181] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00487a # [ 0.268563] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)488b # [ 0.287193] pci_bus 0000:00: root bus resource [bus 00-ff]489a # [ 0.268930] io scheduler mq-deadline registered490a # [ 0.268948] io scheduler kyber registered491b # [ 0.287199] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]492b # [ 0.287204] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]493b # [ 0.287209] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]494a # [ 0.280034] pl061_gpio 9030000.pl061: PL061 GPIO chip registered495b # [ 0.287301] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint496a # [ 0.283290] ledtrig-cpu: registered to indicate activity on CPUs497a # [ 0.284015] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:498a # [ 0.284056] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000499b # [ 0.288112] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint500a # [ 0.284075] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000501a # [ 0.284086] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000502b # [ 0.288425] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]503a # [ 0.284132] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits504a # [ 0.284168] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]505a # [ 0.284296] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00506a # [ 0.284309] pci_bus 0000:00: root bus resource [bus 00-ff]507b # [ 0.288445] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]508a # [ 0.284317] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]509a # [ 0.284323] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]510a # [ 0.284329] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]511a # [ 0.284453] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint512b # [ 0.288489] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]513a # [ 0.285500] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint514a # [ 0.285987] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]515a # [ 0.286010] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]516a # [ 0.286071] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]517b # [ 0.288509] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]518a # [ 0.286095] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]519a # [ 0.287160] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint520a # [ 0.287563] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]521a # [ 0.287587] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]522a # [ 0.287639] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]523b # [ 0.289318] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint524a # [ 0.288727] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint525a # [ 0.289215] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]526b # [ 0.289629] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]527a # [ 0.289237] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]528b # [ 0.289658] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]529a # [ 0.289288] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]530a # [ 0.290376] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint531b # [ 0.289702] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]532a # [ 0.290855] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]533a # [ 0.290877] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]534b # [ 0.290583] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint535a # [ 0.290928] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]536b # [ 0.290906] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]537b # [ 0.290926] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]538b # [ 0.290969] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]539a # [ 0.292029] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint540b # [ 0.291778] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint541a # [ 0.292475] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]542b # [ 0.292116] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]543b # [ 0.292135] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]544a # [ 0.292498] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]545b # [ 0.292177] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]546a # [ 0.292555] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]547b # [ 0.292980] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint548b # [ 0.293298] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]549b # [ 0.293318] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]550a # [ 0.293651] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint551b # [ 0.293361] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]552b # [ 0.294222] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint553a # [ 0.294090] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]554b # [ 0.294581] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]555b # [ 0.294610] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]556a # [ 0.294113] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]557b # [ 0.294661] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]558b # [ 0.295490] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint559b # [ 0.295830] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]560a # [ 0.294177] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]561b # [ 0.295849] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]562b # [ 0.295891] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]563b # [ 0.295912] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]564b # [ 0.296710] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint565a # [ 0.295430] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint566b # [ 0.297047] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]567a # [ 0.295887] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]568b # [ 0.297101] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]569a # [ 0.295910] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]570a # [ 0.295960] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]571b # [ 0.297937] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint572a # [ 0.295983] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]573a # [ 0.297088] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint574a # [ 0.297540] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]575a # [ 0.297588] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]576a # [ 0.298596] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint577a # [ 0.299031] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]578b # [ 0.298258] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]579a # [ 0.299079] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]580a # [ 0.299888] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint581b # [ 0.298320] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]582a # [ 0.300247] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]583b # [ 0.299002] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint584a # [ 0.300729] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint585b # [ 0.299327] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]586a # [ 0.301218] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]587a # [ 0.301239] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]588b # [ 0.299789] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint589b # [ 0.300211] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]590a # [ 0.301288] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]591b # [ 0.300232] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]592a # [ 0.302365] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint593b # [ 0.300275] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]594a # [ 0.302789] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]595b # [ 0.301088] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint596a # [ 0.302810] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]597b # [ 0.301415] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]598a # [ 0.302859] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]599b # [ 0.301443] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]600a # [ 0.304078] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned601b # [ 0.301494] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]602a # [ 0.304089] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned603b # [ 0.302490] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned604a # [ 0.304096] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned605b # [ 0.302501] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned606a # [ 0.304194] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned607b # [ 0.302507] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned608a # [ 0.304296] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned609b # [ 0.302586] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned610a # [ 0.304389] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned611b # [ 0.302666] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned612a # [ 0.304491] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned613b # [ 0.302736] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned614a # [ 0.304591] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned615b # [ 0.302816] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned616a # [ 0.304668] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned617b # [ 0.302909] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned618b # [ 0.302979] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned619b # [ 0.303057] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned620a # [ 0.304762] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned621b # [ 0.303129] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned622a # [ 0.304841] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned623b # [ 0.303210] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned624a # [ 0.304943] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned625b # [ 0.303320] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned626b # [ 0.303398] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned627b # [ 0.303427] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned628b # [ 0.303455] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned629b # [ 0.303492] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned630b # [ 0.303522] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned631b # [ 0.303561] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned632b # [ 0.303596] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned633b # [ 0.303632] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned634b # [ 0.303662] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned635b # [ 0.303700] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned636b # [ 0.303730] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned637b # [ 0.303768] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned638b # [ 0.303796] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned639b # [ 0.303826] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned640b # [ 0.303862] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned641a # [ 0.305045] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned642b # [ 0.303892] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned643b # [ 0.303921] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned644b # [ 0.303949] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned645b # [ 0.303978] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned646b # [ 0.304007] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned647a # [ 0.305125] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned648b # [ 0.304036] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned649b # [ 0.304080] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]650b # [ 0.304087] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]651a # [ 0.305157] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned652b # [ 0.304092] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]653b # [ 0.306251] pci 0000:00:0a.0: enabling device (0000 -> 0002)654a # [ 0.305188] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned655b # [ 0.326114] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)656b # [ 0.329337] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)657b # [ 0.332498] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)658a # [ 0.305220] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned659b # [ 0.335767] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)660b # [ 0.341974] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)661b # [ 0.345003] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)662a # [ 0.305251] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned663b # [ 0.348116] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)664b # [ 0.352917] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)665b # [ 0.357201] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)666a # [ 0.305284] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned667b # [ 0.360151] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)668b # [ 0.364039] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)669a # [ 0.305315] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned670b # [ 0.376656] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled671b # [ 0.381578] msm_serial: driver initialized672b # [ 0.382102] SuperH (H)SCI(F) driver initialized673b # [ 0.382263] STM32 USART driver initialized674a # [ 0.305348] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned675b # [ 0.432008] loop: module loaded676b # [ 0.432617] virtio_blk virtio5: 4/0/0 default/read/poll queues677b # [ 0.438541] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)678a # [ 0.305381] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned679b # [ 0.444525] megasas: 07.734.00.00-rc1680b # [ 0.446582] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]681a # [ 0.305414] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned682b # [ 0.453047] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000683b # [ 0.453099] Intel/Sharp Extended Query Table at 0x0031684b # [ 0.458571] Using buffer write method685a # [ 0.305455] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned686b # [ 0.458662] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]687b # [ 0.463529] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000688a # [ 0.305488] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned689b # [ 0.463577] Intel/Sharp Extended Query Table at 0x0031690b # [ 0.468376] Using buffer write method691b # [ 0.468421] Concatenating MTD devices:692b # [ 0.468427] (0): "0.flash"693b # [ 0.468434] (1): "0.flash"694a # [ 0.305525] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned695b # [ 0.468440] into device "0.flash"696a # [ 0.305564] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned697a # [ 0.305595] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned698a # [ 0.305633] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned699a # [ 0.305665] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned700a # [ 0.305704] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned701a # [ 0.305736] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned702a # [ 0.305774] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned703a # [ 0.305807] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned704a # [ 0.305848] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]705a # [ 0.305857] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]706a # [ 0.305862] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]707a # [ 0.308560] pci 0000:00:0a.0: enabling device (0000 -> 0002)708a # [ 0.340099] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)709a # [ 0.344617] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)710a # [ 0.349562] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)711a # [ 0.355946] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)712a # [ 0.360727] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)713a # [ 0.366444] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)714a # [ 0.372490] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)715a # [ 0.377440] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)716a # [ 0.384574] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)717a # [ 0.388903] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)718a # [ 0.394785] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)719a # [ 0.409028] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled720a # [ 0.413900] msm_serial: driver initialized721a # [ 0.414433] SuperH (H)SCI(F) driver initialized722a # [ 0.414590] STM32 USART driver initialized723a # [ 0.470118] loop: module loaded724a # [ 0.470710] virtio_blk virtio5: 4/0/0 default/read/poll queues725a # [ 0.475898] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)726a # [ 0.481802] megasas: 07.734.00.00-rc1727a # [ 0.483823] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]728a # [ 0.490317] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000729a # [ 0.490360] Intel/Sharp Extended Query Table at 0x0031730a # [ 0.495822] Using buffer write method731a # [ 0.495898] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]732a # [ 0.500795] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000733a # [ 0.500835] Intel/Sharp Extended Query Table at 0x0031734a # [ 0.505592] Using buffer write method735a # [ 0.505632] Concatenating MTD devices:736a # [ 0.505639] (0): "0.flash"737a # [ 0.505645] (1): "0.flash"738a # [ 0.505650] into device "0.flash"739a # [ 0.653840] Freeing initrd memory: 27052K740b # [ 0.704017] Freeing initrd memory: 27056K741a # [ 0.673588] tun: Universal TUN/TAP device driver, 1.6742a # [ 0.682430] thunder_xcv, ver 1.0743b # [ 0.723796] tun: Universal TUN/TAP device driver, 1.6744a # [ 0.682570] thunder_bgx, ver 1.0745a # [ 0.682632] nicpf, ver 1.0746a # [ 0.684449] e1000: Intel(R) PRO/1000 Network Driver747a # [ 0.684461] e1000: Copyright (c) 1999-2006 Intel Corporation.748a # [ 0.684536] e1000e: Intel(R) PRO/1000 Network Driver749b # [ 0.732903] thunder_xcv, ver 1.0750b # [ 0.733019] thunder_bgx, ver 1.0751a # [ 0.684550] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.752b # [ 0.733077] nicpf, ver 1.0753b # [ 0.735069] e1000: Intel(R) PRO/1000 Network Driver754a # [ 0.684684] igb: Intel(R) Gigabit Ethernet Network Driver755a # [ 0.684693] igb: Copyright (c) 2007-2014 Intel Corporation.756b # [ 0.735085] e1000: Copyright (c) 1999-2006 Intel Corporation.757a # [ 0.684756] igbvf: Intel(R) Gigabit Virtual Function Network Driver758b # [ 0.735222] e1000e: Intel(R) PRO/1000 Network Driver759a # [ 0.684765] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.760b # [ 0.735237] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.761a # [ 0.685181] sky2: driver version 1.30762b # [ 0.735305] igb: Intel(R) Gigabit Ethernet Network Driver763a # [ 0.690295] ehci-pci 0000:00:0a.0: EHCI Host Controller764b # [ 0.735315] igb: Copyright (c) 2007-2014 Intel Corporation.765a # [ 0.690316] usbcore: registered new interface driver usb-storage766b # [ 0.735378] igbvf: Intel(R) Gigabit Virtual Function Network Driver767a # [ 0.690340] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1768b # [ 0.735388] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.769b # [ 0.735867] sky2: driver version 1.30770a # [ 0.690657] usbcore: registered new interface driver usbserial_generic771b # [ 0.741024] usbcore: registered new interface driver usb-storage772a # [ 0.690703] usbserial: USB Serial support registered for generic773a # [ 0.690871] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000774b # [ 0.741185] usbcore: registered new interface driver usbserial_generic775a # [ 0.692549] hv_vmbus: registering driver hyperv_keyboard776b # [ 0.741232] usbserial: USB Serial support registered for generic777a # [ 0.695263] rtc-pl031 9010000.pl031: registered as rtc0778b # [ 0.741298] ehci-pci 0000:00:0a.0: EHCI Host Controller779b # [ 0.741351] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1780a # [ 0.695329] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T08:45:01 UTC (1788165901)781a # [ 0.696277] i2c_dev: i2c /dev entries driver782b # [ 0.741979] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000783a # [ 0.699286] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00784b # [ 0.743280] hv_vmbus: registering driver hyperv_keyboard785a # [ 0.700711] hub 1-0:1.0: USB hub found786b # [ 0.746026] rtc-pl031 9010000.pl031: registered as rtc0787a # [ 0.700933] hub 1-0:1.0: 6 ports detected788a # [ 0.704966] sdhci: Secure Digital Host Controller Interface driver789b # [ 0.746091] rtc-pl031 9010000.pl031: setting system clock to 2026-08-31T08:45:01 UTC (1788165901)790a # [ 0.704980] sdhci: Copyright(c) Pierre Ossman791b # [ 0.747091] i2c_dev: i2c /dev entries driver792a # [ 0.705839] Synopsys Designware Multimedia Card Interface Driver793b # [ 0.750397] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00794a # [ 0.706987] sdhci-pltfm: SDHCI platform and OF driver helper795b # [ 0.751342] hub 1-0:1.0: USB hub found796a # [ 0.711829] hid: raw HID events driver (C) Jiri Kosina797b # [ 0.751386] hub 1-0:1.0: 6 ports detected798a # [ 0.712629] usbcore: registered new interface driver usbhid799b # [ 0.755674] sdhci: Secure Digital Host Controller Interface driver800a # [ 0.712640] usbhid: USB HID core driver801b # [ 0.755688] sdhci: Copyright(c) Pierre Ossman802a # [ 0.721723] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available803b # [ 0.756524] Synopsys Designware Multimedia Card Interface Driver804a # [ 0.726082] drop_monitor: Initializing network drop monitor service805b # [ 0.757695] sdhci-pltfm: SDHCI platform and OF driver helper806a # [ 0.726390] NET: Registered PF_INET6 protocol family807b # [ 0.762833] hid: raw HID events driver (C) Jiri Kosina808a # [ 0.728287] Segment Routing with IPv6809a # [ 0.728319] In-situ OAM (IOAM) with IPv6810b # [ 0.763812] usbcore: registered new interface driver usbhid811a # [ 0.728405] NET: Registered PF_PACKET protocol family812b # [ 0.763824] usbhid: USB HID core driver813a # [ 0.728746] 9pnet: Installing 9P2000 support814a # [ 0.734800] Key type dns_resolver registered815b # [ 0.768322] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available816a # [ 0.751777] registered taskstats version 1817a # [ 0.752218] Loading compiled-in X.509 certificates818b # [ 0.772600] drop_monitor: Initializing network drop monitor service819b # [ 0.772946] NET: Registered PF_INET6 protocol family820b # [ 0.775495] Segment Routing with IPv6821b # [ 0.775574] In-situ OAM (IOAM) with IPv6822b # [ 0.775817] NET: Registered PF_PACKET protocol family823b # [ 0.776310] 9pnet: Installing 9P2000 support824b # [ 0.783521] Key type dns_resolver registered825b # [ 0.802699] registered taskstats version 1826b # [ 0.803257] Loading compiled-in X.509 certificates827a # [ 0.773157] Demotion targets for Node 0: null828a # [ 0.773401] Key type .fscrypt registered829a # [ 0.773408] Key type fscrypt-provisioning registered830a # [ 0.773609] ima: No TPM chip found, activating TPM-bypass!831a # [ 0.773632] ima: Allocated hash algorithm: sha1832a # [ 0.773660] ima: No architecture policies found833a # [ 0.774937] input: gpio-keys as /devices/platform/gpio-keys/input/input0834b # [ 0.831636] Demotion targets for Node 0: null835b # [ 0.831970] Key type .fscrypt registered836b # [ 0.831979] Key type fscrypt-provisioning registered837b # [ 0.832240] ima: No TPM chip found, activating TPM-bypass!838b # [ 0.832266] ima: Allocated hash algorithm: sha1839b # [ 0.832328] ima: No architecture policies found840a # [ 0.800896] clk: Disabling unused clocks841b # [ 0.833903] input: gpio-keys as /devices/platform/gpio-keys/input/input0842a # [ 0.800934] PM: genpd: Disabling unused power domains843a # [ 0.805981] Freeing unused kernel memory: 4736K844a # [ 0.806204] Run /init as init process845b # [ 0.866721] clk: Disabling unused clocks846b # [ 0.866762] PM: genpd: Disabling unused power domains847b # [ 0.872465] Freeing unused kernel memory: 4736K848b # [ 0.872748] Run /init as init process849a # [ 0.837738] systemd[1]: Successfully made /usr/ read-only.850b # [ 0.913384] systemd[1]: Successfully made /usr/ read-only.851a # [ 0.947182] usb 1-1: new high-speed USB device number 2 using ehci-pci852b # [ 0.998358] usb 1-1: new high-speed USB device number 2 using ehci-pci853a # [ 1.104181] 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/input1854b # [ 1.150926] 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/input1855a # [ 1.172254] systemd[1]: systemd 261 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)856a # [ 1.172322] systemd[1]: Detected virtualization qemu.857a # [ 1.172392] systemd[1]: Detected architecture arm64.858a # [ 1.172406] systemd[1]: Running in initrd.859a # [ 1.173261] systemd[1]: Initializing machine ID from random generator.860a # [ 1.173538] systemd[1]: Hostname set to <a>.861b # [ 1.239055] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0862b # [ 1.248400] systemd[1]: systemd 261 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)863b # [ 1.248472] systemd[1]: Detected virtualization qemu.864b # [ 1.248550] systemd[1]: Detected architecture arm64.865b # [ 1.248566] systemd[1]: Running in initrd.866b # [ 1.249452] systemd[1]: Initializing machine ID from random generator.867b # [ 1.249849] systemd[1]: Hostname set to <b>.868a # [ 1.227979] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0869b # [ 1.358361] usb 1-2: new high-speed USB device number 3 using ehci-pci870a # [ 1.347187] usb 1-2: new high-speed USB device number 3 using ehci-pci871a # [ 1.429190] systemd[1]: bpf-restrict-fs: LSM BPF program attached872b # [ 1.473204] systemd[1]: bpf-restrict-fs: LSM BPF program attached873b # [ 1.516573] 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/input2874b # [ 1.517190] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0875b # [ 1.542530] systemd[1]: Queued start job for default target Initrd Default Target.876a # [ 1.501357] 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/input2877a # [ 1.501924] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0878b # [ 1.561331] systemd[1]: Created slice Slice /system/modprobe.879b # [ 1.561593] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.880b # [ 1.561630] systemd[1]: Expecting device /dev/disk/by-label/nixos...881b # [ 1.561655] systemd[1]: Reached target Path Units.882b # [ 1.561672] systemd[1]: Reached target Slice Units.883b # [ 1.561688] systemd[1]: Reached target Swaps.884b # [ 1.561706] systemd[1]: Reached target Timer Units.885b # [ 1.561879] systemd[1]: Listening on D-Bus System Message Bus Socket.886b # [ 1.562044] systemd[1]: Listening on Journal Socket (/dev/log).887b # [ 1.562204] systemd[1]: Listening on Journal Sockets.888b # [ 1.562452] systemd[1]: Listening on udev Control Socket.889b # [ 1.562550] systemd[1]: Listening on udev Kernel Socket.890a # [ 1.542391] systemd[1]: Queued start job for default target Initrd Default Target.891b # [ 1.562570] systemd[1]: Reached target Socket Units.892b # [ 1.564540] systemd[1]: Starting Create List of Static Device Nodes...893b # [ 1.566487] systemd[1]: Starting Load Kernel Module 9pnet_virtio...894b # [ 1.566561] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs895b # [ 1.568356] systemd[1]: Mounting Kernel Configuration File System...896b # [ 1.596870] systemd[1]: Starting Journal Service...897b # [ 1.598928] systemd[1]: Starting Load Kernel Modules...898b # [ 1.599039] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os899b # [ 1.600525] systemd[1]: Starting Coldplug All udev Devices...900b # [ 1.606511] systemd[1]: Finished Create List of Static Device Nodes.901a # [ 1.567977] systemd[1]: Created slice Slice /system/modprobe.902b # [ 1.607731] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.903a # [ 1.568426] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.904b # [ 1.608104] systemd[1]: Finished Load Kernel Module 9pnet_virtio.905a # [ 1.568482] systemd[1]: Expecting device /dev/disk/by-label/nixos...906b # [ 1.608394] systemd[1]: Mounted Kernel Configuration File System.907a # [ 1.568526] systemd[1]: Reached target Path Units.908a # [ 1.568558] systemd[1]: Reached target Slice Units.909b # [ 1.612515] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...910a # [ 1.568586] systemd[1]: Reached target Swaps.911a # [ 1.568613] systemd[1]: Reached target Timer Units.912a # [ 1.568895] systemd[1]: Listening on D-Bus System Message Bus Socket.913a # [ 1.569179] systemd[1]: Listening on Journal Socket (/dev/log).914a # [ 1.569440] systemd[1]: Listening on Journal Sockets.915a # [ 1.569703] systemd[1]: Listening on udev Control Socket.916b # [ 1.633060] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.917a # [ 1.569852] systemd[1]: Listening on udev Kernel Socket.918a # [ 1.569887] systemd[1]: Reached target Socket Units.919a # [ 1.572667] systemd[1]: Starting Create List of Static Device Nodes...920b # [ 1.637213] systemd[1]: Starting Create Static Device Nodes in /dev...921a # [ 1.575601] systemd[1]: Starting Load Kernel Module 9pnet_virtio...922a # [ 1.575713] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs923b # [ 1.644481] systemd-journald[94]: Collecting audit messages is disabled.924a # [ 1.578551] systemd[1]: Mounting Kernel Configuration File System...925b # [ 1.646672] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.926a # [ 1.608125] systemd[1]: Starting Journal Service...927b # [ 1.646998] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev928a # [ 1.610791] systemd[1]: Starting Load Kernel Modules...929b # [ 1.653611] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0930b # [ 1.653826] [drm] features: -virgl +edid -resource_blob -host_visible931a # [ 1.610949] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os932b # [ 1.653832] [drm] features: -context_init933b # [ 1.654800] [drm] number of scanouts: 1934b # [ 1.654823] [drm] number of cap sets: 0935a # [ 1.617830] systemd[1]: Starting Coldplug All udev Devices...936b # [ 1.662938] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic937a # [ 1.621911] systemd[1]: Finished Create List of Static Device Nodes.938a # [ 1.625055] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.939a # [ 1.627385] systemd[1]: Finished Load Kernel Module 9pnet_virtio.940a # [ 1.629641] systemd[1]: Mounted Kernel Configuration File System.941b # [ 1.662960] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0942b # [ 1.665228] Console: switching to colour frame buffer device 160x50943a # [ 1.635499] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...944b # [ 1.671912] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device945b # [ 1.690404] systemd[1]: Finished Load Kernel Modules.946b # [ 1.694457] systemd[1]: Starting Apply Kernel Variables...947b # [ 1.696836] systemd[1]: Finished Create Static Device Nodes in /dev.948b # [ 1.698043] systemd[1]: Reached target Preparation for Local File Systems.949b # [ 1.698484] systemd[1]: Reached target Local File Systems.950a # [ 1.659670] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.951a # [ 1.661588] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev952a # [ 1.661972] systemd-journald[95]: Collecting audit messages is disabled.953b # [ 1.705255] systemd[1]: Starting Rule-based Manager for Device Events and Files...954a # [ 1.666487] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0955a # [ 1.666656] [drm] features: -virgl +edid -resource_blob -host_visible956a # [ 1.666670] [drm] features: -context_init957a # [ 1.668371] [drm] number of scanouts: 1958a # [ 1.668400] [drm] number of cap sets: 0959a # [ 1.671042] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.960a # [ 1.673432] systemd[1]: Starting Create Static Device Nodes in /dev...961a # [ 1.675613] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic962a # [ 1.675630] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0963b # [ 1.726923] systemd[1]: Started Journal Service.964b # [ 1.725278] systemd-modules-load[95]: Using 4 probe threads965b # [ 1.730589] systemd-modules-load[95]: Module 'virtio_balloon' is built in966b # [ 1.732436] systemd-modules-load[95]: Module 'virtio_console' is built in967a # [ 1.688042] Console: switching to colour frame buffer device 160x50968b # [ 1.736766] systemd-modules-load[95]: Module 'virtio_rng' is built in969a # [ 1.696855] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device970b # [ 1.739834] systemd-modules-load[95]: Inserted module 'dm_mod'971b # [ 1.741546] systemd-modules-load[95]: Inserted module 'virtio_gpu'972b # [ 1.743222] systemd[1]: Starting Create System Files and Directories...973b # [ 1.745959] systemd[1]: Finished Apply Kernel Variables.974a # [ 1.708562] systemd[1]: Finished Create Static Device Nodes in /dev.975a # [ 1.709315] systemd[1]: Reached target Preparation for Local File Systems.976a # [ 1.709693] systemd[1]: Reached target Local File Systems.977a # [ 1.717010] systemd[1]: Starting Rule-based Manager for Device Events and Files...978a # [ 1.718799] systemd[1]: Finished Load Kernel Modules.979a # [ 1.722733] systemd[1]: Starting Apply Kernel Variables...980b # [ 1.764303] systemd-udevd[107]: Using default interface naming scheme 'v261'.981b # [ 1.768379] systemd[1]: Finished Create System Files and Directories.982b # [ 1.780397] systemd[1]: Started Rule-based Manager for Device Events and Files.983a # [ 1.747770] systemd[1]: Started Journal Service.984a # [ 1.746682] systemd-modules-load[96]: Using 4 probe threads985a # [ 1.748126] systemd-modules-load[96]: Module 'virtio_balloon' is built in986a # [ 1.750464] systemd-modules-load[96]: Module 'virtio_console' is built in987a # [ 1.752710] systemd-modules-load[96]: Module 'virtio_rng' is built in988a # [ 1.753920] systemd-modules-load[96]: Inserted module 'dm_mod'989a # [ 1.756688] systemd-modules-load[96]: Inserted module 'virtio_gpu'990a # [ 1.757833] systemd[1]: Starting Create System Files and Directories...991b # [ 1.801491] systemd[1]: Starting Virtual Console Setup...992a # [ 1.773799] systemd[1]: Finished Apply Kernel Variables.993a # [ 1.779819] systemd[1]: Finished Create System Files and Directories.994a # [ 1.785960] systemd-udevd[106]: Using default interface naming scheme 'v261'.995a # [ 1.803149] systemd[1]: Started Rule-based Manager for Device Events and Files.996a # [ 1.820347] systemd[1]: Starting Virtual Console Setup...997b # [ 1.863365] systemd-vconsole-setup[129]: Configuration of first virtual console was skipped, ignoring remaining ones.998b # [ 1.868475] systemd[1]: Finished Virtual Console Setup.999a # [ 1.883193] systemd-vconsole-setup[129]: Configuration of first virtual console was skipped, ignoring remaining ones.1000a # [ 1.886946] systemd[1]: Finished Virtual Console Setup.1001b # [ 2.279276] systemd[1]: Finished Coldplug All udev Devices.1002b # [ 2.282189] systemd[1]: Reached target System Initialization.1003b # [ 2.284833] systemd[1]: Reached target Basic System.1004a # [ 2.277215] systemd[1]: Finished Coldplug All udev Devices.1005a # [ 2.279838] systemd[1]: Reached target System Initialization.1006a # [ 2.282473] systemd[1]: Reached target Basic System.1007b # [ 2.462939] (udev-worker)[119]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1008b # [ 2.467149] (udev-worker)[119]: Network interface NamePolicy= disabled on kernel command line.1009b # [ 2.488926] (udev-worker)[145]: Network interface NamePolicy= disabled on kernel command line.1010a # [ 2.452271] (udev-worker)[138]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1011a # [ 2.456765] (udev-worker)[138]: Network interface NamePolicy= disabled on kernel command line.1012a # [ 2.462525] (udev-worker)[125]: Network interface NamePolicy= disabled on kernel command line.1013b # [ 2.512955] systemd[1]: Found device /dev/disk/by-label/nixos.1014b # [ 2.517656] systemd[1]: Reached target Initrd Root Device.1015b # [ 2.524152] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1016a # [ 2.512085] systemd[1]: Found device /dev/disk/by-label/nixos.1017a # [ 2.521856] systemd[1]: Reached target Initrd Root Device.1018a # [ 2.523306] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1019b # [ 2.567668] systemd-fsck[151]: nixos: clean, 12/65536 files, 13019/262144 blocks1020b # [ 2.571426] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1021b # [ 2.601358] systemd[1]: Mounting /sysroot...1022a # [ 2.570185] systemd-fsck[152]: nixos: clean, 12/65536 files, 13019/262144 blocks1023a # [ 2.575838] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1024b # [ 2.639163] EXT4-fs (vda): mounted filesystem d85ce34a-18b8-4e79-9ccc-eb000c7ad1fd r/w with ordered data mode. Quota mode: none.1025b # [ 2.642789] systemd[1]: Mounted /sysroot.1026b # [ 2.649050] systemd[1]: Reached target Initrd Root File System.1027b # [ 2.653176] systemd[1]: Mounting /sysroot/nix/.ro-store...1028b # [ 2.660487] systemd[1]: Mounting /sysroot/nix/.rw-store...1029a # [ 2.619021] systemd[1]: Mounting /sysroot...1030b # [ 2.672524] systemd[1]: Mounting /sysroot/run...1031b # [ 2.676736] systemd[1]: Mounting /sysroot/tmp/shared...1032b # [ 2.683042] systemd[1]: Mounting /sysroot/tmp/xchg...1033b # [ 2.692433] systemd[1]: Starting Mountpoints Configured in the Real Root...1034b # [ 2.694636] systemd[1]: Mounted /sysroot/nix/.ro-store.1035a # [ 2.658565] EXT4-fs (vda): mounted filesystem 5f8fdcde-cb6f-4667-985d-8cc812dfe97b r/w with ordered data mode. Quota mode: none.1036b # [ 2.700388] systemd[1]: Mounted /sysroot/nix/.rw-store.1037a # [ 2.657503] systemd[1]: Mounted /sysroot.1038a # [ 2.659375] systemd[1]: Reached target Initrd Root File System.1039a # [ 2.662629] systemd[1]: Mounting /sysroot/nix/.ro-store...1040b # [ 2.709249] systemd-sysroot-fstab-check[164]: /sysroot should be mounted in the initrd, will request daemon-reload.1041a # [ 2.667543] systemd[1]: Mounting /sysroot/nix/.rw-store...1042b # [ 2.713334] systemd[1]: Mounted /sysroot/run.1043b # [ 2.716427] systemd[1]: Mounted /sysroot/tmp/shared.1044b # [ 2.717660] systemd[1]: Mounted /sysroot/tmp/xchg.1045b # [ 2.723095] systemd[1]: Reload requested from client PID 164 ('systemd-sysroot') (unit initrd-parse-etc.service)...1046b # [ 2.725061] systemd[1]: Reloading...1047a # [ 2.690013] systemd[1]: Mounting /sysroot/run...1048a # [ 2.693054] systemd[1]: Mounting /sysroot/tmp/shared...1049a # [ 2.700254] systemd[1]: Mounting /sysroot/tmp/xchg...1050a # [ 2.708417] systemd[1]: Starting Mountpoints Configured in the Real Root...1051a # [ 2.713751] systemd[1]: Mounted /sysroot/nix/.ro-store.1052a # [ 2.716920] systemd[1]: Mounted /sysroot/nix/.rw-store.1053a # [ 2.719186] systemd[1]: Mounted /sysroot/run.1054a # [ 2.720546] systemd[1]: Mounted /sysroot/tmp/shared.1055a # [ 2.721434] systemd[1]: Mounted /sysroot/tmp/xchg.1056a # [ 2.724277] systemd-sysroot-fstab-check[165]: /sysroot should be mounted in the initrd, will request daemon-reload.1057a # [ 2.728156] systemd[1]: Starting rw-sysroot-nix-store.service...1058a # [ 2.730216] systemd[1]: Reload requested from client PID 165 ('systemd-sysroot') (unit initrd-parse-etc.service)...1059a # [ 2.732617] systemd[1]: Reloading...1060b # [ 2.832828] systemd[1]: Reloading finished in 108 ms.1061a # [ 2.829638] systemd[1]: Reloading finished in 97 ms.1062b # [ 2.881949] systemd-sysroot-fstab-check[164]: Requesting initrd-fs.target/start/replace...1063b # [ 2.884513] systemd-sysroot-fstab-check[164]: Requesting swap.target/start/replace...1064b # [ 2.886640] systemd[1]: Starting rw-sysroot-nix-store.service...1065b # [ 2.890561] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1066b # [ 2.892145] systemd[1]: Finished Mountpoints Configured in the Real Root.1067b # [ 2.893303] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1068b # [ 2.920295] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1069b # [ 2.922556] systemd[1]: Finished rw-sysroot-nix-store.service.1070a # [ 2.882500] systemd-sysroot-fstab-check[165]: Requesting initrd-fs.target/start/replace...1071a # [ 2.883864] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1072a # [ 2.885033] systemd[1]: Finished rw-sysroot-nix-store.service.1073a # [ 2.886152] systemd-sysroot-fstab-check[165]: Requesting swap.target/start/replace...1074a # [ 2.889621] systemd[1]: Starting rw-sysroot-nix-store.service...1075a # [ 2.890660] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1076a # [ 2.892230] systemd[1]: Finished Mountpoints Configured in the Real Root.1077a # [ 2.894500] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1078a # [ 2.912644] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1079a # [ 2.914965] systemd[1]: Finished rw-sysroot-nix-store.service.1080a # [ 3.077425] (udev-worker)[145]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory1081a # [ 3.080555] (udev-worker)[145]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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 directory1082b # [ 3.124142] (udev-worker)[138]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory1083b # [ 3.128631] (udev-worker)[138]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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 directory1084a # [ 3.090641] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1085a # [ 3.091784] systemd[1]: Stopped Virtual Console Setup.1086a # [ 3.092838] systemd[1]: Stopping Virtual Console Setup...1087a # [ 3.093619] systemd[1]: Starting Virtual Console Setup...1088b # [ 3.137108] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1089b # [ 3.138264] systemd[1]: Stopped Virtual Console Setup.1090b # [ 3.139040] systemd[1]: Stopping Virtual Console Setup...1091b # [ 3.139816] systemd[1]: Starting Virtual Console Setup...1092b # [ 3.169827] systemd-vconsole-setup[191]: Configuration of first virtual console was skipped, ignoring remaining ones.1093b # [ 3.171906] systemd[1]: Finished Virtual Console Setup.1094a # [ 3.146605] systemd-vconsole-setup[194]: Configuration of first virtual console was skipped, ignoring remaining ones.1095a # [ 3.149252] systemd[1]: Finished Virtual Console Setup.1096b # [ 3.605896] systemd[1]: Mounting /sysroot/nix/store...1097a # [ 3.623836] systemd[1]: Mounting /sysroot/nix/store...1098b # [ 3.679418] systemd[1]: Mounted /sysroot/nix/store.1099b # [ 3.681920] systemd[1]: Reached target Initrd File Systems.1100b # [ 3.684442] systemd[1]: Starting Find NixOS closure...1101b # [ 3.687886] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1102a # [ 3.690349] systemd[1]: Mounted /sysroot/nix/store.1103a # [ 3.692752] systemd[1]: Reached target Initrd File Systems.1104a # [ 3.695468] systemd[1]: Starting Find NixOS closure...1105a # [ 3.699190] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1106b # [ 3.742164] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1107b # [ 3.745927] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1108b # [ 3.765258] systemd[1]: Finished Find NixOS closure.1109b # [ 3.767703] systemd[1]: Reached target Initrd Default Target.1110b # [ 3.770398] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1111a # [ 3.746697] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1112a # [ 3.750398] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1113a # [ 3.769036] systemd[1]: Finished Find NixOS closure.1114a # [ 3.771444] systemd[1]: Reached target Initrd Default Target.1115a # [ 3.774015] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1116b # [ 3.818373] systemd[1]: Stopped target Initrd Default Target.1117b # [ 3.821295] systemd[1]: Stopped target Basic System.1118b # [ 3.823522] systemd[1]: Stopped target Initrd Root Device.1119b # [ 3.826127] systemd[1]: Stopped target Path Units.1120b # [ 3.828321] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1121b # [ 3.831700] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1122b # [ 3.835152] systemd[1]: Stopped target Slice Units.1123b # [ 3.837456] systemd[1]: Stopped target Socket Units.1124b # [ 3.839649] systemd[1]: Stopped target System Initialization.1125b # [ 3.842337] systemd[1]: Stopped target Swaps.1126b # [ 3.846266] systemd[1]: Stopped target Timer Units.1127b # [ 3.850331] systemd[1]: dbus.socket: Deactivated successfully.1128b # [ 3.856315] systemd[1]: Closed D-Bus System Message Bus Socket.1129b # [ 3.859106] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1130b # [ 3.864336] systemd[1]: Stopped Find NixOS closure.1131b # [ 3.867359] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1132a # [ 3.825809] systemd[1]: Stopped target Initrd Default Target.1133b # [ 3.869933] systemd[1]: Starting rw-sysroot-nix-store.service...1134a # [ 3.828430] systemd[1]: Stopped target Basic System.1135b # [ 3.871940] systemd[1]: systemd-sysctl.service: Deactivated successfully.1136a # [ 3.830647] systemd[1]: Stopped target Initrd Root Device.1137b # [ 3.874138] systemd[1]: Stopped Apply Kernel Variables.1138a # [ 3.833074] systemd[1]: Stopped target Path Units.1139b # [ 3.875802] systemd[1]: systemd-modules-load.service: Deactivated successfully.1140b # [ 3.878328] systemd[1]: Stopped Load Kernel Modules.1141a # [ 3.835198] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1142b # [ 3.879852] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1143a # [ 3.838523] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1144b # [ 3.882180] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1145a # [ 3.841859] systemd[1]: Stopped target Slice Units.1146b # [ 3.884396] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1147b # [ 3.886327] systemd[1]: Stopped Create System Files and Directories.1148a # [ 3.844077] systemd[1]: Stopped target Socket Units.1149b # [ 3.888057] systemd[1]: Stopped target Local File Systems.1150a # [ 3.846292] systemd[1]: Stopped target System Initialization.1151b # [ 3.889468] systemd[1]: Stopped target Preparation for Local File Systems.1152b # [ 3.891120] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1153a # [ 3.848843] systemd[1]: Stopped target Swaps.1154b # [ 3.892909] systemd[1]: Stopped Coldplug All udev Devices.1155b # [ 3.894406] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1156a # [ 3.852712] systemd[1]: Stopped target Timer Units.1157b # [ 3.896133] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1158b # [ 3.897816] systemd[1]: Stopped Virtual Console Setup.1159b # [ 3.899029] systemd[1]: initrd-cleanup.service: Deactivated successfully.1160a # [ 3.856602] systemd[1]: dbus.socket: Deactivated successfully.1161b # [ 3.900647] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1162b # [ 3.902172] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1163b # [ 3.903824] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1164a # [ 3.860795] systemd[1]: Closed D-Bus System Message Bus Socket.1165b # [ 3.905340] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1166b # [ 3.906985] systemd[1]: Finished rw-sysroot-nix-store.service.1167a # [ 3.863341] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1168b # [ 3.908389] systemd[1]: systemd-udevd.service: Deactivated successfully.1169a # [ 3.866395] systemd[1]: Stopped Find NixOS closure.1170b # [ 3.909916] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1171a # [ 3.868332] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1172a # [ 3.870566] systemd[1]: Starting rw-sysroot-nix-store.service...1173b # [ 3.911555] systemd[1]: systemd-udevd.service: Consumed 2.413s CPU time over 2.183s wall clock time, 31.7M memory peak.1174a # [ 3.872878] systemd[1]: systemd-sysctl.service: Deactivated successfully.1175b # [ 3.915588] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1176b # [ 3.917768] systemd[1]: Closed udev Control Socket.1177a # [ 3.875437] systemd[1]: Stopped Apply Kernel Variables.1178b # [ 3.919288] systemd[1]: Starting Cleanup udev Database...1179a # [ 3.878312] systemd[1]: systemd-modules-load.service: Deactivated successfully.1180b # [ 3.921213] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1181a # [ 3.880895] systemd[1]: Stopped Load Kernel Modules.1182b # [ 3.923422] systemd[1]: Stopped Create Static Device Nodes in /dev.1183a # [ 3.882603] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1184b # [ 3.925303] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1185b # [ 3.927477] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1186a # [ 3.885343] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1187b # [ 3.929496] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1188a # [ 3.887918] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1189b # [ 3.931366] systemd[1]: Stopped Create List of Static Device Nodes.1190a # [ 3.890445] systemd[1]: Stopped Create System Files and Directories.1191a # [ 3.892653] systemd[1]: Stopped target Local File Systems.1192a # [ 3.894490] systemd[1]: Stopped target Preparation for Local File Systems.1193a # [ 3.896841] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1194a # [ 3.899113] systemd[1]: Stopped Coldplug All udev Devices.1195a # [ 3.900875] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1196a # [ 3.903068] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1197a # [ 3.905206] systemd[1]: Stopped Virtual Console Setup.1198a # [ 3.906682] systemd[1]: initrd-cleanup.service: Deactivated successfully.1199a # [ 3.908468] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1200a # [ 3.910193] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1201a # [ 3.911984] systemd[1]: Finished rw-sysroot-nix-store.service.1202a # [ 3.913522] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1203a # [ 3.915490] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1204a # [ 3.917041] systemd[1]: systemd-udevd.service: Deactivated successfully.1205a # [ 3.918617] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1206a # [ 3.920245] systemd[1]: systemd-udevd.service: Consumed 2.296s CPU time over 2.181s wall clock time, 31.1M memory peak.1207a # [ 3.922535] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1208a # [ 3.924073] systemd[1]: Closed udev Control Socket.1209a # [ 3.925167] systemd[1]: Starting Cleanup udev Database...1210a # [ 3.926341] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1211a # [ 3.927896] systemd[1]: Stopped Create Static Device Nodes in /dev.1212a # [ 3.929238] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1213a # [ 3.930839] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1214a # [ 3.932220] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1215a # [ 3.933539] systemd[1]: Stopped Create List of Static Device Nodes.1216b # [ 4.014879] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1217a # [ 3.974800] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1218b # [ 4.018624] systemd[1]: Finished Cleanup udev Database.1219a # [ 3.978144] systemd[1]: Finished Cleanup udev Database.1220b # [ 4.021214] systemd[1]: Reached target Switch Root.1221a # [ 3.980501] systemd[1]: Reached target Switch Root.1222b # [ 4.023419] systemd[1]: Starting NixOS Activation...1223a # [ 3.982659] systemd[1]: Starting NixOS Activation...1224a # [ 4.271328] initrd-nixos-activation-start[220]: booting system configuration /nix/store/k4gaapa9y09x502f5xjqxfdkqkj18gad-nixos-system-a-test1225b # [ 4.310830] initrd-nixos-activation-start[218]: booting system configuration /nix/store/ib3ijb1h4nkfn2nqvajpzsq2kslranh8-nixos-system-b-test1226b # [ 4.411903] initrd-nixos-activation-start[218]: running activation script...1227a # [ 4.378562] initrd-nixos-activation-start[220]: running activation script...1228a # [ 4.897218] initrd-nixos-activation-start[243]: setting up /etc...1229b # [ 4.968661] initrd-nixos-activation-start[241]: setting up /etc...1230a # [ 5.180308] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1231a # [ 5.181497] systemd[1]: Finished NixOS Activation.1232a # [ 5.185001] systemd[1]: Starting Switch Root...1233b # [ 5.277803] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1234b # [ 5.279061] systemd[1]: Finished NixOS Activation.1235b # [ 5.282616] systemd[1]: Starting Switch Root...1236a # [ 5.240382] systemd[1]: Switching root.1237b # [ 5.337650] systemd[1]: Switching root.1238a # [ 5.377369] systemd-journald[95]: Received SIGTERM from PID 1 (systemd).1239b # [ 5.428581] systemd-journald[94]: Received SIGTERM from PID 1 (systemd).1240a # [ 6.081305] systemd[1]: systemd 261 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)1241a # [ 6.081489] systemd[1]: Detected virtualization qemu.1242a # [ 6.081603] systemd[1]: Detected architecture arm64.1243a # [ 6.081809] systemd[1]: Detected first boot.1244a # [ 6.089185] systemd[1]: Initializing machine ID from random generator.1245b # [ 6.136232] systemd[1]: systemd 261 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)1246b # [ 6.136383] systemd[1]: Detected virtualization qemu.1247b # [ 6.136489] systemd[1]: Detected architecture arm64.1248b # [ 6.136685] systemd[1]: Detected first boot.1249b # [ 6.144082] systemd[1]: Initializing machine ID from random generator.1250a # [ 6.333521] systemd[1]: bpf-restrict-fs: LSM BPF program attached1251b # [ 6.448255] systemd[1]: bpf-restrict-fs: LSM BPF program attached1252a # [ 6.504028] systemd[1]: Applying preset policy.1253b # [ 6.614558] systemd[1]: Applying preset policy.1254a # [ 7.059689] systemd[1]: Populated /etc with preset unit settings.1255b # [ 7.147212] systemd[1]: Populated /etc with preset unit settings.1256a # [ 7.635871] systemd[1]: initrd-switch-root.service: Deactivated successfully.1257a # [ 7.636602] systemd[1]: Stopped initrd-switch-root.service.1258a # [ 7.640118] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1259a # [ 7.647411] systemd[1]: Created slice Slice /system/getty.1260a # [ 7.651659] systemd[1]: Created slice User and Session Slice.1261b # [ 7.699414] systemd[1]: initrd-switch-root.service: Deactivated successfully.1262b # [ 7.699908] systemd[1]: Stopped initrd-switch-root.service.1263b # [ 7.702339] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1264a # [ 7.653242] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1265b # [ 7.710371] systemd[1]: Created slice Slice /system/getty.1266a # [ 7.654686] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1267b # [ 7.713168] systemd[1]: Created slice User and Session Slice.1268a # [ 7.656043] systemd[1]: Expecting device /dev/hvc0...1269b # [ 7.714794] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1270a # [ 7.657155] systemd[1]: Expecting device /dev/ttyAMA0...1271a # [ 7.658302] systemd[1]: Reached target Local Encrypted Volumes.1272b # [ 7.716289] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1273a # [ 7.659482] systemd[1]: Reached target flakelet contract providers ready.1274a # [ 7.660620] systemd[1]: Stopped target initrd-fs.target.1275b # [ 7.717518] systemd[1]: Expecting device /dev/hvc0...1276a # [ 7.661909] systemd[1]: Stopped target initrd-root-fs.target.1277b # [ 7.718682] systemd[1]: Expecting device /dev/ttyAMA0...1278a # [ 7.663004] systemd[1]: Stopped target initrd-switch-root.target.1279b # [ 7.719865] systemd[1]: Reached target Local Encrypted Volumes.1280b # [ 7.721022] systemd[1]: Reached target flakelet contract providers ready.1281b # [ 7.722182] systemd[1]: Stopped target initrd-fs.target.1282a # [ 7.664182] systemd[1]: Reached target Virtual Machines and Containers.1283b # [ 7.723348] systemd[1]: Stopped target initrd-root-fs.target.1284b # [ 7.724477] systemd[1]: Stopped target initrd-switch-root.target.1285a # [ 7.665312] systemd[1]: Reached target Path Units.1286b # [ 7.725618] systemd[1]: Reached target Virtual Machines and Containers.1287a # [ 7.666445] systemd[1]: Reached target Remote File Systems.1288b # [ 7.726677] systemd[1]: Reached target Path Units.1289a # [ 7.667654] systemd[1]: Reached target Slice Units.1290b # [ 7.727639] systemd[1]: Reached target Remote File Systems.1291a # [ 7.668353] systemd[1]: Reached target Swaps.1292b # [ 7.728539] systemd[1]: Reached target Slice Units.1293b # [ 7.729440] systemd[1]: Reached target Swaps.1294b # [ 7.742750] systemd[1]: Listening on Query the User Interactively for a Password.1295a # [ 7.674309] systemd[1]: Listening on Query the User Interactively for a Password.1296a # [ 7.681751] systemd[1]: Listening on Process Core Dump Socket.1297b # [ 7.753021] systemd[1]: Listening on Process Core Dump Socket.1298b # [ 7.758199] systemd[1]: Listening on Credential Encryption/Decryption.1299a # [ 7.686933] systemd[1]: Listening on Credential Encryption/Decryption.1300a # [ 7.692546] systemd[1]: Listening on Factory Reset Management.1301b # [ 7.763486] systemd[1]: Listening on Factory Reset Management.1302a # [ 7.693950] systemd[1]: Listening on Hostname Service Socket.1303b # [ 7.764418] systemd[1]: Listening on Hostname Service Socket.1304a # [ 7.705011] systemd[1]: Starting Journal Log Access Socket...1305a # [ 7.707254] systemd[1]: Listening on Journal Audit Socket.1306b # [ 7.775538] systemd[1]: Starting Journal Log Access Socket...1307a # [ 7.712506] systemd[1]: Listening on Console Output Muting Service Socket.1308b # [ 7.777685] systemd[1]: Listening on Journal Audit Socket.1309a # [ 7.714016] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1310b # [ 7.783225] systemd[1]: Listening on Console Output Muting Service Socket.1311a # [ 7.714969] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1312b # [ 7.784305] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1313a # [ 7.715870] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1314b # [ 7.784873] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1315a # [ 7.728199] systemd[1]: Listening on Disk Repartitioning Service Socket.1316b # [ 7.785313] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1317a # [ 7.729376] systemd[1]: Listening on udev Control Socket.1318a # [ 7.730484] systemd[1]: Listening on udev Varlink Socket.1319b # [ 7.800681] systemd[1]: Listening on Disk Repartitioning Service Socket.1320b # [ 7.802088] systemd[1]: Listening on udev Control Socket.1321a # [ 7.740006] systemd[1]: Mounting Huge Pages File System...1322b # [ 7.803586] systemd[1]: Listening on udev Varlink Socket.1323a # [ 7.752872] systemd[1]: Mounting POSIX Message Queue File System...1324b # [ 7.813317] systemd[1]: Mounting Huge Pages File System...1325a # [ 7.765398] systemd[1]: Mounting Kernel Debug File System...1326b # [ 7.819658] systemd[1]: Mounting POSIX Message Queue File System...1327a # [ 7.778501] systemd[1]: Mounting Kernel Trace File System...1328b # [ 7.826185] systemd[1]: Mounting Kernel Debug File System...1329a # [ 7.787788] systemd[1]: Starting Create List of Static Device Nodes...1330b # [ 7.832452] systemd[1]: Mounting Kernel Trace File System...1331a # [ 7.799689] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1332a # [ 7.800767] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1333b # [ 7.852619] systemd[1]: Starting Create List of Static Device Nodes...1334a # [ 7.817772] systemd[1]: Mounting Kernel Configuration File System...1335b # [ 7.862606] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1336b # [ 7.863806] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1337a # [ 7.818808] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1338b # [ 7.876307] systemd[1]: Mounting Kernel Configuration File System...1339a # [ 7.819651] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1340b # [ 7.877458] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1341a # [ 7.837197] systemd[1]: Starting Load Kernel Module fuse...1342b # [ 7.878496] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1343a # [ 7.838161] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671344a # [ 7.877796] systemd[1]: Starting Journal Service...1345a # [ 7.884597] systemd[1]: Starting Load Kernel Modules...1346a # [ 7.891359] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1347b # [ 7.933734] systemd[1]: Starting Load Kernel Module fuse...1348a # [ 7.896843] systemd[1]: Starting Remount Root and Kernel File Systems...1349a # [ 7.897245] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1350b # [ 7.935208] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671351a # [ 7.910030] systemd[1]: Starting Coldplug All udev Devices...1352b # [ 7.955226] systemd[1]: Starting Journal Service...1353a # [ 7.917406] systemd[1]: Listening on Journal Log Access Socket.1354a # [ 7.918483] systemd[1]: Mounted Huge Pages File System.1355a # [ 7.919994] systemd[1]: Mounted POSIX Message Queue File System.1356b # [ 7.981363] systemd[1]: Starting Load Kernel Modules...1357a # [ 7.921027] systemd[1]: Mounted Kernel Debug File System.1358a # [ 7.922141] systemd[1]: Mounted Kernel Trace File System.1359a # [ 7.923935] systemd[1]: Finished Create List of Static Device Nodes.1360b # [ 7.998780] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1361a # [ 7.925484] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1362a # [ 7.926685] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1363b # [ 8.007079] systemd[1]: Starting Remount Root and Kernel File Systems...1364a # [ 7.927787] systemd[1]: Mounted Kernel Configuration File System.1365b # [ 8.008788] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1366a # [ 7.932844] fuse: init (API version 7.45)1367b # [ 8.024117] systemd[1]: Starting Coldplug All udev Devices...1368a # [ 7.944439] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1369a # [ 7.946077] systemd[1]: modprobe@fuse.service: Deactivated successfully.1370b # [ 8.032755] systemd[1]: Listening on Journal Log Access Socket.1371a # [ 7.947810] systemd[1]: Finished Load Kernel Module fuse.1372b # [ 8.034123] systemd[1]: Mounted Huge Pages File System.1373a # [ 7.959462] systemd-journald[315]: Collecting audit messages is enabled.1374b # [ 8.035402] systemd[1]: Mounted POSIX Message Queue File System.1375a # [ 7.987325] systemd[1]: Queued start job for default target Multi-User System.1376a # [ 7.961801] systemd[1]: Mounting FUSE Control File System...1377b # [ 8.036587] systemd[1]: Mounted Kernel Debug File System.1378b # [ 8.037721] systemd[1]: Mounted Kernel Trace File System.1379a # [ 7.990872] systemd[1]: Finished Load Kernel Modules.1380b # [ 8.039573] systemd[1]: Finished Create List of Static Device Nodes.1381a # [ 7.992213] systemd[1]: Started Journal Service.1382b # [ 8.041238] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1383b # [ 8.042716] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1384a # [ 7.999981] EXT4-fs (vda): re-mounted 5f8fdcde-cb6f-4667-985d-8cc812dfe97b.1385a # [ 8.003581] systemd[1]: systemd-journald.service: Deactivated successfully.1386b # [ 8.044001] systemd[1]: Mounted Kernel Configuration File System.1387a # [ 8.013888] systemd-modules-load[316]: Using 2 probe threads1388b # [ 8.057040] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1389a # [ 8.018858] systemd-modules-load[316]: Module 'atkbd' is built in1390a # [ 8.023122] systemd-modules-load[316]: Module 'loop' is built in1391a # [ 8.025457] systemd[1]: Starting Firewall...1392a # [ 8.027667] systemd[1]: Starting Apply Kernel Variables...1393a # [ 8.034170] systemd[1]: Finished Remount Root and Kernel File Systems.1394a # [ 8.039647] systemd-oomd[318]: No swap; memory pressure usage will be degraded1395b # [ 8.088995] systemd-journald[312]: Collecting audit messages is enabled.1396a # [ 8.048905] systemd[1]: Mounted FUSE Control File System.1397a # [ 8.051213] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1398b # [ 8.097593] systemd[1]: Queued start job for default target Multi-User System.1399a # [ 8.054502] systemd[1]: Listening on Disk Image Download Service Socket.1400b # [ 8.102947] systemd[1]: Started Journal Service.1401b # [ 8.104022] fuse: init (API version 7.45)1402a # [ 8.062400] systemd[1]: Starting Flush Journal to Persistent Storage...1403b # [ 8.105285] systemd[1]: systemd-journald.service: Deactivated successfully.1404a # [ 8.064667] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1405a # [ 8.069239] systemd[1]: Starting Load/Save OS Random Seed...1406b # [ 8.110378] systemd-modules-load[313]: Using 2 probe threads1407a # [ 8.070592] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1408b # [ 8.114610] systemd-modules-load[313]: Module 'atkbd' is built in1409b # [ 8.120047] systemd-modules-load[313]: Module 'loop' is built in1410b # [ 8.121851] systemd[1]: Finished Load Kernel Modules.1411b # [ 8.123998] systemd[1]: Starting Firewall...1412b # [ 8.125638] systemd[1]: Starting Apply Kernel Variables...1413b # [ 8.127436] systemd[1]: modprobe@fuse.service: Deactivated successfully.[ 8.130993] EXT4-fs (vda): re-mounted d85ce34a-18b8-4e79-9ccc-eb000c7ad1fd.1414b # 1415b # [ 8.131984] systemd[1]: Finished Load Kernel Module fuse.1416b # [ 8.135833] systemd-oomd[315]: No swap; memory pressure usage will be degraded1417b # [ 8.142440] systemd[1]: Mounting FUSE Control File System...1418b # [ 8.145935] systemd[1]: Finished Remount Root and Kernel File Systems.1419b # [ 8.149951] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1420a # [ 8.114249] systemd[1]: Finished Apply Kernel Variables.1421b # [ 8.158266] systemd[1]: Listening on Disk Image Download Service Socket.1422a # [ 8.118105] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1423b # [ 8.163961] systemd[1]: Starting Flush Journal to Persistent Storage...1424a # [ 8.123638] systemd-journald[315]: Received client request to flush runtime journal.1425b # [ 8.168713] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1426b # [ 8.173030] systemd[1]: Starting Load/Save OS Random Seed...1427b # [ 8.174287] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1428a # [ 8.150858] systemd[1]: Starting Create Static Device Nodes in /dev...1429a # [ 8.152923] systemd[1]: Finished Load/Save OS Random Seed.1430a # [ 8.154811] systemd[1]: Reached target First Boot Complete.1431a # [ 8.156704] systemd[1]: Finished Flush Journal to Persistent Storage.1432b # [ 8.199313] systemd[1]: Mounted FUSE Control File System.1433b # [ 8.216785] systemd-journald[312]: Received client request to flush runtime journal.1434a # [ 8.196876] systemd[1]: Finished Create Static Device Nodes in /dev.1435a # [ 8.198445] systemd[1]: Reached target Preparation for Local File Systems.1436a # [ 8.201181] systemd[1]: Starting Rule-based Manager for Device Events and Files...1437b # [ 8.249978] systemd[1]: Finished Load/Save OS Random Seed.1438b # [ 8.251332] systemd[1]: Reached target First Boot Complete.1439b # [ 8.252595] systemd[1]: Finished Apply Kernel Variables.1440b # [ 8.253510] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1441b # [ 8.254693] systemd[1]: Starting Create Static Device Nodes in /dev...1442b # [ 8.255766] systemd[1]: Finished Flush Journal to Persistent Storage.1443b # [ 8.327650] systemd[1]: Finished Create Static Device Nodes in /dev.1444b # [ 8.329069] systemd[1]: Reached target Preparation for Local File Systems.1445b # [ 8.332438] systemd[1]: Starting Rule-based Manager for Device Events and Files...1446a # [ 8.295590] systemd-udevd[359]: Using default interface naming scheme 'v261'.1447b # [ 8.414695] systemd-udevd[357]: Using default interface naming scheme 'v261'.1448a # [ 8.403628] systemd[1]: Started Rule-based Manager for Device Events and Files.1449b # [ 8.533233] systemd[1]: Started Rule-based Manager for Device Events and Files.1450a # [ 8.634214] systemd[1]: Mounting /run/wrappers...1451b # [ 8.702506] systemd[1]: Mounting /run/wrappers...1452a # [ 8.661269] systemd[1]: Finished Coldplug All udev Devices.1453a # [ 8.673939] systemd[1]: Mounted /run/wrappers.1454a # [ 8.678867] systemd[1]: Reached target Local File Systems.1455a # [ 8.681730] systemd[1]: Listening on Boot Loader Control Service Socket.1456a # [ 8.686626] systemd[1]: Starting register-nix-paths.service...1457a # [ 8.690948] systemd[1]: Starting Create SUID/SGID Wrappers...1458a # [ 8.696334] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1459b # [ 8.744419] systemd[1]: Finished Coldplug All udev Devices.1460a # [ 8.706585] systemd[1]: Starting Save Transient machine-id to Disk...1461a # [ 8.715177] systemd[1]: Starting Create System Files and Directories...1462b # [ 8.775249] systemd[1]: Mounted /run/wrappers.1463b # [ 8.778804] systemd[1]: Reached target Local File Systems.1464b # [ 8.782444] systemd[1]: Listening on Boot Loader Control Service Socket.1465a # [ 8.743854] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1466b # [ 8.787205] systemd[1]: Starting register-nix-paths.service...1467b # [ 8.793315] systemd[1]: Starting Create SUID/SGID Wrappers...1468b # [ 8.796751] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1469b # [ 8.806049] systemd[1]: Starting Save Transient machine-id to Disk...1470b # [ 8.815782] systemd[1]: Starting Create System Files and Directories...1471b # [ 8.822361] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1472a # [ 8.803896] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1473a # [ 8.808575] systemd[1]: Finished Save Transient machine-id to Disk.1474a # [ 8.812149] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1475b # [ 8.871985] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1476b # [ 8.881605] systemd[1]: Finished Save Transient machine-id to Disk.1477b # [ 8.896805] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1478a # [ 8.871187] systemd[1]: Finished Create System Files and Directories.1479a # [ 8.874266] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1480a # [ 8.881504] systemd[1]: Starting Rebuild Journal Catalog...1481a # [ 8.885572] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1482b # [ 8.936455] systemd[1]: Finished Create System Files and Directories.1483b # [ 8.947982] systemd[1]: Starting Rebuild Journal Catalog...1484b # [ 8.955205] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1485b # [ 8.960333] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1486a # [ 8.939125] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1487a # [ 8.973088] (udev-worker)[435]: Network interface NamePolicy= disabled on kernel command line.1488b # [ 9.021327] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1489a # [ 8.981839] (udev-worker)[391]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1490a # [ 8.985594] (udev-worker)[391]: Network interface NamePolicy= disabled on kernel command line.1491a # [ 8.988577] systemd[1]: Finished Rebuild Journal Catalog.1492a # [ 8.994185] systemd[1]: Starting Update is Completed...1493b # [ 9.051753] systemd[1]: Finished Rebuild Journal Catalog.1494b # [ 9.055234] (udev-worker)[386]: Network interface NamePolicy= disabled on kernel command line.1495b # [ 9.058928] (udev-worker)[415]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1496b # [ 9.066166] (udev-worker)[415]: Network interface NamePolicy= disabled on kernel command line.1497b # [ 9.069541] systemd[1]: Starting Update is Completed...1498a # [ 9.029820] systemd[1]: Condition check resulted in Virtio network device being skipped.1499a # [ 9.034929] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1500a # [ 9.037807] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1501a # [ 9.039589] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671502a # [ 9.043216] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1503a # [ 9.047945] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1504a # [ 9.051636] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1505a # [ 9.056151] systemd[1]: Finished Update is Completed.1506b # [ 9.111210] systemd[1]: Condition check resulted in Virtio network device being skipped.1507b # [ 9.113982] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1508b # [ 9.117489] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1509a # [ 9.080386] mousedev: PS/2 mouse device common for all mice1510b # [ 9.119627] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671511b # [ 9.126162] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1512b # [ 9.128713] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1513b # [ 9.132540] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1514b # [ 9.152954] systemd[1]: Finished Update is Completed.1515b # [ 9.271313] mousedev: PS/2 mouse device common for all mice1516a # [ 9.260653] systemd[1]: Finished Firewall.1517a # [ 9.322498] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1518a # [ 9.324429] systemd[1]: Finished Create SUID/SGID Wrappers.1519b # [ 9.430923] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1520b # [ 9.432229] systemd[1]: Finished Create SUID/SGID Wrappers.1521b # [ 9.550893] systemd[1]: Finished Firewall.1522a # [ 9.555219] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31523b # [ 9.603849] systemd[1]: Finished register-nix-paths.service.1524b # [ 9.605177] systemd[1]: Reached target System Initialization.1525b # [ 9.606076] systemd[1]: Started Discard unused filesystem blocks once a week.1526b # [ 9.607086] systemd[1]: Started Daily Cleanup of Temporary Directories.1527b # [ 9.608105] systemd[1]: Reached target Timer Units.1528b # [ 9.608887] systemd[1]: Listening on D-Bus System Message Bus Socket.1529b # [ 9.609784] systemd[1]: Listening on Nix Daemon Socket.1530a # [ 9.568204] systemd[1]: Finished register-nix-paths.service.1531b # [ 9.610686] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1532b # [ 9.612316] systemd[1]: Reached target Socket Units.1533b # [ 9.613827] systemd[1]: Reached target Basic System.1534a # [ 9.571613] systemd[1]: Reached target System Initialization.1535b # [ 9.614672] systemd[1]: Started backdoor.service.1536a # [ 9.572963] systemd[1]: Started Discard unused filesystem blocks once a week.1537a # [ 9.574053] systemd[1]: Started Daily Cleanup of Temporary Directories.1538a # [ 9.575290] systemd[1]: Reached target Timer Units.1539b # [ 9.617200] systemd[1]: Starting Re-link flakelet services at boot...1540a # [ 9.576114] systemd[1]: Listening on D-Bus System Message Bus Socket.1541a # [ 9.577761] systemd[1]: Listening on Nix Daemon Socket.1542a # [ 9.578975] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1543a # [ 9.580815] systemd[1]: Reached target Socket Units.1544a # [ 9.581885] systemd[1]: Reached target Basic System.1545a # [ 9.584365] systemd[1]: Started backdoor.service.1546b # [ 9.628510] systemd[1]: Starting Import lastlog data into lastlog2 database...1547a # [ 9.596101] systemd[1]: Starting Re-link flakelet services at boot...1548b # [ 9.656187] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1549b # [ 9.664322] systemd[1]: Starting Post-Boot Actions...1550a # [ 9.628952] systemd[1]: Starting Import lastlog data into lastlog2 database...1551b # [ 9.671426] systemd[1]: Started Reset console on configuration changes.[ 9.675112] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31552b # 1553b # [ 9.679289] systemd[1]: Starting resolvconf update...1554a # [ 9.637531] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1555a # [ 9.653997] systemd[1]: Starting Post-Boot Actions...1556b # [ 9.699003] systemd[1]: Starting D-Bus System Message Bus...1557a # [ 9.661280] systemd[1]: Started Reset console on configuration changes.1558a # [ 9.668055] systemd[1]: Starting resolvconf update...1559a # [ 9.686827] systemd[1]: Starting D-Bus System Message Bus...1560a # [ 9.697896] systemd[1]: Starting Virtual Console Setup...1561a # [ 9.713955] systemd[1]: Finished Post-Boot Actions.1562b # [ 9.755209] systemd[1]: Finished Post-Boot Actions.1563a # [ 9.716853] systemd[1]: Finished Re-link flakelet services at boot.1564b # [ 9.759134] systemd[1]: Finished Re-link flakelet services at boot.1565b # connecting to host...1566a # connecting to host...1567b # [ 9.764720] systemd[1]: Starting Reconcile flakelet services with the host configuration...1568b # [ 9.768632] systemd[1]: Started Name Service Cache Daemon (nsncd).1569a # [ 9.732756] systemd[1]: Starting Reconcile flakelet services with the host configuration...1570b # [ 9.771221] nsncd[559]: Aug 31 08:45:10.526 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1571b # [ 9.779776] systemd[1]: Reached target Host and Network Name Lookups.1572b # [ 9.783782] systemd[1]: Reached target User and Group Name Lookups.1573a # [ 9.745802] systemd[1]: Started Name Service Cache Daemon (nsncd).1574b # [ 9.788602] systemd[1]: Starting User Login Management...1575a # [ 9.747128] systemd[1]: Reached target Host and Network Name Lookups.1576a: Guest shell says: b'Spawning backdoor root shell...\n'1577a # [ 9.750900] nsncd[565]: Aug 31 08:45:10.553 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1578a # [ 9.760152] systemd[1]: Reached target User and Group Name Lookups.1579a # [ 9.763567] systemd[1]: Starting User Login Management...1580a # [ 9.769707] systemd[1]: Finished Import lastlog data into lastlog2 database.1581b # [ 9.816452] systemd[1]: Finished Import lastlog data into lastlog2 database.1582b # [ 9.829240] systemd[1]: Finished Reconcile flakelet services with the host configuration.1583a: connected to guest root shell1584a: (connecting took 10.23 seconds)1585a: (finished: waiting for the VM to finish booting, in 10.23 seconds)1586a # [ 9.793689] systemd[1]: Finished Reconcile flakelet services with the host configuration.1587a # [ 9.830665] dbus-broker-launch[572]: Looking up NSS user entry for 'systemd-timesync'...1588a # [ 9.835113] systemd-logind[593]: New seat seat0.1589a: (finished: must succeed: mkdir -p /srv/kv && echo bucket-data > /srv/kv/web, in 10.28 seconds)1590a: must succeed: systemctl start flakelet-web.service1591b # [ 9.881948] dbus-broker-launch[564]: Looking up NSS user entry for 'systemd-timesync'...1592a # [ 9.839972] systemd-logind[593]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1593a # [ 9.846931] systemd-logind[593]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1594a # [ 9.848859] systemd-logind[593]: Watching system buttons on /dev/input/event0 (gpio-keys)1595a # [ 9.850216] systemd[1]: Started User Login Management.1596a # [ 9.851348] systemd[1]: Starting linger-users.service...1597b # [ 9.891182] systemd-logind[586]: New seat seat0.1598a # [ 9.853033] dbus-broker-launch[572]: NSS returned no entry for 'systemd-timesync'1599a # [ 9.854475] dbus-broker-launch[572]: Invalid user-name in /nix/store/s8sm8xwbfx7y43x6lrfyr9mp58vgim5j-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1600a # [ 9.859238] systemd[1]: Stopped target Host and Network Name Lookups.1601a # [ 9.862101] systemd[1]: Stopping Host and Network Name Lookups...1602a # [ 9.865695] systemd[1]: Stopped target User and Group Name Lookups.1603b # [ 9.900853] dbus-broker-launch[564]: NSS returned no entry for 'systemd-timesync'1604a # [ 9.867644] systemd[1]: Stopping User and Group Name Lookups...1605a # [ 9.869434] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1606a # [ 9.871918] systemd[1]: nscd.service: Deactivated successfully.1607b # [ 9.911127] dbus-broker-launch[564]: Invalid user-name in /nix/store/s8sm8xwbfx7y43x6lrfyr9mp58vgim5j-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1608b # [ 9.918102] systemd[1]: Starting Virtual Console Setup...1609b # [ 9.919597] systemd-logind[586]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1610b # [ 9.922819] systemd-logind[586]: Watching system buttons on /dev/input/event0 (gpio-keys)1611a # [ 9.881043] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1612b # [ 9.925466] systemd[1]: Started User Login Management.1613a # [ 9.886642] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1614b # [ 9.934938] systemd[1]: Starting linger-users.service...1615a # [ 9.894756] systemd[1]: Started D-Bus System Message Bus.1616b # [ 9.938024] systemd[1]: Started D-Bus System Message Bus.1617b # [ 9.942372] systemd-logind[586]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1618b # [ 9.954171] dbus-broker-launch[564]: Ready1619b # [ 9.955261] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1620b # [ 9.958131] systemd[1]: Stopped Virtual Console Setup.1621b # [ 9.961794] systemd[1]: Stopped target Host and Network Name Lookups.1622b # [ 9.963682] systemd[1]: Stopping Host and Network Name Lookups...1623a # [ 9.923414] dbus-broker-launch[572]: Ready1624b # [ 9.966718] systemd[1]: Stopped target User and Group Name Lookups.1625a # [ 9.926175] systemd[1]: linger-users.service: Deactivated successfully.1626b # [ 9.970560] systemd[1]: Stopping User and Group Name Lookups...1627a # [ 9.929448] systemd[1]: Finished linger-users.service.1628b # [ 9.972648] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1629b # [ 9.974566] systemd[1]: Starting Virtual Console Setup...1630b # [ 9.977080] systemd[1]: nscd.service: Deactivated successfully.1631a # [ 9.932731] nsncd[654]: Aug 31 08:45:10.739 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1632b # [ 9.978835] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1633a # [ 9.938297] systemd[1]: Started Name Service Cache Daemon (nsncd).1634b # [ 9.980850] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1635a # [ 9.940463] systemd[1]: Reached target Host and Network Name Lookups.1636a # [ 9.942040] systemd[1]: Reached target User and Group Name Lookups.1637b # [ 9.983523] systemd[1]: linger-users.service: Deactivated successfully.1638a # [ 9.946670] systemd[1]: Finished resolvconf update.1639b # [ 9.988536] systemd[1]: Finished linger-users.service.1640a # [ 9.948210] systemd[1]: Reached target Preparation for Network.1641a # [ 9.952990] systemd[1]: Starting DHCP Client...1642a # [ 9.956728] systemd[1]: Starting Address configuration of eth1...1643a # [ 9.961727] systemd[1]: Starting Extra networking commands....1644b # [ 10.024399] systemd[1]: Started Name Service Cache Daemon (nsncd).1645b # [ 10.027544] nsncd[643]: Aug 31 08:45:10.780 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1646b # [ 10.033433] systemd[1]: Reached target Host and Network Name Lookups.1647b # [ 10.035608] systemd[1]: Reached target User and Group Name Lookups.1648b # [ 10.037841] systemd[1]: Finished resolvconf update.1649b # [ 10.039470] systemd[1]: Reached target Preparation for Network.1650b # [ 10.044690] systemd[1]: Starting DHCP Client...1651b # [ 10.049371] systemd[1]: Starting Address configuration of eth1...1652b # [ 10.054351] systemd[1]: Starting Extra networking commands....1653a # [ 10.053284] network-addresses-eth1-start[679]: adding address 192.168.1.1/24... done1654a # [ 10.065643] network-addresses-eth1-start[679]: adding address 2001:db8:1::1/64... done1655a # [ 10.080422] systemd[1]: Finished Address configuration of eth1.1656a # [ 10.098028] dhcpcd[686]: dhcpcd-10.3.2 starting1657a # [ 10.107318] dhcpcd[739]: dev: loaded udev1658b # [ 10.154208] network-addresses-eth1-start[669]: adding address 192.168.1.2/24... done1659a # [ 10.117890] systemd[1]: Finished Extra networking commands..1660a # [ 10.118957] systemd[1]: Reached target Network.1661a # [ 10.121897] systemd[1]: Starting Permit User Sessions...1662a # [ 10.124679] systemd[1]: Starting Update flakelet service web...1663b # [ 10.167050] network-addresses-eth1-start[669]: adding address 2001:db8:1::2/64... done1664a # [ 10.142291] 8021q: 802.1Q VLAN Support v1.81665a # [ 10.142701] 8021q: adding VLAN 0 to HW filter on device eth11666b # [ 10.187230] systemd[1]: Finished Address configuration of eth1.1667b # [ 10.195868] dhcpcd[676]: dhcpcd-10.3.2 starting1668b # [ 10.207742] dhcpcd[722]: dev: loaded udev1669a # [ 10.170494] systemd[1]: Finished Permit User Sessions.1670a # [ 10.172862] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1671a # [ 10.175946] flakelet[747]: web: resolving path:/nix/store/6g0nzblvm1vmgi1ccz2abp1miiqh5sn8-flake.nix1672a # [ 10.178890] systemd[1]: Started Getty on tty1.1673a # [ 10.180476] systemd[1]: Reached target Login Prompts.1674b # [ 10.239281] systemd[1]: Finished Extra networking commands..1675b # [ 10.240862] systemd[1]: Reached target Network.[ 10.243719] 8021q: 802.1Q VLAN Support v1.81676b # 1677a # [ 10.200300] cfg80211: Loading compiled-in X.509 certificates for regulatory database1678b # [ 10.244194] 8021q: adding VLAN 0 to HW filter on device eth11679b # [ 10.246862] systemd[1]: Starting Permit User Sessions...1680b # [ 10.252738] systemd[1]: Starting Update flakelet service web...1681a # [ 10.214369] systemd-vconsole-setup[573]: Configuration of first virtual console was skipped, ignoring remaining ones.1682a # [ 10.218071] systemd[1]: Finished Virtual Console Setup.1683a # [ 10.228594] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1684a # [ 10.229117] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1685a # [ 10.231986] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21686a # [ 10.232345] cfg80211: failed to load regulatory.db1687b # [ 10.273088] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1688b # [ 10.289389] systemd[1]: Finished Permit User Sessions.1689b # [ 10.293540] systemd[1]: Started Getty on tty1.1690b # [ 10.295512] systemd[1]: Reached target Login Prompts.1691b # [ 10.297985] flakelet[738]: web: resolving path:/nix/store/6g0nzblvm1vmgi1ccz2abp1miiqh5sn8-flake.nix1692b # [ 10.305276] cfg80211: Loading compiled-in X.509 certificates for regulatory database1693a # [ 10.265043] systemd[1]: Started Nix Daemon.1694b # [ 10.331645] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1695b # [ 10.332202] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1696b # [ 10.335096] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21697a # [ 10.300138] 8021q: adding VLAN 0 to HW filter on device eth01698b # [ 10.335457] cfg80211: failed to load regulatory.db1699a # [ 10.297924] dhcpcd[739]: eth0: waiting for carrier1700a # [ 10.302027] dhcpcd[739]: eth0: carrier acquired1701a # [ 10.312329] dhcpcd[739]: DUID 00:01:00:01:32:27:fb:97:52:54:00:12:34:561702a # [ 10.315445] dhcpcd[739]: eth0: IAID 00:12:34:561703a # [ 10.317334] dhcpcd[739]: eth0: adding address fe80::5054:ff:fe12:34561704b # [ 10.386333] systemd[1]: Started Nix Daemon.1705b # [ 10.396162] 8021q: adding VLAN 0 to HW filter on device eth01706b # [ 10.395012] dhcpcd[722]: eth0: waiting for carrier1707b # [ 10.399430] dhcpcd[722]: eth0: carrier acquired1708b # [ 10.406569] dhcpcd[722]: DUID 00:01:00:01:32:27:fb:97:52:54:00:12:34:561709b # [ 10.408774] dhcpcd[722]: eth0: IAID 00:12:34:561710b # [ 10.410642] dhcpcd[722]: eth0: adding address fe80::5054:ff:fe12:34561711a # [ 10.392230] nix-daemon[766]: accepted connection from pid 750, user flakelet1712b # [ 10.460473] systemd-vconsole-setup[637]: Configuration of first virtual console was skipped, ignoring remaining ones.1713b # [ 10.464133] systemd[1]: Finished Virtual Console Setup.1714b # [ 10.501175] nix-daemon[757]: accepted connection from pid 741, user flakelet1715a # [ 10.569180] flakelet[747]: web: evaluating /nix/store/i4lxzxq561zv1dmg9c4bkhb4s0bscmvg-flakelet-driver.nix1716b # [ 10.684525] flakelet[738]: web: evaluating /nix/store/i4lxzxq561zv1dmg9c4bkhb4s0bscmvg-flakelet-driver.nix1717a # [ 10.690107] nix-daemon[766]: accepted connection from pid 789, user flakelet1718b # [ 10.810513] nix-daemon[757]: accepted connection from pid 778, user flakelet1719a # [ 11.555154] dhcpcd[739]: eth0: soliciting an IPv6 router1720a # [ 11.555463] dhcpcd[739]: eth0: Router Advertisement from fe80::21721a # [ 11.555594] dhcpcd[739]: eth0: adding address fec0::5054:ff:fe12:3456/641722a # [ 11.555720] dhcpcd[739]: eth0: adding route to fec0::/641723a # [ 11.555843] dhcpcd[739]: eth0: adding default route via fe80::21724b # [ 11.733959] dhcpcd[722]: eth0: soliciting a DHCP lease1725b # [ 11.757036] dhcpcd[722]: eth0: offered 10.0.2.15 from 10.0.2.21726b # [ 11.780636] dhcpcd[722]: eth0: probing address 10.0.2.15/241727a # [ 11.892433] dhcpcd[739]: eth0: soliciting a DHCP lease1728a # [ 11.912893] dhcpcd[739]: eth0: offered 10.0.2.15 from 10.0.2.21729a # [ 11.940524] dhcpcd[739]: eth0: probing address 10.0.2.15/241730b # [ 12.851099] dhcpcd[722]: eth0: soliciting an IPv6 router1731b # [ 12.851370] dhcpcd[722]: eth0: Router Advertisement from fe80::21732b # [ 12.851499] dhcpcd[722]: eth0: adding address fec0::5054:ff:fe12:3456/641733b # [ 12.851683] dhcpcd[722]: eth0: adding route to fec0::/641734b # [ 12.851815] dhcpcd[722]: eth0: adding default route via fe80::21735b # [ 16.747875] dhcpcd[722]: eth0: leased 10.0.2.15 for 86400 seconds1736b # [ 16.749019] dhcpcd[722]: eth0: adding route to 10.0.2.0/241737b # [ 16.754522] dhcpcd[722]: eth0: adding default route via 10.0.2.21738b # [ 16.986446] systemd[1]: Started DHCP Client.1739a # [ 17.135405] dhcpcd[739]: eth0: leased 10.0.2.15 for 86400 seconds1740a # [ 17.135804] dhcpcd[739]: eth0: adding route to 10.0.2.0/241741a # [ 17.135942] dhcpcd[739]: eth0: adding default route via 10.0.2.21742a # [ 17.387097] systemd[1]: Started DHCP Client.1743a # [ 18.765850] flakelet[747]: web: building /nix/store/rz5pn1xgng6xsvcl1n654a015wn1xz7d-flakelet-web.drv1744b # [ 19.052246] flakelet[738]: web: building /nix/store/rz5pn1xgng6xsvcl1n654a015wn1xz7d-flakelet-web.drv1745a # [ 20.229044] nix-daemon[766]: accepted connection from pid 978, user flakelet1746a # [ 20.269548] flakelet[747]: web: activating generation 11747a # [ 20.286470] systemd[1]: Reload requested from client PID 986 ('systemctl') (unit flakelet-web.service)...1748a # [ 20.293144] systemd[1]: Reloading...1749b # [ 20.451862] nix-daemon[757]: accepted connection from pid 971, user flakelet1750b # [ 20.482829] flakelet[738]: web: activating generation 11751b # [ 20.496894] systemd[1]: Reload requested from client PID 979 ('systemctl') (unit flakelet-web.service)...1752b # [ 20.501994] systemd[1]: Reloading...1753a # [ 20.918856] systemd[1]: Reloading finished in 630 ms.1754a # [ 21.016870] systemd[1]: Reload requested from client PID 1021 ('systemctl') (unit flakelet-web.service)...1755a # [ 21.022108] systemd[1]: Reloading...1756b # [ 21.154546] systemd[1]: Reloading finished in 654 ms.1757b # [ 21.277703] systemd[1]: Reload requested from client PID 1013 ('systemctl') (unit flakelet-web.service)...1758b # [ 21.282970] systemd[1]: Reloading...1759a # [ 21.660997] systemd[1]: Reloading finished in 640 ms.1760a # [ 21.748661] systemd[1]: Starting web.service...1761a # [ 21.843954] systemd[1]: Started web.service.1762b # [ 21.935713] systemd[1]: Reloading finished in 655 ms.1763b # [ 22.041199] systemd[1]: Starting web.service...1764b # [ 22.112041] systemd[1]: Started web.service.1765a # [ 22.098276] flakelet[747]: web: updated to generation 11766a # [ 22.101044] systemd[1]: Finished Update flakelet service web.1767a # [ 22.103745] systemd[1]: Reached target flakelet managed services.1768a: (finished: must succeed: systemctl start flakelet-web.service, in 12.28 seconds)1769a # [ 22.106889] systemd[1]: Reached target Multi-User System.1770a: must succeed: systemctl is-active web.service1771a # [ 22.109893] systemd[1]: Startup finished in 809ms (kernel) + 4.714s (initrd) + 16.579s (userspace) = 22.103s.1772a: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)1773a: must succeed: echo payload > /var/lib/private/web/file1774a: (finished: must succeed: echo payload > /var/lib/private/web/file, in 0.02 seconds)1775a: must succeed: flakelet export web --dry-run | grep -q /var/lib/web1776a: (finished: must succeed: flakelet export web --dry-run | grep -q /var/lib/web, in 0.05 seconds)1777a: must succeed: flakelet export web --copy > /tmp/shared/web.tar.zst1778a # web: stopping units1779b # [ 22.348053] flakelet[738]: web: updated to generation 11780b # [ 22.351239] systemd[1]: Finished Update flakelet service web.1781b # [ 22.353259] systemd[1]: Reached target flakelet managed services.1782b # [ 22.354419] systemd[1]: Reached target Multi-User System.1783b # [ 22.355453] systemd[1]: Startup finished in 883ms (kernel) + 4.702s (initrd) + 16.767s (userspace) = 22.352s.1784a # [ 22.483482] systemd[1]: Stopping web.service...1785a # [ 22.487761] systemd[1]: web.service: Deactivated successfully.1786a # [ 22.490390] systemd[1]: Stopped web.service.1787a # web: running web-dump.service1788a # [ 22.540981] systemd[1]: Starting dump for web...1789a # [ 22.658624] systemd[1]: web-dump.service: Deactivated successfully.1790a # [ 22.662253] systemd[1]: Finished dump for web.1791a # requires.kv: running /nix/store/fdbbpmpys08nxfk8np7rg50f571vpb9w-kv-dump1792a # web: archiving /var/lib/web1793a # web: starting units1794a # [ 22.829792] systemd[1]: Reload requested from client PID 1094 ('systemctl') (unit backdoor.service)...1795a # [ 22.834924] systemd[1]: Reloading...1796a # [ 23.495010] systemd[1]: Reloading finished in 661 ms.1797a # [ 23.609980] systemd[1]: Reload requested from client PID 1127 ('systemctl') (unit backdoor.service)...1798a # [ 23.618557] systemd[1]: Reloading...1799a # [ 24.199079] systemd[1]: Reloading finished in 585 ms.1800a # [ 24.289197] systemd[1]: Starting web.service...1801a # [ 24.342880] systemd[1]: Started web.service.1802a: (finished: must succeed: flakelet export web --copy > /tmp/shared/web.tar.zst, in 2.12 seconds)1803a: must succeed: systemctl is-active web.service1804a: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)1805a: must succeed: test -f /var/lib/private/web/dump1806a: (finished: must succeed: test -f /var/lib/private/web/dump, in 0.03 seconds)1807a: must succeed: flakelet export web --to b > /tmp/shared/web.tar.zst1808a # web: stopping units1809a # [ 24.751912] systemd[1]: Stopping web.service...1810a # [ 24.755443] systemd[1]: web.service: Deactivated successfully.1811a # [ 24.757976] systemd[1]: Stopped web.service.1812a # web: running web-dump.service1813a # [ 24.790571] systemd[1]: Starting dump for web...1814a # [ 24.900525] systemd[1]: web-dump.service: Deactivated successfully.1815a # [ 24.903448] systemd[1]: Finished dump for web.1816a # requires.kv: running /nix/store/fdbbpmpys08nxfk8np7rg50f571vpb9w-kv-dump1817a # web: archiving /var/lib/web1818a # [ 25.418802] systemd[1]: Reload requested from client PID 1198 ('systemctl') (unit backdoor.service)...1819a # [ 25.423673] systemd[1]: Reloading...1820a # [ 26.010515] systemd[1]: Reloading finished in 590 ms.1821a # [ 26.111333] systemd[1]: Reload requested from client PID 1231 ('systemctl') (unit backdoor.service)...1822a # [ 26.116519] systemd[1]: Reloading...1823a # [ 26.778443] systemd[1]: Reloading finished in 662 ms.1824a # web: disabled here, 'flakelet enable web' undoes that1825a: (finished: must succeed: flakelet export web --to b > /tmp/shared/web.tar.zst, in 2.47 seconds)1826a: must succeed: tar --zstd -tf /tmp/shared/web.tar.zst1827a: (finished: must succeed: tar --zstd -tf /tmp/shared/web.tar.zst, in 0.05 seconds)1828a: must fail: systemctl is-active web.service1829a: (finished: must fail: systemctl is-active web.service, in 0.04 seconds)1830a: must succeed: flakelet update web --no-refresh | grep disabled1831a: (finished: must succeed: flakelet update web --no-refresh | grep disabled, in 0.06 seconds)1832a: must succeed: systemctl restart flakelet-web.service1833a # [ 27.073980] systemd[1]: flakelet-web.service: Deactivated successfully.1834a # [ 27.077446] systemd[1]: Stopped Update flakelet service web.1835a # [ 27.080448] systemd[1]: flakelet-web.service: Consumed 4.421s CPU time over 16.949s wall clock time, 125.9M memory peak, 4K written to disk.1836a # [ 27.086639] systemd[1]: Stopping Update flakelet service web...1837a # [ 27.089086] systemd[1]: Starting Update flakelet service web...1838a # [ 27.145221] flakelet[1282]: web: disabled, left alone: exported to b1839a # [ 27.148000] systemd[1]: Finished Update flakelet service web.1840a: (finished: must succeed: systemctl restart flakelet-web.service, in 0.12 seconds)1841a: must succeed: flakelet boot1842a: (finished: must succeed: flakelet boot, in 0.05 seconds)1843a: must fail: systemctl is-active web.service1844a: (finished: must fail: systemctl is-active web.service, in 0.05 seconds)1845a: must succeed: flakelet status web | grep 'exported to b'1846a: (finished: must succeed: flakelet status web | grep 'exported to b', in 0.10 seconds)1847a: must fail: flakelet rollback web1848a # error: service 'web' is disabled (exported to b), run 'flakelet enable web' first1849a: (finished: must fail: flakelet rollback web, in 0.06 seconds)1850a: must succeed: flakelet enable web1851a # [ 27.468815] systemd[1]: Reload requested from client PID 1302 ('systemctl') (unit backdoor.service)...1852a # [ 27.473955] systemd[1]: Reloading...1853a # [ 28.139547] systemd[1]: Reloading finished in 666 ms.1854a # [ 28.268408] systemd[1]: Reload requested from client PID 1335 ('systemctl') (unit backdoor.service)...1855a # [ 28.273512] systemd[1]: Reloading...1856a # [ 28.889235] systemd[1]: Reloading finished in 618 ms.1857a # [ 28.967387] systemd[1]: Starting web.service...1858a # [ 29.040973] systemd[1]: Started web.service.1859a: (finished: must succeed: flakelet enable web, in 1.88 seconds)1860a: must succeed: systemctl is-active web.service1861a: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)1862a: must succeed: grep -q payload /var/lib/private/web/file1863a: (finished: must succeed: grep -q payload /var/lib/private/web/file, in 0.03 seconds)1864a: must succeed: flakelet disable web -m done1865a # [ 29.593553] systemd[1]: Stopping web.service...1866a # [ 29.596186] systemd[1]: web.service: Deactivated successfully.1867a # [ 29.598795] systemd[1]: Stopped web.service.1868a # [ 29.784113] systemd[1]: Reload requested from client PID 1387 ('systemctl') (unit backdoor.service)...1869a # [ 29.789086] systemd[1]: Reloading...1870a # [ 30.407430] systemd[1]: Reloading finished in 621 ms.1871a # [ 30.493541] systemd[1]: Reload requested from client PID 1420 ('systemctl') (unit backdoor.service)...1872a # [ 30.500856] systemd[1]: Reloading...1873a # [ 31.100862] systemd[1]: Reloading finished in 604 ms.1874a: (finished: must succeed: flakelet disable web -m done, in 1.81 seconds)1875b: must succeed: systemd-run -p DynamicUser=yes -u squat sleep infinity1876b: waiting for the VM to finish booting1877b: Guest shell says: b'Spawning backdoor root shell...\n'1878b: connected to guest root shell1879b: (connecting took 0.00 seconds)1880b: (finished: waiting for the VM to finish booting, in 0.00 seconds)1881b # [ 31.276115] systemd[1]: Started [systemd-run] /run/current-system/sw/bin/sleep infinity.1882b # Running as unit: squat.service; invocation ID: 6332e5178dde4ba491a5d9adf84b73791883b: (finished: must succeed: systemd-run -p DynamicUser=yes -u squat sleep infinity, in 0.07 seconds)1884b: must succeed: systemctl start flakelet-web.service1885b: (finished: must succeed: systemctl start flakelet-web.service, in 0.07 seconds)1886b: must succeed: systemctl is-active web.service1887b: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)1888b: must succeed: mkdir -p /srv/kv && echo stale > /srv/kv/web1889b: (finished: must succeed: mkdir -p /srv/kv && echo stale > /srv/kv/web, in 0.05 seconds)1890b: must fail: flakelet import - --no-refresh < /tmp/shared/web.tar.zst1891b # web: resolving path:/nix/store/6g0nzblvm1vmgi1ccz2abp1miiqh5sn8-flake.nix?lastModified=1&narHash=sha256-3lFMMxkSeEnEQossoJzcvROghChAoOIsHlzlQ9O6yf4%3D1892b # [ 31.641888] nix-daemon[757]: accepted connection from pid 1081, user flakelet1893b # web: evaluating /nix/store/i4lxzxq561zv1dmg9c4bkhb4s0bscmvg-flakelet-driver.nix1894b # [ 31.896458] nix-daemon[757]: accepted connection from pid 1101, user flakelet1895b # web: building /nix/store/rz5pn1xgng6xsvcl1n654a015wn1xz7d-flakelet-web.drv1896b # [ 37.069187] nix-daemon[757]: accepted connection from pid 1111, user flakelet1897b # [ 37.315243] systemd[1]: Stopping web.service...1898b # [ 37.317469] systemd[1]: web.service: Deactivated successfully.1899b # [ 37.320276] systemd[1]: Stopped web.service.1900b # [ 37.529265] systemd[1]: Reload requested from client PID 1125 ('systemctl') (unit backdoor.service)...1901b # [ 37.534379] systemd[1]: Reloading...1902b # [ 38.117845] systemd[1]: Reloading finished in 586 ms.1903b # [ 38.208571] systemd[1]: Reload requested from client PID 1159 ('systemctl') (unit backdoor.service)...1904b # [ 38.213711] systemd[1]: Reloading...1905b # [ 38.835577] systemd[1]: Reloading finished in 622 ms.1906b # web: restoring /var/lib/web1907b # requires.kv: running /nix/store/089xgxdlw5j0rrj8zkvgsap1kfp9pws9-kv-restore1908b # error: /nix/store/089xgxdlw5j0rrj8zkvgsap1kfp9pws9-kv-restore /var/cache/flakelet/.tmpdGPKPX/requires/kv/claim.json /var/cache/flakelet/.tmpdGPKPX/requires/kv failed:1909b # 1910b: (finished: must fail: flakelet import - --no-refresh < /tmp/shared/web.tar.zst, in 7.59 seconds)1911b: must fail: systemctl is-active web.service1912b: (finished: must fail: systemctl is-active web.service, in 0.05 seconds)1913b: must succeed: flakelet status web | grep 'did not finish'1914b: (finished: must succeed: flakelet status web | grep 'did not finish', in 0.11 seconds)1915b: must succeed: test -z "$(ls -A /var/lib/private/web)"1916b: (finished: must succeed: test -z "$(ls -A /var/lib/private/web)", in 0.05 seconds)1917b: must succeed: echo junk > /var/lib/private/web/junk1918b: (finished: must succeed: echo junk > /var/lib/private/web/junk, in 0.02 seconds)1919b: must fail: flakelet import /tmp/shared/web.tar.zst --no-refresh1920b # error: service 'web' cannot be imported:1921b # /var/lib/private/web is not empty (see --replace)1922b: (finished: must fail: flakelet import /tmp/shared/web.tar.zst --no-refresh, in 0.08 seconds)1923b: must succeed: flakelet import /tmp/shared/web.tar.zst --no-refresh --replace1924b # web: resolving path:/nix/store/6g0nzblvm1vmgi1ccz2abp1miiqh5sn8-flake.nix?lastModified=1&narHash=sha256-3lFMMxkSeEnEQossoJzcvROghChAoOIsHlzlQ9O6yf4%3D1925b # [ 39.525409] nix-daemon[757]: accepted connection from pid 1227, user flakelet1926b # web: evaluating /nix/store/i4lxzxq561zv1dmg9c4bkhb4s0bscmvg-flakelet-driver.nix1927b # [ 39.806426] nix-daemon[757]: accepted connection from pid 1247, user flakelet1928b # web: building /nix/store/rz5pn1xgng6xsvcl1n654a015wn1xz7d-flakelet-web.drv1929b # [ 44.788415] nix-daemon[757]: accepted connection from pid 1258, user flakelet1930b # [ 44.951881] systemd[1]: Reload requested from client PID 1268 ('systemctl') (unit backdoor.service)...1931b # [ 44.957194] systemd[1]: Reloading...1932b # [ 45.565489] systemd[1]: Reloading finished in 611 ms.1933b # web: restoring /var/lib/web1934b # requires.kv: running /nix/store/089xgxdlw5j0rrj8zkvgsap1kfp9pws9-kv-restore1935b # web: running web-restore.service1936b # [ 45.753011] systemd[1]: Reload requested from client PID 1306 ('systemctl') (unit backdoor.service)...1937b # [ 45.758321] systemd[1]: Reloading...1938b # [ 46.337714] systemd[1]: Reloading finished in 581 ms.1939b # [ 46.422471] systemd[1]: Starting restore for web...1940b # [ 46.561149] systemd[1]: web-restore.service: Deactivated successfully.1941b # [ 46.564178] systemd[1]: Finished restore for web.1942b # web: activating generation 21943b # [ 46.587450] systemd[1]: Reload requested from client PID 1345 ('systemctl') (unit backdoor.service)...1944b # [ 46.592476] systemd[1]: Reloading...1945b # [ 47.246324] systemd[1]: Reloading finished in 655 ms.1946b # [ 47.413338] systemd[1]: Reload requested from client PID 1379 ('systemctl') (unit backdoor.service)...1947b # [ 47.418364] systemd[1]: Reloading...1948b # [ 48.045998] systemd[1]: Reloading finished in 630 ms.1949b # [ 48.137810] systemd[1]: Starting web.service...1950b # [ 48.209538] systemd[1]: Started web.service.1951b: (finished: must succeed: flakelet import /tmp/shared/web.tar.zst --no-refresh --replace, in 9.11 seconds)1952b: must succeed: test ! -e /var/lib/private/web/junk1953b: (finished: must succeed: test ! -e /var/lib/private/web/junk, in 0.03 seconds)1954b: must succeed: systemctl is-active web.service1955b: (finished: must succeed: systemctl is-active web.service, in 0.04 seconds)1956b: must succeed: flakelet status web | grep ok | grep pinned1957b: (finished: must succeed: flakelet status web | grep ok | grep pinned, in 0.23 seconds)1958b: must succeed: grep -q payload /var/lib/private/web/file1959b: (finished: must succeed: grep -q payload /var/lib/private/web/file, in 0.04 seconds)1960b: must succeed: test -f /var/lib/private/web/restored1961b: (finished: must succeed: test -f /var/lib/private/web/restored, in 0.03 seconds)1962b: must succeed: grep -q bucket-data /srv/kv/web1963b: (finished: must succeed: grep -q bucket-data /srv/kv/web, in 0.03 seconds)1964b: must succeed: systemd-run --wait --pipe -p DynamicUser=yes -p User=web -p StateDirectory=web sh -c 'test -O /var/lib/web/file && echo more >> /var/lib/web/file'1965b # Running as unit: run-p1440-i1441.service1966b # [ 48.919098] systemd[1]: Started [systemd-run] /run/current-system/sw/bin/sh -c "test -O /var/lib/web/file && echo more >> /var/lib/web/file".1967b # [ 49.034748] systemd[1]: run-p1440-i1441.service: Deactivated successfully.1968b # Finished with result: success1969b # Main processes terminated with: code=exited, status=0/SUCCESS1970b # Service runtime: 119ms1971b # CPU time consumed: 55ms1972b # Memory peak: 2.4M (swap: 0B)1973b: (finished: must succeed: systemd-run --wait --pipe -p DynamicUser=yes -p User=web -p StateDirectory=web sh -c 'test -O /var/lib/web/file && echo more >> /var/lib/web/file', in 0.19 seconds)1974b: must fail: flakelet import /tmp/shared/web.tar.zst --no-refresh1975b # error: service 'web' cannot be imported:1976b # /var/lib/private/web is not empty (see --replace)1977b: (finished: must fail: flakelet import /tmp/shared/web.tar.zst --no-refresh, in 0.08 seconds)1978(finished: run the VM test script, in 50.05 seconds)1979test script finished in 50.19s1980cleanup1981kill QemuMachine (pid 47)1982a # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14)1983kill QemuMachine (pid 48)1984b # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14)1985(finished: cleanup, in 0.69 seconds)1986additionally exposed symbols:1987 a, b,1988 vlan1,1989 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_ssh1990meta.json1991state/1992state/0.tar1993requires/1994requires/kv/1995requires/kv/data1996requires/kv/claim.json1997