vm-test-run-wifi
default.checks.aarch64-linux.wifi
· build #289
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test # Disk image does not exist, creating the virtualisation disk image...14test # Formatting '/build/vm-state-test/tmp.C67uF3uqtM', fmt=raw size=107374182415test # mke2fs 1.47.4 (6-Mar-2025)16test # Discarding device blocks: 0/262144 done17test # Creating filesystem with 262144 4k blocks and 65536 inodes18test # Filesystem UUID: 649897d3-233a-4e65-a44b-9922f46956f319test # Superblock backups stored on blocks:20test # 32768, 98304, 163840, 22937621test # 22test # Allocating group tables: 0/8 done23test # Writing inode tables: 0/8 done24test # Creating journal (8192 blocks): done25test # Writing superblocks and filesystem accounting information: 0/8 done26test # 27test # Virtualisation disk image created.28test: QEMU running (pid 48)29second: QEMU running (pid 47)30second # Disk image does not exist, creating the virtualisation disk image...31second # Formatting '/build/vm-state-second/tmp.HpCLZjrk6D', fmt=raw size=107374182432second # mke2fs 1.47.4 (6-Mar-2025)33second # Discarding device blocks: 0/262144 done34second # Creating filesystem with 262144 4k blocks and 65536 inodes35second # Filesystem UUID: f874f4a6-e55f-461c-ba30-a46454c453b136second # Superblock backups stored on blocks:37second # 32768, 98304, 163840, 22937638second # 39second # Allocating group tables: 0/8 done40second # Writing inode tables: 0/8 done41second # Creating journal (8192 blocks): done42second # Writing superblocks and filesystem accounting information: 0/8 done43second # 44second # Virtualisation disk image created.45(finished: start all VMs, in 0.46 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49second # [ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Aug 3 09:22:13 UTC 202650second # [ 0.000000] KASLR enabled51second # [ 0.000000] random: crng init done52second # [ 0.000000] Machine model: linux,dummy-virt53second # [ 0.000000] efi: UEFI not found.54second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT55second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]56second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]57second # [ 0.000000] Zone ranges:58second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]59second # [ 0.000000] DMA32 empty60second # [ 0.000000] Normal empty61second # [ 0.000000] Device empty62second # [ 0.000000] Movable zone start for each node63second # [ 0.000000] Early memory node ranges64second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]65second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]66second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000067second # [ 0.000000] psci: probing for conduit method from DT.68second # [ 0.000000] psci: PSCIv1.3 detected in firmware.69second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs70second # [ 0.000000] psci: Trusted OS migration not required71second # [ 0.000000] psci: SMC Calling Convention v1.172second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)73second # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u31129674second # [ 0.000000] Detected PIPT I-cache on CPU075second # [ 0.000000] CPU features: detected: GICv3 CPU interface76second # [ 0.000000] CPU features: detected: Spectre-v477second # [ 0.000000] CPU features: detected: Spectre-BHB78second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR79second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)80second # [ 0.000000] CPU features: detected: ARM erratum 141804081second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion82second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing83second # [ 0.000000] alternatives: applying boot alternatives84second # [ 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/7kgjx8yrgyj90qa6fqyxj7r93d18p3vq-nixos-system-second-test/init regInfo=/nix/store/ay3sw998afab8405mzqsy2wa7hlrdh3v-closure-info/registration console=ttyAMA0,115200n8 console=tty085second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ay3sw998afab8405mzqsy2wa7hlrdh3v-closure-info/registration", will be passed to user space.86second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes87second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)88second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)89second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB90second # [ 0.000000] software IO TLB: area num 1.91second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)92second # [ 0.000000] Fallback order for Node 0: 093second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214494second # [ 0.000000] Policy zone: DMA95second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off96second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=197second # [ 0.000000] allocated 2097152 bytes of page_ext98second # [ 0.000000] ftrace: allocating 74872 entries in 294 pages99second # [ 0.000000] ftrace: allocated 294 pages with 4 groups100second # [ 0.000000] rcu: Hierarchical RCU implementation.101second # [ 0.000000] rcu: RCU event tracing is enabled.102test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]103second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.104second # [ 0.000000] Trampoline variant of Tasks RCU enabled.105second # [ 0.000000] Rude variant of Tasks RCU enabled.106test # [ 0.000000] Linux version 6.18.42 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Aug 3 09:22:13 UTC 2026107second # [ 0.000000] Tracing variant of Tasks RCU enabled.108test # [ 0.000000] KASLR enabled109test # [ 0.000000] random: crng init done110second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.111test # [ 0.000000] Machine model: linux,dummy-virt112test # [ 0.000000] efi: UEFI not found.113second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1114test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT115second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.116test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]117second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.118test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]119test # [ 0.000000] Zone ranges:120second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.121test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]122second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0123test # [ 0.000000] DMA32 empty124test # [ 0.000000] Normal empty125second # [ 0.000000] GICv3: 256 SPIs implemented126test # [ 0.000000] Device empty127second # [ 0.000000] GICv3: 0 Extended SPIs implemented128test # [ 0.000000] Movable zone start for each node129second # [ 0.000000] Root IRQ handler: gic_handle_irq130test # [ 0.000000] Early memory node ranges131second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI132test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]133second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0134test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]135second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000136second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]137test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000138test # [ 0.000000] psci: probing for conduit method from DT.139second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)140test # [ 0.000000] psci: PSCIv1.3 detected in firmware.141test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs142second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)143test # [ 0.000000] psci: Trusted OS migration not required144second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000145test # [ 0.000000] psci: SMC Calling Convention v1.1146second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000147test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)148second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.149test # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296150test # [ 0.000000] Detected PIPT I-cache on CPU0151second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns152test # [ 0.000000] CPU features: detected: GICv3 CPU interface153test # [ 0.000000] CPU features: detected: Spectre-v4154second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040155test # [ 0.000000] CPU features: detected: Spectre-BHB156second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).157test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR158second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns159test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)160test # [ 0.000000] CPU features: detected: ARM erratum 1418040161second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns162second # [ 0.000049] arm-pv: using stolen time PV163test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion164test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing165second # [ 0.000346] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)166test # [ 0.000000] alternatives: applying boot alternatives167second # [ 0.000608] Console: colour dummy device 80x25168second # [ 0.000625] printk: legacy console [tty0] enabled169second # [ 0.000844] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)170second # [ 0.000849] pid_max: default: 32768 minimum: 301171second # [ 0.000957] LSM: initializing lsm=capability,landlock,yama,bpf,ima172second # [ 0.001083] landlock: Up and running.173test # [ 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/njvpwrimj9h9r36zsiy14vc4az8hxarz-nixos-system-test-test/init regInfo=/nix/store/ymsm6nfgyykxarp024ialj2f8nfxyq56-closure-info/registration console=ttyAMA0,115200n8 console=tty0174second # [ 0.001085] Yama: becoming mindful.175second # [ 0.001483] LSM support for eBPF active176second # [ 0.001631] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)177test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ymsm6nfgyykxarp024ialj2f8nfxyq56-closure-info/registration", will be passed to user space.178second # [ 0.001653] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)179test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes180second # [ 0.003662] cacheinfo: Unable to detect cache hierarchy for CPU 0181test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)182second # [ 0.004465] rcu: Hierarchical SRCU implementation.183test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)184second # [ 0.004470] rcu: Max phase no-delay instances is 1000.185second # [ 0.005414] fsl-mc MSI: its@8080000 domain created186test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB187second # [ 0.005564] EFI services will not be available.188test # [ 0.000000] software IO TLB: area num 1.189second # [ 0.005651] smp: Bringing up secondary CPUs ...190second # [ 0.005683] smp: Brought up 1 node, 1 CPU191test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)192second # [ 0.005687] SMP: Total of 1 processors activated.193test # [ 0.000000] Fallback order for Node 0: 0194second # [ 0.005689] CPU: All CPU(s) started at EL1195test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144196second # [ 0.005701] CPU features: detected: 32-bit EL0 Support197test # [ 0.000000] Policy zone: DMA198test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off199second # [ 0.005704] CPU features: detected: Data cache clean to the PoU not required for I/D coherence200test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1201second # [ 0.005707] CPU features: detected: Common not Private translations202test # [ 0.000000] allocated 2097152 bytes of page_ext203second # [ 0.005709] CPU features: detected: CRC32 instructions204test # [ 0.000000] ftrace: allocating 74872 entries in 294 pages205second # [ 0.005711] CPU features: detected: Data cache clean to Point of Persistence206test # [ 0.000000] ftrace: allocated 294 pages with 4 groups207second # [ 0.005714] CPU features: detected: Enhanced Virtualization Traps208test # [ 0.000000] rcu: Hierarchical RCU implementation.209second # [ 0.005724] CPU features: detected: RCpc load-acquire (LDAPR)210test # [ 0.000000] rcu: RCU event tracing is enabled.211second # [ 0.005726] CPU features: detected: LSE atomic instructions212test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.213second # [ 0.005728] CPU features: detected: Privileged Access Never214test # [ 0.000000] Trampoline variant of Tasks RCU enabled.215second # [ 0.005730] CPU features: detected: PMUv3216test # [ 0.000000] Rude variant of Tasks RCU enabled.217second # [ 0.005732] CPU features: detected: RAS Extension Support218test # [ 0.000000] Tracing variant of Tasks RCU enabled.219second # [ 0.005736] CPU features: detected: Speculative Store Bypassing Safe (SSBS)220test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.221second # [ 0.005756] alternatives: applying system-wide alternatives222test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1223second # [ 0.007191] CPU features: detected: Hardware dirty bit management on CPU0224test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.225second # [ 0.007401] Memory: 891320K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1106K bss, 115944K reserved, 32768K cma-reserved)226test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.227second # [ 0.007851] devtmpfs: initialized228test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.229second # [ 0.009355] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)230test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0231second # [ 0.009383] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).232test # [ 0.000000] GICv3: 256 SPIs implemented233test # [ 0.000000] GICv3: 0 Extended SPIs implemented234second # [ 0.009510] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL235test # [ 0.000000] Root IRQ handler: gic_handle_irq236second # [ 0.009513] 0 pages in range for non-PLT usage237test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI238second # [ 0.009514] 508288 pages in range for PLT usage239test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0240second # [ 0.009629] pinctrl core: initialized pinctrl subsystem241second # [ 0.010415] DMI not present or invalid.242test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000243test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]244second # [ 0.013828] NET: Registered PF_NETLINK/PF_ROUTE protocol family245second # [ 0.016255] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations246test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)247second # [ 0.016389] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations248test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)249second # [ 0.016539] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations250test # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000251second # [ 0.016559] audit: initializing netlink subsys (disabled)252test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000253second # [ 0.017172] thermal_sys: Registered thermal governor 'fair_share'254second # [ 0.017174] thermal_sys: Registered thermal governor 'bang_bang'255test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.256second # [ 0.017178] thermal_sys: Registered thermal governor 'step_wise'257test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns258second # [ 0.017179] thermal_sys: Registered thermal governor 'user_space'259test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040260second # [ 0.017182] thermal_sys: Registered thermal governor 'power_allocator'261test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).262second # [ 0.017216] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1263second # [ 0.017230] cpuidle: using governor ladder264test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns265second # [ 0.017235] cpuidle: using governor menu266test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns267second # [ 0.017369] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.268test # [ 0.000044] arm-pv: using stolen time PV269second # [ 0.017390] ASID allocator initialised with 32768 entries270second # [ 0.018053] Serial: AMBA PL011 UART driver271test # [ 0.000365] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)272second # [ 0.021166] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1273test # [ 0.000636] Console: colour dummy device 80x25274second # [ 0.021348] printk: console [ttyAMA0] enabled275test # [ 0.000652] printk: legacy console [tty0] enabled276test # [ 0.000859] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)277test # [ 0.000864] pid_max: default: 32768 minimum: 301278test # [ 0.000954] LSM: initializing lsm=capability,landlock,yama,bpf,ima279test # [ 0.001081] landlock: Up and running.280test # [ 0.001083] Yama: becoming mindful.281test # [ 0.001467] LSM support for eBPF active282test # [ 0.001602] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)283test # [ 0.001621] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)284test # [ 0.003334] cacheinfo: Unable to detect cache hierarchy for CPU 0285test # [ 0.004199] rcu: Hierarchical SRCU implementation.286test # [ 0.004204] rcu: Max phase no-delay instances is 1000.287test # [ 0.005105] fsl-mc MSI: its@8080000 domain created288test # [ 0.005259] EFI services will not be available.289test # [ 0.005389] smp: Bringing up secondary CPUs ...290test # [ 0.005418] smp: Brought up 1 node, 1 CPU291test # [ 0.005423] SMP: Total of 1 processors activated.292test # [ 0.005425] CPU: All CPU(s) started at EL1293test # [ 0.005436] CPU features: detected: 32-bit EL0 Support294test # [ 0.005439] CPU features: detected: Data cache clean to the PoU not required for I/D coherence295test # [ 0.005442] CPU features: detected: Common not Private translations296test # [ 0.005444] CPU features: detected: CRC32 instructions297second # [ 0.092495] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages298test # [ 0.005446] CPU features: detected: Data cache clean to Point of Persistence299second # [ 0.092518] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page300test # [ 0.005448] CPU features: detected: Enhanced Virtualization Traps301test # [ 0.005457] CPU features: detected: RCpc load-acquire (LDAPR)302second # [ 0.092523] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages303test # [ 0.005460] CPU features: detected: LSE atomic instructions304second # [ 0.092528] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page305test # [ 0.005462] CPU features: detected: Privileged Access Never306second # [ 0.092532] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages307test # [ 0.005464] CPU features: detected: PMUv3308second # [ 0.092535] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page309test # [ 0.005466] CPU features: detected: RAS Extension Support310second # [ 0.092538] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages311test # [ 0.005469] CPU features: detected: Speculative Store Bypassing Safe (SSBS)312second # [ 0.092541] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page313test # [ 0.005490] alternatives: applying system-wide alternatives314test # [ 0.006962] CPU features: detected: Hardware dirty bit management on CPU0315test # [ 0.007163] Memory: 891376K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1106K bss, 115936K reserved, 32768K cma-reserved)316test # [ 0.007631] devtmpfs: initialized317second # [ 0.097438] fbcon: Taking over console318second # [ 0.097459] ACPI: Interpreter disabled.319test # [ 0.009178] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)320second # [ 0.098684] iommu: Default domain type: Translated321test # [ 0.009202] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).322second # [ 0.098702] iommu: DMA domain TLB invalidation policy: strict mode323test # [ 0.009342] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL324second # [ 0.099806] SCSI subsystem initialized325test # [ 0.009347] 0 pages in range for non-PLT usage326test # [ 0.009347] 508288 pages in range for PLT usage327second # [ 0.100342] usbcore: registered new interface driver usbfs328test # [ 0.009474] pinctrl core: initialized pinctrl subsystem329second # [ 0.100380] usbcore: registered new interface driver hub330test # [ 0.010290] DMI not present or invalid.331second # [ 0.100396] usbcore: registered new device driver usb332test # [ 0.013793] NET: Registered PF_NETLINK/PF_ROUTE protocol family333test # [ 0.016122] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations334second # [ 0.101818] pps_core: LinuxPPS API ver. 1 registered335test # [ 0.016264] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations336second # [ 0.101830] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>337second # [ 0.101837] PTP clock support registered338test # [ 0.016417] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations339second # [ 0.101869] EDAC MC: Ver: 3.0.0340test # [ 0.016436] audit: initializing netlink subsys (disabled)341test # [ 0.017023] thermal_sys: Registered thermal governor 'fair_share'342test # [ 0.017025] thermal_sys: Registered thermal governor 'bang_bang'343test # [ 0.017029] thermal_sys: Registered thermal governor 'step_wise'344test # [ 0.017031] thermal_sys: Registered thermal governor 'user_space'345test # [ 0.017033] thermal_sys: Registered thermal governor 'power_allocator'346test # [ 0.017067] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1347test # [ 0.017082] cpuidle: using governor ladder348test # [ 0.017087] cpuidle: using governor menu349test # [ 0.017217] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.350test # [ 0.017238] ASID allocator initialised with 32768 entries351test # [ 0.017890] Serial: AMBA PL011 UART driver352test # [ 0.021094] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1353second # [ 0.108618] scmi_core: SCMI protocol bus registered354test # [ 0.021268] printk: console [ttyAMA0] enabled355second # [ 0.109343] FPGA manager framework356second # [ 0.110401] vgaarb: loaded357second # [ 0.110826] clocksource: Switched to clocksource arch_sys_counter358second # [ 0.111274] VFS: Disk quotas dquot_6.6.0359second # [ 0.111303] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360second # [ 0.112877] netfs: FS-Cache loaded361second # [ 0.112999] pnp: PnP ACPI: disabled362test # [ 0.093334] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages363test # [ 0.093357] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page364test # [ 0.093362] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages365test # [ 0.093368] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page366test # [ 0.093371] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages367test # [ 0.093374] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page368test # [ 0.093378] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages369test # [ 0.093381] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page370test # [ 0.098349] fbcon: Taking over console371test # [ 0.098370] ACPI: Interpreter disabled.372test # [ 0.099637] iommu: Default domain type: Translated373test # [ 0.099648] iommu: DMA domain TLB invalidation policy: strict mode374test # [ 0.100803] SCSI subsystem initialized375test # [ 0.101368] usbcore: registered new interface driver usbfs376second # [ 0.121999] NET: Registered PF_INET protocol family377second # [ 0.122229] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)378test # [ 0.109435] usbcore: registered new interface driver hub379test # [ 0.109461] usbcore: registered new device driver usb380test # [ 0.109741] pps_core: LinuxPPS API ver. 1 registered381test # [ 0.109749] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>382test # [ 0.109755] PTP clock support registered383test # [ 0.109785] EDAC MC: Ver: 3.0.0384test # [ 0.112362] scmi_core: SCMI protocol bus registered385test # [ 0.113066] FPGA manager framework386test # [ 0.114202] vgaarb: loaded387test # [ 0.114636] clocksource: Switched to clocksource arch_sys_counter388test # [ 0.115052] VFS: Disk quotas dquot_6.6.0389test # [ 0.115088] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390test # [ 0.116654] netfs: FS-Cache loaded391test # [ 0.116776] pnp: PnP ACPI: disabled392test # [ 0.119248] NET: Registered PF_INET protocol family393test # [ 0.119454] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)394second # [ 0.147039] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)395second # [ 0.147070] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)396second # [ 0.147086] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)397second # [ 0.147130] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)398second # [ 0.147199] TCP: Hash tables configured (established 8192 bind 8192)399second # [ 0.147322] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)400second # [ 0.147375] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)401second # [ 0.147431] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)402second # [ 0.147567] NET: Registered PF_UNIX/PF_LOCAL protocol family403second # [ 0.147610] NET: Registered PF_XDP protocol family404second # [ 0.147631] PCI: CLS 0 bytes, default 64405second # [ 0.147841] Trying to unpack rootfs image as initramfs...406second # [ 0.166865] kvm [1]: HYP mode not available407test # [ 0.149202] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)408test # [ 0.149236] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)409test # [ 0.149250] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)410test # [ 0.149291] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)411test # [ 0.149359] TCP: Hash tables configured (established 8192 bind 8192)412test # [ 0.149458] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)413test # [ 0.149522] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.149577] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)415test # [ 0.149686] NET: Registered PF_UNIX/PF_LOCAL protocol family416test # [ 0.149722] NET: Registered PF_XDP protocol family417test # [ 0.149745] PCI: CLS 0 bytes, default 64418test # [ 0.149968] Trying to unpack rootfs image as initramfs...419test # [ 0.160617] kvm [1]: HYP mode not available420second # [ 0.233532] Initialise system trusted keyrings421second # [ 0.234040] workingset: timestamp_bits=42 max_order=18 bucket_order=0422second # [ 0.235006] squashfs: version 4.0 (2009/01/31) Phillip Lougher423second # [ 0.235492] 9p: Installing v9fs 9p2000 file system support424second # [ 0.254397] Key type asymmetric registered425second # [ 0.254423] Asymmetric key parser 'x509' registered426second # [ 0.254501] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)427test # [ 0.235047] Initialise system trusted keyrings428test # [ 0.235550] workingset: timestamp_bits=42 max_order=18 bucket_order=0429test # [ 0.236475] squashfs: version 4.0 (2009/01/31) Phillip Lougher430test # [ 0.236952] 9p: Installing v9fs 9p2000 file system support431second # [ 0.262911] io scheduler mq-deadline registered432second # [ 0.262932] io scheduler kyber registered433second # [ 0.265871] pl061_gpio 9030000.pl061: PL061 GPIO chip registered434second # [ 0.266621] ledtrig-cpu: registered to indicate activity on CPUs435second # [ 0.267462] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:436second # [ 0.267488] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000437second # [ 0.267503] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000438second # [ 0.267509] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000439second # [ 0.267535] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits440second # [ 0.267557] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]441second # [ 0.267636] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00442second # [ 0.267653] pci_bus 0000:00: root bus resource [bus 00-ff]443second # [ 0.267658] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]444second # [ 0.267662] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]445second # [ 0.267666] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]446second # [ 0.267734] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint447second # [ 0.268170] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint448second # [ 0.268293] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]449second # [ 0.268304] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]450second # [ 0.268325] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]451second # [ 0.268335] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]452test # [ 0.256277] Key type asymmetric registered453second # [ 0.268627] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint454test # [ 0.256302] Asymmetric key parser 'x509' registered455second # [ 0.268748] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]456test # [ 0.256370] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)457second # [ 0.268760] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]458second # [ 0.268779] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]459second # [ 0.269068] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint460second # [ 0.269187] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]461second # [ 0.269198] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]462second # [ 0.269218] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]463second # [ 0.269509] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint464second # [ 0.269626] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]465second # [ 0.269637] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]466second # [ 0.269656] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]467second # [ 0.269945] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint468second # [ 0.270063] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]469test # [ 0.262709] io scheduler mq-deadline registered470second # [ 0.270074] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]471test # [ 0.262730] io scheduler kyber registered472second # [ 0.270094] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]473second # [ 0.270382] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint474second # [ 0.270502] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]475second # [ 0.270513] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]476second # [ 0.270533] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]477test # [ 0.265725] pl061_gpio 9030000.pl061: PL061 GPIO chip registered478test # [ 0.266520] ledtrig-cpu: registered to indicate activity on CPUs479test # [ 0.267369] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:480test # [ 0.267397] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000481test # [ 0.267413] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000482test # [ 0.267419] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000483test # [ 0.267445] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits484test # [ 0.267467] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]485test # [ 0.267545] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00486test # [ 0.267564] pci_bus 0000:00: root bus resource [bus 00-ff]487test # [ 0.267569] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]488second # [ 0.294943] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint489test # [ 0.267573] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]490second # [ 0.295085] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]491second # [ 0.295097] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]492test # [ 0.267577] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]493second # [ 0.295118] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]494test # [ 0.267649] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint495second # [ 0.295134] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]496test # [ 0.268102] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint497second # [ 0.295477] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint498test # [ 0.268229] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]499second # [ 0.295602] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]500test # [ 0.268241] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]501second # [ 0.295621] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]502test # [ 0.268261] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]503test # [ 0.268272] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]504second # [ 0.295932] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint505second # [ 0.296058] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]506test # [ 0.268570] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint507test # [ 0.268695] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]508second # [ 0.296078] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]509test # [ 0.268706] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]510second # [ 0.296337] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint511test # [ 0.268726] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]512second # [ 0.296457] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]513test # [ 0.269028] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint514second # [ 0.296629] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint515test # [ 0.269150] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]516second # [ 0.296848] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]517test # [ 0.269161] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]518second # [ 0.296862] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]519test # [ 0.269182] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]520second # [ 0.296883] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]521test # [ 0.269477] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint522second # [ 0.297185] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint523test # [ 0.269599] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]524second # [ 0.297319] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]525test # [ 0.269610] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]526second # [ 0.297330] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]527test # [ 0.269631] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]528second # [ 0.297350] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]529test # [ 0.269946] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint530second # [ 0.297754] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned531test # [ 0.270069] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]532second # [ 0.297765] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned533test # [ 0.270080] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]534second # [ 0.297771] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned535test # [ 0.270100] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]536second # [ 0.297805] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned537test # [ 0.270397] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint538test # [ 0.270519] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]539second # [ 0.297838] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned540test # [ 0.270530] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]541second # [ 0.297871] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned542test # [ 0.270550] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]543second # [ 0.297902] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned544second # [ 0.297934] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned545second # [ 0.297967] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned546second # [ 0.297999] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned547second # [ 0.298029] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned548second # [ 0.298060] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned549second # [ 0.298142] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned550second # [ 0.298190] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned551second # [ 0.298204] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned552second # [ 0.298218] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned553second # [ 0.298232] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned554second # [ 0.298246] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned555second # [ 0.298260] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned556second # [ 0.298274] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned557second # [ 0.298288] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned558second # [ 0.298302] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned559second # [ 0.298316] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned560second # [ 0.298330] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned561second # [ 0.298344] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned562test # [ 0.295015] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint563second # [ 0.298358] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned564test # [ 0.295164] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]565second # [ 0.298372] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned566test # [ 0.295176] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]567second # [ 0.298386] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned568test # [ 0.295198] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]569second # [ 0.298399] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned570test # [ 0.295213] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]571second # [ 0.298413] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned572second # [ 0.298431] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned573test # [ 0.295535] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint574second # [ 0.298445] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned575test # [ 0.295666] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]576second # [ 0.298459] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned577test # [ 0.295686] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]578second # [ 0.298472] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned579test # [ 0.296001] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint580second # [ 0.298490] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]581test # [ 0.296132] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]582second # [ 0.298496] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]583test # [ 0.296153] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]584second # [ 0.298501] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]585test # [ 0.296419] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint586test # [ 0.296544] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]587test # [ 0.296724] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint588test # [ 0.296936] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]589test # [ 0.296951] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]590test # [ 0.296972] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]591test # [ 0.297289] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint592test # [ 0.297418] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]593test # [ 0.297430] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]594test # [ 0.297450] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]595test # [ 0.297862] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned596test # [ 0.297873] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned597test # [ 0.297879] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned598test # [ 0.297926] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned599test # [ 0.297959] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned600test # [ 0.297992] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned601test # [ 0.298024] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned602second # [ 0.335338] pci 0000:00:0a.0: enabling device (0000 -> 0002)603test # [ 0.298056] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned604test # [ 0.298089] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned605test # [ 0.298121] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned606test # [ 0.298154] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned607test # [ 0.298186] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned608test # [ 0.298273] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned609test # [ 0.298320] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned610test # [ 0.298335] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned611test # [ 0.298349] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned612test # [ 0.298363] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned613test # [ 0.298377] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned614test # [ 0.298391] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned615test # [ 0.298405] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned616second # [ 0.341753] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)617test # [ 0.298419] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned618test # [ 0.298434] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned619test # [ 0.298448] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned620test # [ 0.298463] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned621test # [ 0.298476] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned622test # [ 0.298491] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned623test # [ 0.298504] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned624test # [ 0.298519] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned625test # [ 0.298532] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned626test # [ 0.298547] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned627test # [ 0.298566] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned628test # [ 0.298580] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned629test # [ 0.298594] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned630test # [ 0.298607] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned631test # [ 0.298626] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]632test # [ 0.298632] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]633second # [ 0.351546] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)634second # [ 0.354467] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)635test # [ 0.334696] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]636test # [ 0.335482] pci 0000:00:0a.0: enabling device (0000 -> 0002)637test # [ 0.342581] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)638second # [ 0.363916] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)639second # [ 0.367518] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)640second # [ 0.369224] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)641test # [ 0.351917] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)642test # [ 0.354120] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)643second # [ 0.379042] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)644second # [ 0.381399] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)645second # [ 0.383138] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)646second # [ 0.384749] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)647second # [ 0.386812] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)648test # [ 0.363743] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)649test # [ 0.367351] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)650test # [ 0.369099] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)651second # [ 0.398249] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled652test # [ 0.378820] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)653test # [ 0.381400] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)654test # [ 0.384307] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)655second # [ 0.403598] msm_serial: driver initialized656test # [ 0.385982] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)657second # [ 0.403731] SuperH (H)SCI(F) driver initialized658second # [ 0.403766] STM32 USART driver initialized659test # [ 0.393328] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)660second # [ 0.427509] loop: module loaded661second # [ 0.427664] virtio_blk virtio5: 1/0/0 default/read/poll queues662second # [ 0.428244] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)663test # [ 0.409383] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled664second # [ 0.431249] megasas: 07.734.00.00-rc1665second # [ 0.431745] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]666second # [ 0.433855] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000667second # [ 0.433922] Intel/Sharp Extended Query Table at 0x0031668test # [ 0.411021] msm_serial: driver initialized669test # [ 0.411101] SuperH (H)SCI(F) driver initialized670test # [ 0.411139] STM32 USART driver initialized671second # [ 0.443415] Using buffer write method672second # [ 0.443494] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]673second # [ 0.446093] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000674second # [ 0.446118] Intel/Sharp Extended Query Table at 0x0031675test # [ 0.430258] loop: module loaded676test # [ 0.430406] virtio_blk virtio5: 1/0/0 default/read/poll queues677second # [ 0.455345] Using buffer write method678second # [ 0.455379] Concatenating MTD devices:679second # [ 0.455383] (0): "0.flash"680second # [ 0.455386] (1): "0.flash"681second # [ 0.455388] into device "0.flash"682test # [ 0.435118] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)683test # [ 0.439093] megasas: 07.734.00.00-rc1684test # [ 0.439592] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]685test # [ 0.441684] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000686test # [ 0.441723] Intel/Sharp Extended Query Table at 0x0031687test # [ 0.451231] Using buffer write method688test # [ 0.451324] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689test # [ 0.453986] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690test # [ 0.454014] Intel/Sharp Extended Query Table at 0x0031691test # [ 0.457649] Using buffer write method692test # [ 0.457680] Concatenating MTD devices:693test # [ 0.457683] (0): "0.flash"694test # [ 0.457686] (1): "0.flash"695test # [ 0.457689] into device "0.flash"696second # [ 0.668152] Freeing initrd memory: 27144K697second # [ 0.675121] tun: Universal TUN/TAP device driver, 1.6698second # [ 0.677816] thunder_xcv, ver 1.0699second # [ 0.677847] thunder_bgx, ver 1.0700second # [ 0.677859] nicpf, ver 1.0701second # [ 0.678155] e1000: Intel(R) PRO/1000 Network Driver702second # [ 0.678164] e1000: Copyright (c) 1999-2006 Intel Corporation.703second # [ 0.678180] e1000e: Intel(R) PRO/1000 Network Driver704second # [ 0.678187] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.705second # [ 0.678200] igb: Intel(R) Gigabit Ethernet Network Driver706second # [ 0.678204] igb: Copyright (c) 2007-2014 Intel Corporation.707second # [ 0.678215] igbvf: Intel(R) Gigabit Virtual Function Network Driver708second # [ 0.678218] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.709second # [ 0.678291] sky2: driver version 1.30710second # [ 0.679487] ehci-pci 0000:00:0a.0: EHCI Host Controller711second # [ 0.679556] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1712second # [ 0.679798] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000713second # [ 0.685656] usbcore: registered new interface driver usb-storage714second # [ 0.685749] usbcore: registered new interface driver usbserial_generic715second # [ 0.685758] usbserial: USB Serial support registered for generic716second # [ 0.686049] hv_vmbus: registering driver hyperv_keyboard717second # [ 0.688382] rtc-pl031 9010000.pl031: registered as rtc0718second # [ 0.688417] rtc-pl031 9010000.pl031: setting system clock to 2026-08-10T11:05:58 UTC (1786359958)719second # [ 0.688584] i2c_dev: i2c /dev entries driver720second # [ 0.691231] sdhci: Secure Digital Host Controller Interface driver721second # [ 0.691244] sdhci: Copyright(c) Pierre Ossman722second # [ 0.691377] Synopsys Designware Multimedia Card Interface Driver723second # [ 0.691578] sdhci-pltfm: SDHCI platform and OF driver helper724second # [ 0.692467] hid: raw HID events driver (C) Jiri Kosina725second # [ 0.692634] usbcore: registered new interface driver usbhid726second # [ 0.692639] usbhid: USB HID core driver727second # [ 0.695827] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00728second # [ 0.696169] hub 1-0:1.0: USB hub found729second # [ 0.696192] hub 1-0:1.0: 6 ports detected730second # [ 0.697595] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available731second # [ 0.698355] drop_monitor: Initializing network drop monitor service732second # [ 0.698524] NET: Registered PF_INET6 protocol family733second # [ 0.700735] Segment Routing with IPv6734second # [ 0.700760] In-situ OAM (IOAM) with IPv6735second # [ 0.700822] NET: Registered PF_PACKET protocol family736second # [ 0.701822] 9pnet: Installing 9P2000 support737test # [ 0.681422] Freeing initrd memory: 27136K738second # [ 0.704516] Key type dns_resolver registered739second # [ 0.707741] registered taskstats version 1740second # [ 0.707924] Loading compiled-in X.509 certificates741test # [ 0.688537] tun: Universal TUN/TAP device driver, 1.6742second # [ 0.713073] Demotion targets for Node 0: null743second # [ 0.713169] Key type .fscrypt registered744second # [ 0.713174] Key type fscrypt-provisioning registered745second # [ 0.713281] ima: No TPM chip found, activating TPM-bypass!746second # [ 0.713294] ima: Allocated hash algorithm: sha1747second # [ 0.713390] ima: No architecture policies found748second # [ 0.716209] input: gpio-keys as /devices/platform/gpio-keys/input/input0749test # [ 0.691251] thunder_xcv, ver 1.0750test # [ 0.691283] thunder_bgx, ver 1.0751test # [ 0.691295] nicpf, ver 1.0752test # [ 0.691596] e1000: Intel(R) PRO/1000 Network Driver753test # [ 0.691605] e1000: Copyright (c) 1999-2006 Intel Corporation.754test # [ 0.691620] e1000e: Intel(R) PRO/1000 Network Driver755test # [ 0.691626] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.756test # [ 0.691640] igb: Intel(R) Gigabit Ethernet Network Driver757test # [ 0.691643] igb: Copyright (c) 2007-2014 Intel Corporation.758test # [ 0.691654] igbvf: Intel(R) Gigabit Virtual Function Network Driver759test # [ 0.691657] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.760test # [ 0.691721] sky2: driver version 1.30761test # [ 0.692565] usbcore: registered new interface driver usb-storage762test # [ 0.692616] usbcore: registered new interface driver usbserial_generic763test # [ 0.692624] usbserial: USB Serial support registered for generic764test # [ 0.692929] hv_vmbus: registering driver hyperv_keyboard765test # [ 0.693977] ehci-pci 0000:00:0a.0: EHCI Host Controller766test # [ 0.694012] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1767test # [ 0.694215] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000768test # [ 0.701715] rtc-pl031 9010000.pl031: registered as rtc0769test # [ 0.701760] rtc-pl031 9010000.pl031: setting system clock to 2026-08-10T11:05:58 UTC (1786359958)770second # [ 0.726665] clk: Disabling unused clocks771test # [ 0.702028] i2c_dev: i2c /dev entries driver772test # [ 0.703949] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00773second # [ 0.726698] PM: genpd: Disabling unused power domains774test # [ 0.704742] hub 1-0:1.0: USB hub found775test # [ 0.705049] hub 1-0:1.0: 6 ports detected776second # [ 0.729900] Freeing unused kernel memory: 4736K777second # [ 0.729997] Run /init as init process778test # [ 0.706674] sdhci: Secure Digital Host Controller Interface driver779test # [ 0.706687] sdhci: Copyright(c) Pierre Ossman780test # [ 0.706825] Synopsys Designware Multimedia Card Interface Driver781test # [ 0.706993] sdhci-pltfm: SDHCI platform and OF driver helper782test # [ 0.707935] hid: raw HID events driver (C) Jiri Kosina783test # [ 0.708086] usbcore: registered new interface driver usbhid784test # [ 0.708091] usbhid: USB HID core driver785test # [ 0.711483] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available786test # [ 0.712275] drop_monitor: Initializing network drop monitor service787test # [ 0.712452] NET: Registered PF_INET6 protocol family788test # [ 0.714756] Segment Routing with IPv6789test # [ 0.714785] In-situ OAM (IOAM) with IPv6790test # [ 0.714855] NET: Registered PF_PACKET protocol family791test # [ 0.715919] 9pnet: Installing 9P2000 support792test # [ 0.717543] Key type dns_resolver registered793test # [ 0.721038] registered taskstats version 1794test # [ 0.721210] Loading compiled-in X.509 certificates795second # [ 0.749352] systemd[1]: Successfully made /usr/ read-only.796test # [ 0.726431] Demotion targets for Node 0: null797test # [ 0.726530] Key type .fscrypt registered798test # [ 0.726536] Key type fscrypt-provisioning registered799test # [ 0.728047] ima: No TPM chip found, activating TPM-bypass!800test # [ 0.728067] ima: Allocated hash algorithm: sha1801test # [ 0.728120] ima: No architecture policies found802test # [ 0.729695] input: gpio-keys as /devices/platform/gpio-keys/input/input0803test # [ 0.739804] clk: Disabling unused clocks804test # [ 0.739832] PM: genpd: Disabling unused power domains805test # [ 0.742994] Freeing unused kernel memory: 4736K806test # [ 0.743083] Run /init as init process807test # [ 0.761185] systemd[1]: Successfully made /usr/ read-only.808second # [ 0.942881] usb 1-1: new high-speed USB device number 2 using ehci-pci809test # [ 0.950693] usb 1-1: new high-speed USB device number 2 using ehci-pci810second # [ 1.083976] systemd[1]: systemd 261.1 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)811second # [ 1.090502] systemd[1]: Detected virtualization qemu.812second # [ 1.092094] systemd[1]: Detected architecture arm64.813second # [ 1.093125] systemd[1]: Running in initrd.814second # [ 1.095160] systemd[1]: Initializing machine ID from random generator.815second # [ 1.095547] systemd[1]: Hostname set to <second>.816second # [ 1.107633] 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/input1817test # [ 1.095925] systemd[1]: systemd 261.1 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)818test # [ 1.103175] systemd[1]: Detected virtualization qemu.819test # [ 1.104251] systemd[1]: Detected architecture arm64.820test # [ 1.105284] systemd[1]: Running in initrd.821test # [ 1.107341] systemd[1]: Initializing machine ID from random generator.822test # [ 1.109569] systemd[1]: Hostname set to <test>.823test # [ 1.118299] 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/input1824second # [ 1.191031] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0825test # [ 1.202996] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0826second # [ 1.310870] usb 1-2: new high-speed USB device number 3 using ehci-pci827test # [ 1.322662] usb 1-2: new high-speed USB device number 3 using ehci-pci828second # [ 1.363544] systemd[1]: bpf-restrict-fs: LSM BPF program attached829test # [ 1.359592] systemd[1]: bpf-restrict-fs: LSM BPF program attached830second # [ 1.411030] systemd[1]: Queued start job for default target Initrd Default Target.831second # [ 1.420438] systemd[1]: Created slice Slice /system/modprobe.832second # [ 1.421147] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.833second # [ 1.421815] systemd[1]: Expecting device /dev/disk/by-label/nixos...834second # [ 1.422365] systemd[1]: Reached target Path Units.835second # [ 1.422775] systemd[1]: Reached target Slice Units.836second # [ 1.423264] systemd[1]: Reached target Swaps.837second # [ 1.423632] systemd[1]: Reached target Timer Units.838second # [ 1.424187] systemd[1]: Listening on D-Bus System Message Bus Socket.839second # [ 1.424859] systemd[1]: Listening on Journal Socket (/dev/log).840second # [ 1.425467] systemd[1]: Listening on Journal Sockets.841second # [ 1.425984] systemd[1]: Listening on udev Control Socket.842second # [ 1.426536] systemd[1]: Listening on udev Kernel Socket.843second # [ 1.427206] systemd[1]: Reached target Socket Units.844second # [ 1.428794] systemd[1]: Starting Create List of Static Device Nodes...845second # [ 1.439048] systemd[1]: Starting Load Kernel Module 9pnet_virtio...846second # [ 1.439647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs847test # [ 1.416385] systemd[1]: Queued start job for default target Initrd Default Target.848test # [ 1.424192] systemd[1]: Created slice Slice /system/modprobe.849second # [ 1.447837] systemd[1]: Mounting Kernel Configuration File System...850test # [ 1.424946] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.851test # [ 1.425572] systemd[1]: Expecting device /dev/disk/by-label/nixos...852test # [ 1.426081] systemd[1]: Reached target Path Units.853test # [ 1.426449] systemd[1]: Reached target Slice Units.854test # [ 1.426864] systemd[1]: Reached target Swaps.855test # [ 1.427197] systemd[1]: Reached target Timer Units.856test # [ 1.427722] systemd[1]: Listening on D-Bus System Message Bus Socket.857test # [ 1.428331] systemd[1]: Listening on Journal Socket (/dev/log).858test # [ 1.428862] systemd[1]: Listening on Journal Sockets.859test # [ 1.429322] systemd[1]: Listening on udev Control Socket.860test # [ 1.429827] systemd[1]: Listening on udev Kernel Socket.861test # [ 1.430475] systemd[1]: Reached target Socket Units.862second # [ 1.455230] systemd[1]: Starting Journal Service...863test # [ 1.432061] systemd[1]: Starting Create List of Static Device Nodes...864test # [ 1.437729] systemd[1]: Starting Load Kernel Module 9pnet_virtio...865test # [ 1.438706] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs866second # [ 1.462667] 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/input2867second # [ 1.469098] systemd[1]: Starting Load Kernel Modules...868second # [ 1.469213] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os869test # [ 1.450787] systemd[1]: Mounting Kernel Configuration File System...870second # [ 1.478989] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0871test # [ 1.458513] systemd[1]: Starting Journal Service...872test # [ 1.460218] systemd[1]: Starting Load Kernel Modules...873test # [ 1.460724] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os874second # [ 1.487035] systemd[1]: Starting Coldplug All udev Devices...875second # [ 1.488511] systemd[1]: Finished Create List of Static Device Nodes.876second # [ 1.489839] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.877second # [ 1.494705] systemd-journald[73]: Collecting audit messages is disabled.878second # [ 1.495047] systemd[1]: Finished Load Kernel Module 9pnet_virtio.879second # [ 1.495323] systemd[1]: Mounted Kernel Configuration File System.880second # [ 1.497808] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...881test # [ 1.477150] systemd[1]: Starting Coldplug All udev Devices...882test # [ 1.481653] 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/input2883test # [ 1.482836] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0884test # [ 1.507027] systemd[1]: Finished Create List of Static Device Nodes.885test # [ 1.508106] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.886test # [ 1.508282] systemd[1]: Finished Load Kernel Module 9pnet_virtio.887second # [ 1.535323] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.888second # [ 1.536997] systemd[1]: Starting Create Static Device Nodes in /dev...889test # [ 1.514940] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...890test # [ 1.515723] systemd[1]: Mounted Kernel Configuration File System.891test # [ 1.528328] systemd-journald[73]: Collecting audit messages is disabled.892second # [ 1.553676] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.893second # [ 1.567161] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev894second # [ 1.573588] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0895second # [ 1.573803] [drm] features: -virgl +edid -resource_blob -host_visible896second # [ 1.573808] [drm] features: -context_init897second # [ 1.574255] [drm] number of scanouts: 1898second # [ 1.574270] [drm] number of cap sets: 0899test # [ 1.554703] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.900test # [ 1.562702] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev901second # [ 1.587301] systemd[1]: Finished Create Static Device Nodes in /dev.902second # [ 1.587609] systemd[1]: Reached target Preparation for Local File Systems.903test # [ 1.564732] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.904second # [ 1.587646] systemd[1]: Reached target Local File Systems.905test # [ 1.566391] systemd[1]: Starting Create Static Device Nodes in /dev...906second # [ 1.590115] systemd[1]: Starting Rule-based Manager for Device Events and Files...907second # [ 1.593231] systemd-modules-load[74]: Inserted module 'dm_mod'908second # [ 1.600832] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic909second # [ 1.600850] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0910second # [ 1.599853] systemd-modules-load[74]: Module 'virtio_balloon' is built in911second # [ 1.600746] systemd-modules-load[74]: Module 'virtio_console' is built in912second # [ 1.608740] systemd[1]: Started Journal Service.913test # [ 1.583757] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0914test # [ 1.583986] [drm] features: -virgl +edid -resource_blob -host_visible915test # [ 1.583993] [drm] features: -context_init916test # [ 1.584463] [drm] number of scanouts: 1917test # [ 1.584479] [drm] number of cap sets: 0918second # [ 1.615203] Console: switching to colour frame buffer device 160x50919second # [ 1.618665] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device920test # [ 1.599082] systemd[1]: Finished Create Static Device Nodes in /dev.921test # [ 1.599245] systemd[1]: Reached target Preparation for Local File Systems.922test # [ 1.599277] systemd[1]: Reached target Local File Systems.923test # [ 1.601831] systemd[1]: Starting Rule-based Manager for Device Events and Files...924test # [ 1.606977] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic925test # [ 1.606994] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0926second # [ 1.631603] systemd[1]: Starting Create System Files and Directories...927second # [ 1.632802] systemd-modules-load[74]: Inserted module 'virtio_gpu'928second # [ 1.633376] systemd-modules-load[74]: Module 'virtio_rng' is built in929test # [ 1.613325] systemd-modules-load[74]: Inserted module 'dm_mod'930test # [ 1.620906] Console: switching to colour frame buffer device 160x50931test # [ 1.624765] systemd[1]: Started Journal Service.932test # [ 1.619541] systemd-modules-load[74]: Module 'virtio_balloon' is built in933test # [ 1.620294] systemd-modules-load[74]: Module 'virtio_console' is built in934second # [ 1.646060] systemd[1]: Finished Load Kernel Modules.935test # [ 1.635345] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device936test # [ 1.631159] systemd[1]: Starting Create System Files and Directories...937second # [ 1.660583] systemd[1]: Starting Apply Kernel Variables...938test # [ 1.640062] systemd-modules-load[74]: Inserted module 'virtio_gpu'939test # [ 1.640634] systemd-modules-load[74]: Module 'virtio_rng' is built in940second # [ 1.663698] systemd-udevd[80]: Using default interface naming scheme 'v261'.941test # [ 1.644160] systemd[1]: Finished Load Kernel Modules.942second # [ 1.672197] systemd[1]: Finished Create System Files and Directories.943second # [ 1.678867] systemd[1]: Finished Apply Kernel Variables.944test # [ 1.664450] systemd[1]: Starting Apply Kernel Variables...945second # [ 1.698866] systemd[1]: Started Rule-based Manager for Device Events and Files.946test # [ 1.680714] systemd[1]: Finished Apply Kernel Variables.947test # [ 1.686621] systemd[1]: Finished Create System Files and Directories.948test # [ 1.695108] systemd-udevd[80]: Using default interface naming scheme 'v261'.949test # [ 1.712149] systemd[1]: Started Rule-based Manager for Device Events and Files.950second # [ 1.745559] systemd[1]: Starting Virtual Console Setup...951second # [ 1.792925] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.952second # [ 1.794739] systemd[1]: Finished Virtual Console Setup.953test # [ 1.775463] systemd[1]: Starting Virtual Console Setup...954test # [ 1.808377] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.955test # [ 1.810585] systemd[1]: Finished Virtual Console Setup.956second # [ 2.016685] systemd[1]: Finished Coldplug All udev Devices.957second # [ 2.017819] systemd[1]: Reached target System Initialization.958second # [ 2.018302] systemd[1]: Reached target Basic System.959test # [ 2.029096] systemd[1]: Finished Coldplug All udev Devices.960test # [ 2.029658] systemd[1]: Reached target System Initialization.961test # [ 2.030145] systemd[1]: Reached target Basic System.962second # [ 2.107960] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.963second # [ 2.136687] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.964test # [ 2.126184] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.965test # [ 2.144995] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.966second # [ 2.188388] systemd[1]: Found device /dev/disk/by-label/nixos.967second # [ 2.189742] systemd[1]: Reached target Initrd Root Device.968second # [ 2.192082] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969second # [ 2.238471] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks970second # [ 2.242304] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.971test # [ 2.224813] systemd[1]: Found device /dev/disk/by-label/nixos.972test # [ 2.225405] systemd[1]: Reached target Initrd Root Device.973test # [ 2.226965] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...974test # [ 2.263290] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks975test # [ 2.266951] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.976second # [ 2.482515] systemd[1]: Mounting /sysroot...977test # [ 2.476162] systemd[1]: Mounting /sysroot...978second # [ 2.515504] EXT4-fs (vda): mounted filesystem f874f4a6-e55f-461c-ba30-a46454c453b1 r/w with ordered data mode. Quota mode: none.979second # [ 2.513466] systemd[1]: Mounted /sysroot.980second # [ 2.515248] systemd[1]: Reached target Initrd Root File System.981second # [ 2.520410] systemd[1]: Mounting /sysroot/nix/.ro-store...982test # [ 2.507784] EXT4-fs (vda): mounted filesystem 649897d3-233a-4e65-a44b-9922f46956f3 r/w with ordered data mode. Quota mode: none.983test # [ 2.505778] systemd[1]: Mounted /sysroot.984second # [ 2.528911] systemd[1]: Mounting /sysroot/nix/.rw-store...985test # [ 2.507164] systemd[1]: Reached target Initrd Root File System.986test # [ 2.511874] systemd[1]: Mounting /sysroot/nix/.ro-store...987second # [ 2.539158] systemd[1]: Mounting /sysroot/run...988test # [ 2.521752] systemd[1]: Mounting /sysroot/nix/.rw-store...989second # [ 2.555210] systemd[1]: Mounting /sysroot/tmp/shared...990test # [ 2.532142] systemd[1]: Mounting /sysroot/run...991second # [ 2.561033] systemd[1]: Mounting /sysroot/tmp/xchg...992second # [ 2.573381] systemd[1]: Starting Mountpoints Configured in the Real Root...993test # [ 2.553192] systemd[1]: Mounting /sysroot/tmp/shared...994test # [ 2.563137] systemd[1]: Mounting /sysroot/tmp/xchg...995second # [ 2.603681] systemd[1]: Mounted /sysroot/nix/.ro-store.996test # [ 2.583639] systemd[1]: Starting Mountpoints Configured in the Real Root...997test # [ 2.586596] systemd[1]: Mounted /sysroot/nix/.rw-store.998test # [ 2.594747] systemd[1]: Mounted /sysroot/nix/.ro-store.999second # [ 2.621812] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.1000second # [ 2.623511] systemd[1]: Mounted /sysroot/nix/.rw-store.1001second # [ 2.630738] systemd[1]: Mounted /sysroot/run.1002test # [ 2.612544] systemd[1]: Mounted /sysroot/run.1003second # [ 2.641806] systemd[1]: Mounted /sysroot/tmp/shared.1004second # [ 2.642712] systemd[1]: Mounted /sysroot/tmp/xchg.1005second # [ 2.646180] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1006second # [ 2.647862] systemd[1]: Reloading...1007test # [ 2.627219] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.1008test # [ 2.629828] systemd[1]: Starting rw-sysroot-nix-store.service...1009test # [ 2.642208] systemd[1]: Mounted /sysroot/tmp/shared.1010test # [ 2.643959] systemd[1]: Mounted /sysroot/tmp/xchg.1011test # [ 2.647970] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1012test # [ 2.652496] systemd[1]: Reloading...1013second # [ 2.823844] systemd[1]: Reloading finished in 178 ms.1014test # [ 2.830236] systemd[1]: Reloading finished in 179 ms.1015second # [ 2.853344] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1016second # [ 2.854949] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1017second # [ 2.862912] systemd[1]: Starting rw-sysroot-nix-store.service...1018second # [ 2.865015] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019second # [ 2.873874] systemd[1]: Finished Mountpoints Configured in the Real Root.1020second # [ 2.874521] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1021second # [ 2.878828] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1022second # [ 2.879494] systemd[1]: Finished rw-sysroot-nix-store.service.1023test # [ 2.856977] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1024test # [ 2.858941] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1025test # [ 2.861664] systemd[1]: Finished rw-sysroot-nix-store.service.1026test # [ 2.862904] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1027test # [ 2.864881] systemd[1]: Starting rw-sysroot-nix-store.service...1028test # [ 2.872473] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1029test # [ 2.873648] systemd[1]: Finished Mountpoints Configured in the Real Root.1030test # [ 2.874374] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1031test # [ 2.889543] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1032test # [ 2.890437] systemd[1]: Finished rw-sysroot-nix-store.service.1033second # [ 3.058388] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/x3ma60wd3w0db1m4dr1xln72q96lnm3b-systemd-261.1/lib/udev/mtd_probe": No such file or directory1034second # [ 3.066481] (udev-worker)[95]: mtd0ro: /nix/store/x3ma60wd3w0db1m4dr1xln72q96lnm3b-systemd-261.1/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 directory1035second # [ 3.075267] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1036second # [ 3.075960] systemd[1]: Stopped Virtual Console Setup.1037second # [ 3.077253] systemd[1]: Stopping Virtual Console Setup...1038second # [ 3.080490] systemd[1]: Starting Virtual Console Setup...1039test # [ 3.067020] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/x3ma60wd3w0db1m4dr1xln72q96lnm3b-systemd-261.1/lib/udev/mtd_probe": No such file or directory1040test # [ 3.070021] (udev-worker)[98]: mtd0ro: /nix/store/x3ma60wd3w0db1m4dr1xln72q96lnm3b-systemd-261.1/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 directory1041second # [ 3.103579] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.1042second # [ 3.106175] systemd[1]: Finished Virtual Console Setup.1043test # [ 3.086763] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1044test # [ 3.088393] systemd[1]: Stopped Virtual Console Setup.1045test # [ 3.089925] systemd[1]: Stopping Virtual Console Setup...1046test # [ 3.095128] systemd[1]: Starting Virtual Console Setup...1047test # [ 3.115409] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.1048test # [ 3.117904] systemd[1]: Finished Virtual Console Setup.1049second # [ 3.484086] systemd[1]: Mounting /sysroot/nix/store...1050test # [ 3.475148] systemd[1]: Mounting /sysroot/nix/store...1051second # [ 3.535783] systemd[1]: Mounted /sysroot/nix/store.1052second # [ 3.539574] systemd[1]: Reached target Initrd File Systems.1053second # [ 3.544421] systemd[1]: Starting Find NixOS closure...1054second # [ 3.547499] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1055test # [ 3.526563] systemd[1]: Mounted /sysroot/nix/store.1056test # [ 3.528745] systemd[1]: Reached target Initrd File Systems.1057test # [ 3.532614] systemd[1]: Starting Find NixOS closure...1058test # [ 3.544370] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1059second # [ 3.594586] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1060second # [ 3.601074] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1061test # [ 3.584354] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1062test # [ 3.587035] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1063second # [ 3.614513] systemd[1]: Finished Find NixOS closure.1064second # [ 3.616208] systemd[1]: Reached target Initrd Default Target.1065second # [ 3.618250] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1066test # [ 3.606120] systemd[1]: Finished Find NixOS closure.1067test # [ 3.608251] systemd[1]: Reached target Initrd Default Target.1068test # [ 3.610458] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1069second # [ 3.653225] systemd[1]: Stopped target Initrd Default Target.1070second # [ 3.655135] systemd[1]: Stopped target Basic System.1071second # [ 3.660260] systemd[1]: Stopped target Initrd Root Device.1072second # [ 3.661085] systemd[1]: Stopped target Path Units.1073second # [ 3.661787] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1074second # [ 3.662931] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1075second # [ 3.663940] systemd[1]: Stopped target Slice Units.1076second # [ 3.665530] systemd[1]: Stopped target Socket Units.1077test # [ 3.643281] systemd[1]: Stopped target Initrd Default Target.1078second # [ 3.667329] systemd[1]: Stopped target System Initialization.1079test # [ 3.645045] systemd[1]: Stopped target Basic System.1080test # [ 3.648076] systemd[1]: Stopped target Initrd Root Device.1081test # [ 3.649141] systemd[1]: Stopped target Path Units.1082test # [ 3.650280] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1083second # [ 3.672156] systemd[1]: Stopped target Swaps.1084second # [ 3.673296] systemd[1]: Stopped target Timer Units.1085second # [ 3.673828] systemd[1]: dbus.socket: Deactivated successfully.1086second # [ 3.674471] systemd[1]: Closed D-Bus System Message Bus Socket.1087second # [ 3.675124] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1088second # [ 3.675923] systemd[1]: Stopped Find NixOS closure.1089test # [ 3.652822] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1090test # [ 3.654915] systemd[1]: Stopped target Slice Units.1091second # [ 3.679181] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1092test # [ 3.660117] systemd[1]: Stopped target Socket Units.1093test # [ 3.660797] systemd[1]: Stopped target System Initialization.1094second # [ 3.684448] systemd[1]: Starting rw-sysroot-nix-store.service...1095test # [ 3.661517] systemd[1]: Stopped target Swaps.1096test # [ 3.662094] systemd[1]: Stopped target Timer Units.1097test # [ 3.662731] systemd[1]: dbus.socket: Deactivated successfully.1098second # [ 3.686133] systemd[1]: systemd-sysctl.service: Deactivated successfully.1099test # [ 3.664120] systemd[1]: Closed D-Bus System Message Bus Socket.1100second # [ 3.687746] systemd[1]: Stopped Apply Kernel Variables.1101second # [ 3.688451] systemd[1]: systemd-modules-load.service: Deactivated successfully.1102test # [ 3.665412] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1103test # [ 3.668115] systemd[1]: Stopped Find NixOS closure.1104second # [ 3.691473] systemd[1]: Stopped Load Kernel Modules.1105test # [ 3.668752] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1106test # [ 3.670043] systemd[1]: Starting rw-sysroot-nix-store.service...1107test # [ 3.672316] systemd[1]: systemd-sysctl.service: Deactivated successfully.1108second # [ 3.696162] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1109test # [ 3.673563] systemd[1]: Stopped Apply Kernel Variables.1110test # [ 3.677156] systemd[1]: systemd-modules-load.service: Deactivated successfully.1111second # [ 3.700880] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1112test # [ 3.678519] systemd[1]: Stopped Load Kernel Modules.1113second # [ 3.701941] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1114test # [ 3.680113] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1115second # [ 3.704338] systemd[1]: Stopped Create System Files and Directories.1116second # [ 3.704952] systemd[1]: Stopped target Local File Systems.1117second # [ 3.705963] systemd[1]: Stopped target Preparation for Local File Systems.1118test # [ 3.683644] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1119second # [ 3.707235] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1120second # [ 3.708401] systemd[1]: Stopped Coldplug All udev Devices.1121second # [ 3.708906] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1122second # [ 3.709515] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1123test # [ 3.685292] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1124second # [ 3.710116] systemd[1]: Stopped Virtual Console Setup.1125second # [ 3.710669] systemd[1]: systemd-udevd.service: Deactivated successfully.1126second # [ 3.711234] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1127second # [ 3.711815] systemd[1]: initrd-cleanup.service: Deactivated successfully.1128test # [ 3.693967] systemd[1]: Stopped Create System Files and Directories.1129test # [ 3.694600] systemd[1]: Stopped target Local File Systems.1130second # [ 3.719608] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1131second # [ 3.720741] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1132test # [ 3.698100] systemd[1]: Stopped target Preparation for Local File Systems.1133second # [ 3.721571] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1134second # [ 3.723156] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1135test # [ 3.700227] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1136test # [ 3.703069] systemd[1]: Stopped Coldplug All udev Devices.1137second # [ 3.726846] systemd[1]: Closed udev Control Socket.1138second # [ 3.727300] systemd[1]: Starting Cleanup udev Database...1139second # [ 3.727763] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1140test # [ 3.703641] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1141second # [ 3.728715] systemd[1]: Stopped Create Static Device Nodes in /dev.1142second # [ 3.729247] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1143test # [ 3.706523] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1144second # [ 3.730367] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1145test # [ 3.708285] systemd[1]: Stopped Virtual Console Setup.1146second # [ 3.731537] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1147second # [ 3.732248] systemd[1]: Stopped Create List of Static Device Nodes.1148second # [ 3.732766] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1149test # [ 3.709549] systemd[1]: initrd-cleanup.service: Deactivated successfully.1150second # [ 3.733346] systemd[1]: Finished rw-sysroot-nix-store.service.1151test # [ 3.710187] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1152test # [ 3.711861] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1153test # [ 3.712851] systemd[1]: Finished rw-sysroot-nix-store.service.1154test # [ 3.713338] systemd[1]: systemd-udevd.service: Deactivated successfully.1155test # [ 3.713864] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1156test # [ 3.714423] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1157test # [ 3.714999] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1158test # [ 3.715489] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1159test # [ 3.719599] systemd[1]: Closed udev Control Socket.1160test # [ 3.724117] systemd[1]: Starting Cleanup udev Database...1161test # [ 3.724651] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1162test # [ 3.728089] systemd[1]: Stopped Create Static Device Nodes in /dev.1163test # [ 3.728663] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1164test # [ 3.729316] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1165second # [ 3.752506] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1166second # [ 3.753197] systemd[1]: Finished Cleanup udev Database.1167test # [ 3.729914] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1168test # [ 3.730474] systemd[1]: Stopped Create List of Static Device Nodes.1169second # [ 3.754456] systemd[1]: Reached target Switch Root.1170second # [ 3.756767] systemd[1]: Starting NixOS Activation...1171test # [ 3.741561] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1172test # [ 3.743335] systemd[1]: Finished Cleanup udev Database.1173test # [ 3.743837] systemd[1]: Reached target Switch Root.1174test # [ 3.748129] systemd[1]: Starting NixOS Activation...1175second # [ 3.932619] initrd-nixos-activation-start[177]: booting system configuration /nix/store/7kgjx8yrgyj90qa6fqyxj7r93d18p3vq-nixos-system-second-test1176test # [ 3.937284] initrd-nixos-activation-start[179]: booting system configuration /nix/store/njvpwrimj9h9r36zsiy14vc4az8hxarz-nixos-system-test-test1177second # [ 3.999409] initrd-nixos-activation-start[177]: running activation script...1178test # [ 4.005714] initrd-nixos-activation-start[179]: running activation script...1179second # [ 4.442194] initrd-nixos-activation-start[200]: setting up /etc...1180test # [ 4.481212] initrd-nixos-activation-start[202]: setting up /etc...1181second # [ 4.679846] initrd-nixos-activation-start[200]: setting up age secrets...1182test # [ 4.751295] initrd-nixos-activation-start[202]: setting up age secrets...1183second # [ 4.868496] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1184second # [ 4.870200] systemd[1]: Finished NixOS Activation.1185second # [ 4.870970] systemd[1]: Starting Switch Root...1186second # [ 4.884837] systemd[1]: Switching root.1187second # [ 5.052789] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1188test # [ 5.042361] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1189test # [ 5.044119] systemd[1]: Finished NixOS Activation.1190test # [ 5.044860] systemd[1]: Starting Switch Root...1191test # [ 5.061054] systemd[1]: Switching root.1192test # [ 5.237277] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1193second # [ 5.639108] systemd[1]: systemd 261.1 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)1194second # [ 5.646069] systemd[1]: Detected virtualization qemu.1195second # [ 5.648117] systemd[1]: Detected architecture arm64.1196second # [ 5.649822] systemd[1]: Detected first boot.1197second # [ 5.654371] systemd[1]: Initializing machine ID from random generator.1198test # [ 5.829857] systemd[1]: systemd 261.1 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)1199test # [ 5.836643] systemd[1]: Detected virtualization qemu.1200test # [ 5.838431] systemd[1]: Detected architecture arm64.1201test # [ 5.840318] systemd[1]: Detected first boot.1202test # [ 5.845899] systemd[1]: Initializing machine ID from random generator.1203second # [ 5.948336] systemd[1]: bpf-restrict-fs: LSM BPF program attached1204second # [ 6.117187] systemd[1]: Applying preset policy.1205test # [ 6.143972] systemd[1]: bpf-restrict-fs: LSM BPF program attached1206test # [ 6.333349] systemd[1]: Applying preset policy.1207second # [ 6.581709] systemd[1]: Populated /etc with preset unit settings.1208test # [ 6.857230] systemd[1]: Populated /etc with preset unit settings.1209second # [ 7.078578] systemd[1]: initrd-switch-root.service: Deactivated successfully.1210second # [ 7.079656] systemd[1]: Stopped initrd-switch-root.service.1211second # [ 7.081450] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1212second # [ 7.083790] systemd[1]: Created slice Slice /system/getty.1213second # [ 7.085439] systemd[1]: Created slice User and Session Slice.1214second # [ 7.086069] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1215second # [ 7.087896] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1216second # [ 7.088546] systemd[1]: Expecting device /dev/hvc0...1217second # [ 7.088935] systemd[1]: Expecting device /dev/ttyAMA0...1218second # [ 7.089370] systemd[1]: Reached target Local Encrypted Volumes.1219second # [ 7.089840] systemd[1]: Stopped target initrd-fs.target.1220second # [ 7.090278] systemd[1]: Stopped target initrd-root-fs.target.1221second # [ 7.091453] systemd[1]: Stopped target initrd-switch-root.target.1222second # [ 7.092438] systemd[1]: Reached target Virtual Machines and Containers.1223second # [ 7.093529] systemd[1]: Reached target Path Units.1224second # [ 7.095023] systemd[1]: Reached target Remote File Systems.1225second # [ 7.095930] systemd[1]: Reached target Slice Units.1226second # [ 7.097400] systemd[1]: Reached target Swaps.1227second # [ 7.101361] systemd[1]: Listening on Query the User Interactively for a Password.1228second # [ 7.106036] systemd[1]: Listening on Process Core Dump Socket.1229second # [ 7.109719] systemd[1]: Listening on Credential Encryption/Decryption.1230second # [ 7.113375] systemd[1]: Listening on Factory Reset Management.1231second # [ 7.113849] systemd[1]: Listening on Hostname Service Socket.1232second # [ 7.119299] systemd[1]: Starting Journal Log Access Socket...1233second # [ 7.120581] systemd[1]: Listening on Journal Audit Socket.1234second # [ 7.125405] systemd[1]: Listening on Console Output Muting Service Socket.1235second # [ 7.126552] systemd[1]: Listening on Network Management Metrics Varlink Socket.1236second # [ 7.127786] systemd[1]: Listening on Network Management Varlink Socket.1237second # [ 7.128903] systemd[1]: Listening on Network Management Netlink Socket.1238second # [ 7.130070] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1239second # [ 7.131793] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1240second # [ 7.132973] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1241second # [ 7.143308] systemd[1]: Listening on Disk Repartitioning Service Socket.1242second # [ 7.144488] systemd[1]: Listening on Resolve Monitor Varlink Socket.1243second # [ 7.145555] systemd[1]: Listening on Resolve Service Varlink Socket.1244second # [ 7.146622] systemd[1]: Listening on udev Control Socket.1245second # [ 7.148356] systemd[1]: Listening on udev Varlink Socket.1246second # [ 7.152305] systemd[1]: Mounting Huge Pages File System...1247second # [ 7.156445] systemd[1]: Mounting POSIX Message Queue File System...1248second # [ 7.163041] systemd[1]: Mounting Kernel Debug File System...1249second # [ 7.168442] systemd[1]: Mounting Kernel Trace File System...1250second # [ 7.179718] systemd[1]: Starting Create List of Static Device Nodes...1251second # [ 7.190504] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1252second # [ 7.191689] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1253second # [ 7.201056] systemd[1]: Mounting Kernel Configuration File System...1254second # [ 7.202959] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1255second # [ 7.204654] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1256second # [ 7.219648] systemd[1]: Starting Load Kernel Module fuse...1257second # [ 7.220053] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671258second # [ 7.226822] systemd[1]: Starting Journal Service...1259second # [ 7.285364] systemd[1]: Starting Load Kernel Modules...1260second # [ 7.336670] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1261second # [ 7.358547] fuse: init (API version 7.45)1262second # [ 7.361148] systemd[1]: Starting Remount Root and Kernel File Systems...1263second # [ 7.361568] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1264second # [ 7.381028] systemd[1]: Starting Coldplug All udev Devices...1265second # [ 7.431744] systemd-journald[300]: Collecting audit messages is enabled.1266second # [ 7.437281] systemd[1]: Listening on Journal Log Access Socket.1267second # [ 7.440923] systemd[1]: Mounted Huge Pages File System.1268second # [ 7.442645] systemd[1]: Mounted POSIX Message Queue File System.1269second # [ 7.445107] systemd[1]: Mounted Kernel Debug File System.1270second # [ 7.451005] systemd[1]: Mounted Kernel Trace File System.1271second # [ 7.451494] systemd[1]: Started Journal Service.1272second # [ 7.446758] systemd[1]: Queued start job for default target Multi-User System.1273second # [ 7.448718] systemd[1]: systemd-journald.service: Deactivated successfully.1274test # [ 7.436825] systemd[1]: initrd-switch-root.service: Deactivated successfully.1275test # [ 7.437664] systemd[1]: Stopped initrd-switch-root.service.1276second # [ 7.455054] systemd-modules-load[301]: Module 'atkbd' is built in1277second # [ 7.455693] systemd-modules-load[301]: Module 'ctr' is built in1278test # [ 7.439818] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1279second # [ 7.457733] systemd-modules-load[301]: Module 'loop' is built in1280test # [ 7.442481] systemd[1]: Created slice Slice /system/getty.1281test # [ 7.443562] systemd[1]: Created slice User and Session Slice.1282test # [ 7.444807] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1283test # [ 7.446182] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1284test # [ 7.447672] systemd[1]: Expecting device /dev/hvc0...1285second # [ 7.464132] systemd[1]: Finished Create List of Static Device Nodes.1286test # [ 7.448115] systemd[1]: Expecting device /dev/ttyAMA0...1287test # [ 7.449146] systemd[1]: Reached target Local Encrypted Volumes.1288test # [ 7.450243] systemd[1]: Stopped target initrd-fs.target.1289test # [ 7.451379] systemd[1]: Stopped target initrd-root-fs.target.1290test # [ 7.452373] systemd[1]: Stopped target initrd-switch-root.target.1291test # [ 7.453418] systemd[1]: Reached target Virtual Machines and Containers.1292test # [ 7.455096] systemd[1]: Reached target Path Units.1293second # [ 7.467617] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1294second # [ 7.473713] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1295test # [ 7.456488] systemd[1]: Reached target Remote File Systems.1296second # [ 7.474345] systemd[1]: Mounted Kernel Configuration File System.1297second # [ 7.474962] systemd[1]: modprobe@fuse.service: Deactivated successfully.1298second # [ 7.475629] systemd[1]: Finished Load Kernel Module fuse.1299test # [ 7.457917] systemd[1]: Reached target Slice Units.1300test # [ 7.459382] systemd[1]: Reached target Swaps.1301test # [ 7.463434] systemd[1]: Listening on Query the User Interactively for a Password.1302second # [ 7.484554] systemd[1]: Finished Load Kernel Modules.1303test # [ 7.468109] systemd[1]: Listening on Process Core Dump Socket.1304second # [ 7.492565] EXT4-fs (vda): re-mounted f874f4a6-e55f-461c-ba30-a46454c453b1.1305second # [ 7.488282] systemd[1]: Mounting FUSE Control File System...1306test # [ 7.471979] systemd[1]: Listening on Credential Encryption/Decryption.1307second # [ 7.489979] systemd[1]: Starting Firewall...1308second # [ 7.490440] systemd[1]: Starting Apply Kernel Variables...1309test # [ 7.475834] systemd[1]: Listening on Factory Reset Management.1310test # [ 7.477382] systemd[1]: Listening on Hostname Service Socket.1311test # [ 7.482291] systemd[1]: Starting Journal Log Access Socket...1312second # [ 7.500502] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1313test # [ 7.483878] systemd[1]: Listening on Journal Audit Socket.1314test # [ 7.487875] systemd[1]: Listening on Console Output Muting Service Socket.1315test # [ 7.489569] systemd[1]: Listening on Network Management Metrics Varlink Socket.1316test # [ 7.491626] systemd[1]: Listening on Network Management Varlink Socket.1317test # [ 7.492736] systemd[1]: Listening on Network Management Netlink Socket.1318test # [ 7.494468] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1319second # [ 7.512335] systemd-oomd[302]: No swap; memory pressure usage will be degraded1320test # [ 7.496206] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1321test # [ 7.498676] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1322second # [ 7.525269] systemd[1]: Finished Remount Root and Kernel File Systems.1323test # [ 7.508908] systemd[1]: Listening on Disk Repartitioning Service Socket.1324test # [ 7.510005] systemd[1]: Listening on Resolve Monitor Varlink Socket.1325test # [ 7.511159] systemd[1]: Listening on Resolve Service Varlink Socket.1326test # [ 7.512264] systemd[1]: Listening on udev Control Socket.1327second # [ 7.529351] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1328test # [ 7.513327] systemd[1]: Listening on udev Varlink Socket.1329test # [ 7.517283] systemd[1]: Mounting Huge Pages File System...1330test # [ 7.521340] systemd[1]: Mounting POSIX Message Queue File System...1331test # [ 7.531079] systemd[1]: Mounting Kernel Debug File System...1332test # [ 7.540631] systemd[1]: Mounting Kernel Trace File System...1333second # [ 7.561380] systemd[1]: Listening on Disk Image Download Service Socket.1334test # [ 7.546874] systemd[1]: Starting Create List of Static Device Nodes...1335test # [ 7.552531] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1336second # [ 7.574753] systemd[1]: Starting Flush Journal to Persistent Storage...1337test # [ 7.558807] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1338second # [ 7.576830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1339second # [ 7.586242] systemd[1]: Starting Load/Save OS Random Seed...1340test # [ 7.571790] systemd[1]: Mounting Kernel Configuration File System...1341test # [ 7.573751] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1342test # [ 7.577152] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1343second # [ 7.595761] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1344test # [ 7.589110] systemd[1]: Starting Load Kernel Module fuse...1345test # [ 7.590038] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671346second # [ 7.642900] systemd[1]: Mounted FUSE Control File System.1347second # [ 7.656241] systemd-journald[300]: Received client request to flush runtime journal.1348test # [ 7.638449] systemd[1]: Starting Journal Service...1349test # [ 7.667865] systemd[1]: Starting Load Kernel Modules...1350test # [ 7.688166] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1351test # [ 7.704946] systemd[1]: Starting Remount Root and Kernel File Systems...1352test # [ 7.715019] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1353test # [ 7.717508] fuse: init (API version 7.45)1354second # [ 7.735475] systemd[1]: Finished Apply Kernel Variables.1355second # [ 7.741707] systemd[1]: Starting Network Name Resolution...1356second # [ 7.742262] systemd[1]: Finished Load/Save OS Random Seed.1357second # [ 7.742750] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1358second # [ 7.743375] systemd[1]: Reached target First Boot Complete.1359second # [ 7.743881] systemd[1]: Starting Create Static Device Nodes in /dev...1360second # [ 7.752857] systemd[1]: Finished Flush Journal to Persistent Storage.1361test # [ 7.752507] systemd[1]: Starting Coldplug All udev Devices...1362test # [ 7.774067] systemd-journald[324]: Collecting audit messages is enabled.1363test # [ 7.780561] systemd[1]: Listening on Journal Log Access Socket.1364test # [ 7.781060] systemd[1]: Mounted Huge Pages File System.1365test # [ 7.781453] systemd[1]: Mounted POSIX Message Queue File System.1366test # [ 7.781911] systemd[1]: Mounted Kernel Debug File System.1367test # [ 7.782280] systemd[1]: Mounted Kernel Trace File System.1368test # [ 7.782053] systemd[1]: Queued start job for default target Multi-User System.1369test # [ 7.783389] systemd[1]: systemd-journald.service: Deactivated successfully.1370test # [ 7.802979] systemd[1]: Finished Create List of Static Device Nodes.1371test # [ 7.803524] systemd[1]: Started Journal Service.1372test # [ 7.800100] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1373test # [ 7.801751] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1374second # [ 7.826090] systemd-resolved[329]: Positive Trust Anchors:1375second # [ 7.828840] systemd-resolved[329]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1376test # [ 7.806473] systemd[1]: Mounted Kernel Configuration File System.1377test # [ 7.809801] systemd[1]: modprobe@fuse.service: Deactivated successfully.1378second # [ 7.832488] systemd-resolved[329]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161379test # [ 7.813117] systemd[1]: Finished Load Kernel Module fuse.1380test # [ 7.817481] systemd-modules-load[325]: Module 'atkbd' is built in1381second # [ 7.835775] systemd-resolved[329]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1382test # [ 7.822593] systemd-modules-load[325]: Module 'ctr' is built in1383test # [ 7.823988] systemd-modules-load[325]: Module 'loop' is built in1384test # [ 7.828455] systemd[1]: Finished Load Kernel Modules.1385test # [ 7.836132] systemd[1]: Mounting FUSE Control File System...1386test # [ 7.845819] EXT4-fs (vda): re-mounted 649897d3-233a-4e65-a44b-9922f46956f3.1387test # [ 7.844234] systemd[1]: Starting Firewall...1388test # [ 7.847563] systemd[1]: Starting Apply Kernel Variables...1389second # [ 7.873584] systemd[1]: Finished Create Static Device Nodes in /dev.1390second # [ 7.874241] systemd[1]: Reached target Preparation for Local File Systems.1391second # [ 7.877483] systemd[1]: Starting Rule-based Manager for Device Events and Files...1392test # [ 7.856431] systemd-oomd[326]: No swap; memory pressure usage will be degraded1393test # [ 7.875261] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1394test # [ 7.876362] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1395test # [ 7.893740] systemd[1]: Finished Remount Root and Kernel File Systems.1396test # [ 7.911314] systemd[1]: Listening on Disk Image Download Service Socket.1397test # [ 7.922960] systemd[1]: Starting Flush Journal to Persistent Storage...1398test # [ 7.925917] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1399test # [ 7.930932] systemd[1]: Starting Load/Save OS Random Seed...1400test # [ 7.937988] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1401test # [ 7.984101] systemd[1]: Mounted FUSE Control File System.1402test # [ 7.988559] systemd[1]: Finished Apply Kernel Variables.1403second # [ 8.014284] systemd-udevd[344]: Using default interface naming scheme 'v261'.1404test # [ 8.000380] systemd[1]: Starting Network Name Resolution...1405test # [ 8.028296] systemd-journald[324]: Received client request to flush runtime journal.1406second # [ 8.076670] systemd[1]: Mounting /run/wrappers...1407second # [ 8.094739] systemd-resolved[329]: Using system hostname 'second'.1408second # [ 8.107355] systemd[1]: Started Network Name Resolution.1409second # [ 8.127554] systemd[1]: Mounted /run/wrappers.1410second # [ 8.128544] systemd[1]: Reached target Local File Systems.1411second # [ 8.131780] systemd[1]: Listening on Boot Loader Control Service Socket.1412second # [ 8.142766] systemd[1]: Starting register-nix-paths.service...1413second # [ 8.145084] systemd[1]: Starting Create SUID/SGID Wrappers...1414test # [ 8.125166] systemd[1]: Finished Load/Save OS Random Seed.1415second # [ 8.148616] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1416test # [ 8.125791] systemd[1]: Reached target First Boot Complete.1417test # [ 8.126456] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1418test # [ 8.127143] systemd[1]: Starting Create Static Device Nodes in /dev...1419second # [ 8.152390] systemd[1]: Starting Save Transient machine-id to Disk...1420test # [ 8.132064] systemd[1]: Finished Flush Journal to Persistent Storage.1421second # [ 8.182910] systemd[1]: Starting Create System Files and Directories...1422test # [ 8.174727] systemd-resolved[352]: Positive Trust Anchors:1423test # [ 8.176593] systemd-resolved[352]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1424test # [ 8.181134] systemd-resolved[352]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161425test # [ 8.184708] systemd-resolved[352]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1426test # [ 8.214920] systemd[1]: Finished Create Static Device Nodes in /dev.1427test # [ 8.216718] systemd[1]: Reached target Preparation for Local File Systems.1428test # [ 8.217527] systemd[1]: Starting Rule-based Manager for Device Events and Files...1429second # [ 8.263966] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1430second # [ 8.269236] systemd[1]: Finished Save Transient machine-id to Disk.1431test # [ 8.318698] systemd-udevd[366]: Using default interface naming scheme 'v261'.1432second # [ 8.352172] systemd[1]: Finished Create System Files and Directories.1433second # [ 8.360720] systemd[1]: Starting Rebuild Journal Catalog...1434second # [ 8.367178] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1435second # [ 8.456794] systemd[1]: Started Rule-based Manager for Device Events and Files.1436test # [ 8.435825] systemd-resolved[352]: Using system hostname 'test'.1437test # [ 8.444183] systemd[1]: Mounting /run/wrappers...1438test # [ 8.446860] systemd[1]: Started Network Name Resolution.1439second # [ 8.476434] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1440test # [ 8.501981] systemd[1]: Mounted /run/wrappers.1441test # [ 8.503600] systemd[1]: Reached target Local File Systems.1442test # [ 8.511674] systemd[1]: Listening on Boot Loader Control Service Socket.1443test # [ 8.516114] systemd[1]: Starting register-nix-paths.service...1444test # [ 8.519708] systemd[1]: Starting Create SUID/SGID Wrappers...1445test # [ 8.528162] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1446second # [ 8.553047] systemd[1]: Finished Coldplug All udev Devices.1447test # [ 8.530944] systemd[1]: Starting Save Transient machine-id to Disk...1448second # [ 8.561988] systemd[1]: Finished Rebuild Journal Catalog.1449second # [ 8.564910] systemd[1]: Starting Update is Completed...1450test # [ 8.571692] systemd[1]: Starting Create System Files and Directories...1451second # [ 8.622567] systemd[1]: Finished Update is Completed.1452test # [ 8.650284] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1453test # [ 8.656910] systemd[1]: Started Rule-based Manager for Device Events and Files.1454test # [ 8.665127] systemd[1]: Finished Save Transient machine-id to Disk.1455test # [ 8.739874] systemd[1]: Finished Create System Files and Directories.1456test # [ 8.754577] systemd[1]: Starting Rebuild Journal Catalog...1457test # [ 8.760829] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1458second # [ 8.845363] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1459test # [ 8.857644] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1460test # [ 8.923000] systemd[1]: Finished Coldplug All udev Devices.1461test # [ 8.944406] systemd[1]: Finished Rebuild Journal Catalog.1462test # [ 8.951922] systemd[1]: Starting Update is Completed...1463second # [ 9.003341] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1464second # [ 9.005318] systemd[1]: Finished Create SUID/SGID Wrappers.1465test # [ 9.016738] systemd[1]: Finished Update is Completed.1466second # [ 9.070287] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1467second # [ 9.117102] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1468test # [ 9.136132] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1469second # [ 9.386570] systemd[1]: Finished register-nix-paths.service.1470second # [ 9.388564] systemd[1]: Reached target System Initialization.1471second # [ 9.391765] systemd[1]: Started Discard unused filesystem blocks once a week.1472second # [ 9.394271] systemd[1]: Started Daily Cleanup of Temporary Directories.1473second # [ 9.397220] systemd[1]: Reached target Timer Units.1474second # [ 9.399210] systemd[1]: Listening on D-Bus System Message Bus Socket.1475second # [ 9.401142] systemd[1]: Listening on Nix Daemon Socket.1476second # [ 9.405704] systemd[1]: Listening on Authorization Manager Agent Helper.1477second # [ 9.407158] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1478second # [ 9.409248] systemd[1]: Reached target Socket Units.1479second # [ 9.412101] systemd[1]: Starting D-Bus System Message Bus...1480second # [ 9.414186] systemd[1]: Finished Firewall.1481second # [ 9.415549] systemd[1]: Reached target Preparation for Network.1482second # [ 9.417502] systemd[1]: Listening on Network Management Resolve Hook Socket.1483test # [ 9.400516] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1484second # [ 9.427341] (udev-worker)[449]: Network interface NamePolicy= disabled on kernel command line.1485second # [ 9.428593] systemd[1]: Starting Network Management...1486second # [ 9.448738] (udev-worker)[452]: Network interface NamePolicy= disabled on kernel command line.1487test # [ 9.436388] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1488test # [ 9.438854] systemd[1]: Finished Create SUID/SGID Wrappers.1489test # [ 9.462442] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1490second # [ 9.603333] mousedev: PS/2 mouse device common for all mice1491second # [ 9.640442] dbus-broker-launch[522]: Looking up NSS user entry for 'systemd-timesync'...1492second # [ 9.653603] cfg80211: Loading compiled-in X.509 certificates for regulatory database1493second # [ 9.657146] dbus-broker-launch[522]: NSS returned no entry for 'systemd-timesync'1494second # [ 9.657950] dbus-broker-launch[522]: Invalid user-name in /nix/store/7axhn8y0591pw9is8bfakgb1pd10yqm2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1495second # [ 9.692142] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1496second # [ 9.692659] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1497second # [ 9.712889] dbus-broker-launch[522]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/crfnmckggcmz15v4bb16a9l959qi3cvj-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1498second # [ 9.715242] dbus-broker-launch[522]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/crfnmckggcmz15v4bb16a9l959qi3cvj-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1499second # [ 9.719006] dbus-broker-launch[522]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/p5n1rb7z3xyfpp3467ga6qq5sms9ncnw-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1500second # [ 9.722778] dbus-broker-launch[522]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/1k954jnklzygshqiarz7kdmskp0a3k2b-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1501second # [ 9.732437] systemd[1]: Started D-Bus System Message Bus.1502test # [ 9.726752] (udev-worker)[457]: Network interface NamePolicy= disabled on kernel command line.1503test # [ 9.730895] (udev-worker)[462]: Network interface NamePolicy= disabled on kernel command line.1504second # [ 9.755002] systemd-networkd[524]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1505second # [ 9.764060] systemd-networkd[524]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1506second # [ 9.769751] systemd-networkd[524]: lo: Link UP1507second # [ 9.770770] systemd-networkd[524]: lo: Gained carrier1508test # [ 9.755902] systemd[1]: Finished Firewall.1509second # [ 9.780053] systemd-networkd[524]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1510test # [ 9.758348] systemd[1]: Reached target Preparation for Network.1511test # [ 9.760469] systemd[1]: Listening on Network Management Resolve Hook Socket.1512second # [ 9.784542] systemd-networkd[524]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1513second # [ 9.785310] systemd-networkd[524]: eth1: Link UP1514second # [ 9.785839] systemd-networkd[524]: eth1: Gained carrier1515test # [ 9.765567] systemd[1]: Starting Network Management...1516second # [ 9.788245] systemd-networkd[524]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1517test # [ 9.766802] systemd[1]: Finished register-nix-paths.service.1518second # [ 9.794893] dbus-broker-launch[522]: Ready1519test # [ 9.768923] systemd[1]: Reached target System Initialization.1520test # [ 9.772573] systemd[1]: Started Discard unused filesystem blocks once a week.1521test # [ 9.773172] systemd[1]: Started Daily Cleanup of Temporary Directories.1522test # [ 9.773704] systemd[1]: Reached target Timer Units.1523test # [ 9.774116] systemd[1]: Listening on D-Bus System Message Bus Socket.1524second # [ 9.798208] systemd[1]: Started Network Management.1525second # [ 9.799606] systemd[1]: Reached target Basic System.1526test # [ 9.778534] systemd[1]: Listening on Nix Daemon Socket.1527second # [ 9.805381] systemd[1]: Starting Network Manager Script Dispatcher Service...1528second # [ 9.808684] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1529test # [ 9.789693] systemd[1]: Listening on Authorization Manager Agent Helper.1530test # [ 9.791243] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1531test # [ 9.792780] systemd[1]: Reached target Socket Units.1532second # [ 9.818626] systemd[1]: Starting Network Manager...1533test # [ 9.800594] systemd[1]: Starting D-Bus System Message Bus...1534second # [ 9.827723] systemd[1]: Started backdoor.service.1535second # [ 9.864323] systemd[1]: Starting Import lastlog data into lastlog2 database...1536second # [ 9.882664] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1537second # [ 9.918347] systemd[1]: Starting Post-Boot Actions...1538second # [ 9.931380] systemd[1]: Started Reset console on configuration changes.1539second # [ 9.954116] 4vlrjl8344ni0h7hvii7gkdkbwhxr9jy-wifi-secrets[535]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all1540test # [ 9.946935] mousedev: PS/2 mouse device common for all mice1541second # connecting to host...1542second # [ 9.995013] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1543second # [ 9.995793] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1544test # [ 10.001448] cfg80211: Loading compiled-in X.509 certificates for regulatory database1545second # [ 10.029452] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1546test # [ 10.011293] dbus-broker-launch[550]: Looking up NSS user entry for 'systemd-timesync'...1547test # [ 10.023211] dbus-broker-launch[550]: NSS returned no entry for 'systemd-timesync'1548test # [ 10.024839] dbus-broker-launch[550]: Invalid user-name in /nix/store/7axhn8y0591pw9is8bfakgb1pd10yqm2-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1549test # [ 10.039907] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1550test # [ 10.040409] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1551second # [ 10.079384] nsncd[540]: Aug 10 11:06:07.894 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1552second # [ 10.088203] systemd[1]: Started Name Service Cache Daemon (nsncd).1553second # [ 10.099175] systemd[1]: Reached target Host and Network Name Lookups.1554second # [ 10.103753] systemd[1]: Reached target User and Group Name Lookups.1555test # [ 10.080679] dbus-broker-launch[550]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/crfnmckggcmz15v4bb16a9l959qi3cvj-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1556test # [ 10.083288] dbus-broker-launch[550]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/crfnmckggcmz15v4bb16a9l959qi3cvj-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1557test # [ 10.088843] dbus-broker-launch[550]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/p5n1rb7z3xyfpp3467ga6qq5sms9ncnw-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1558second # [ 10.113417] systemd[1]: Starting User Login Management...1559second # [ 10.116873] systemd[1]: Finished Post-Boot Actions.1560test # [ 10.093373] dbus-broker-launch[550]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/1k954jnklzygshqiarz7kdmskp0a3k2b-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1561test # [ 10.102294] systemd[1]: Started D-Bus System Message Bus.1562second # [ 10.127794] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1563test # [ 10.106389] systemd-networkd[547]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1564test # [ 10.112303] systemd-networkd[547]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1565test # [ 10.116758] systemd-networkd[547]: lo: Link UP1566second # [ 10.141817] systemd[1]: Finished Import lastlog data into lastlog2 database.1567test # [ 10.121283] systemd-networkd[547]: lo: Gained carrier1568test # [ 10.123801] systemd-networkd[547]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1569test # [ 10.129743] systemd-networkd[547]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1570test # [ 10.136617] systemd-networkd[547]: eth1: Link UP1571test # [ 10.137044] systemd-networkd[547]: eth1: Gained carrier1572test # [ 10.137487] systemd-networkd[547]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1573second # [ 10.162706] systemd[1]: Started Network Manager Script Dispatcher Service.1574test # [ 10.160760] dbus-broker-launch[550]: Ready1575test # [ 10.163883] systemd[1]: Started Network Management.1576test # [ 10.166650] systemd[1]: Reached target Basic System.1577test # [ 10.170069] systemd[1]: Starting Network Manager Script Dispatcher Service...1578test # [ 10.175430] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1579test # [ 10.192925] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1580test # [ 10.208866] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1581test # [ 10.216502] systemd[1]: Starting Network Manager...1582test # [ 10.230689] systemd[1]: Started backdoor.service.1583second # [ 10.258615] systemd[1]: Starting Hostname Service...1584second # [ 10.271606] systemd-logind[568]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1585second # [ 10.273446] systemd-logind[568]: Watching system buttons on /dev/input/event0 (gpio-keys)1586second # [ 10.274079] systemd-logind[568]: New seat seat0.1587second # [ 10.278193] systemd[1]: Started User Login Management.1588second # [ 10.284139] systemd[1]: Starting linger-users.service...1589test # [ 10.270364] systemd[1]: Starting Import lastlog data into lastlog2 database...1590test # [ 10.297068] 32qylaax3kls3nx596h4s8bnp5qfv0gm-wifi-secrets[559]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-one1591test # [ 10.304374] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1592test # [ 10.312790] systemd[1]: Starting Post-Boot Actions...1593test # [ 10.317963] 4vlrjl8344ni0h7hvii7gkdkbwhxr9jy-wifi-secrets[558]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all1594second # [ 10.354478] systemd[1]: linger-users.service: Deactivated successfully.1595second # [ 10.356057] systemd[1]: Finished linger-users.service.1596second # [ 10.390655] systemd[1]: Started Hostname Service.1597test # [ 10.368572] systemd[1]: Started Reset console on configuration changes.1598test # [ 10.387637] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1599test # [ 10.396432] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1600test # [ 10.402939] wmfhm26m42mhbw78y742kv6m7qq9fgxz-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-open1601test # [ 10.423813] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1602test # [ 10.447359] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1603test # [ 10.454344] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1604test # connecting to host...1605test # [ 10.460455] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1606second # [ 10.489798] systemd-networkd[524]: eth0: Link UP1607second # [ 10.490271] systemd-networkd[524]: eth0: Gained carrier1608test # [ 10.470507] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1609test # [ 10.477420] systemd[1]: Finished Post-Boot Actions.1610second # [ 10.509281] systemd[1]: Started Network Manager.1611second # [ 10.511042] systemd[1]: Reached target Network.1612second # [ 10.515989] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1613second # [ 10.522367] systemd[1]: Starting Permit User Sessions...1614test: Guest shell says: b'Spawning backdoor root shell...\n'1615test # [ 10.519883] systemd[1]: Started Name Service Cache Daemon (nsncd).1616test # [ 10.523533] nsncd[569]: Aug 10 11:06:08.326 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1617test # [ 10.550030] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1618test # [ 10.555544] systemd[1]: Reached target Host and Network Name Lookups.1619test # [ 10.559200] systemd[1]: Reached target User and Group Name Lookups.1620test # [ 10.570269] systemd[1]: Starting User Login Management...1621test: connected to guest root shell1622test # [ 10.575580] systemd[1]: Started Network Manager Script Dispatcher Service.1623test: (connecting took 10.83 seconds)1624test: (finished: waiting for the VM to finish booting, in 10.83 seconds)1625test # [ 10.609812] systemd[1]: Finished Import lastlog data into lastlog2 database.1626second # [ 10.676324] systemd[1]: Finished Permit User Sessions.1627second # [ 10.687570] systemd[1]: Started Getty on tty1.1628second # [ 10.690677] systemd[1]: Reached target Login Prompts.1629test # [ 10.721964] systemd-logind[607]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1630second # [ 10.748500] systemd-resolved[329]: eth0: Bus client set default route setting: yes1631test # [ 10.726303] systemd-logind[607]: Watching system buttons on /dev/input/event0 (gpio-keys)1632second # [ 10.752834] systemd-resolved[329]: eth0: Bus client set DNS server list to: 10.0.2.31633test # [ 10.732837] systemd[1]: Starting Hostname Service...1634test # [ 10.733288] systemd-logind[607]: New seat seat0.1635test # [ 10.733689] systemd[1]: Started User Login Management.1636test # [ 10.740292] systemd[1]: Starting linger-users.service...1637second # [ 10.797943] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1638second # [ 10.800931] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1639test # [ 10.790589] systemd[1]: linger-users.service: Deactivated successfully.1640test # [ 10.797989] systemd[1]: Finished linger-users.service.1641test # [ 10.846058] systemd[1]: Started Hostname Service.1642test # [ 10.938448] systemd-networkd[547]: eth0: Link UP1643test # [ 10.938916] systemd-networkd[547]: eth0: Gained carrier1644second # [ 10.968613] systemd[1]: Reached target Multi-User System.1645second # [ 10.970216] systemd[1]: Startup finished in 728ms (kernel) + 4.419s (initrd) + 5.822s (userspace) = 10.970s.1646test # [ 10.957816] systemd[1]: Started Network Manager.1647test # [ 10.959455] systemd[1]: Reached target Network.1648test # [ 10.964538] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1649test # [ 10.969537] systemd[1]: Starting Permit User Sessions...1650second # [ 11.136721] systemd-networkd[524]: eth1: Gained IPv6LL1651test # [ 11.120065] systemd[1]: Finished Permit User Sessions.1652test # [ 11.130457] systemd[1]: Started Getty on tty1.1653test # [ 11.132938] systemd[1]: Reached target Login Prompts.1654test # [ 11.137571] systemd-networkd[547]: eth1: Gained IPv6LL1655second # [ 11.175829] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31656test # [ 11.159419] systemd-resolved[352]: eth0: Bus client set default route setting: yes1657test # [ 11.164914] systemd-resolved[352]: eth0: Bus client set DNS server list to: 10.0.2.31658test # [ 11.247244] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1659test # [ 11.249432] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1660second # [ 11.408211] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1661test # [ 11.404397] systemd[1]: Reached target Multi-User System.1662test # [ 11.406049] systemd[1]: Startup finished in 741ms (kernel) + 4.588s (initrd) + 6.076s (userspace) = 11.405s.1663second # [ 11.437387] systemd[1]: Starting Virtual Console Setup...1664second # [ 11.470119] systemd-logind[568]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1665test # [ 11.617772] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31666test: (finished: waiting for unit NetworkManager.service, in 12.04 seconds)1667test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1668test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1669test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets-wg-test-open1670test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets-wg-test-open, in 0.04 seconds)1671test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1672second # [ 11.884495] systemd-vconsole-setup[635]: Configuration of first virtual console was skipped, ignoring remaining ones.1673second # [ 11.887084] systemd[1]: Finished Virtual Console Setup.1674test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1675(finished: run the VM test script, in 12.61 seconds)1676test # [ 11.931437] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1677test script finished in 12.67s1678cleanup1679kill QemuMachine (pid 47)1680second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/41m77i1296n33p6liin8ynr6wh3h6b7m-python3-3.14.6/bin/python3.14)1681test # [ 11.960585] systemd[1]: Starting Virtual Console Setup...1682test # [ 11.974315] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1683test # [ 11.974992] systemd[1]: Stopped Virtual Console Setup.1684test # [ 11.980204] systemd[1]: Starting Virtual Console Setup...1685test # [ 11.990584] systemd-logind[607]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1686kill QemuMachine (pid 48)1687test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/41m77i1296n33p6liin8ynr6wh3h6b7m-python3-3.14.6/bin/python3.14)1688(finished: cleanup, in 0.24 seconds)