vm-test-run-wifi
checks.aarch64-linux.wifi
· build #635
· 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 vm13second # Disk image does not exist, creating the virtualisation disk image...14second # Formatting '/build/vm-state-second/tmp.yKSjIs1GNT', fmt=raw size=107374182415second # mke2fs 1.47.4 (6-Mar-2025)16test # Disk image does not exist, creating the virtualisation disk image...17second: QEMU running (pid 14)18test: QEMU running (pid 15)19second # Discarding device blocks: 0/262144 done20test # Formatting '/build/vm-state-test/tmp.1MwdN2B78I', fmt=raw size=107374182421second # Creating filesystem with 262144 4k blocks and 65536 inodes22second # Filesystem UUID: bf83a622-d6f0-40c3-a452-0a7bb33878d123test # mke2fs 1.47.4 (6-Mar-2025)24second # Superblock backups stored on blocks:25test # Discarding device blocks: 0/262144 done26second # 32768, 98304, 163840, 22937627test # Creating filesystem with 262144 4k blocks and 65536 inodes28second # 29(finished: start all VMs, in 0.49 seconds)30second # Allocating group tables: 0/8 done31test: waiting for unit NetworkManager.service32second # Writing inode tables: 0/8 done33second # Creating journal (8192 blocks): done34test # Filesystem UUID: d865bef7-6356-4b99-b42e-4435ea11da7235test: waiting for the VM to finish booting36test # Superblock backups stored on blocks:37second # Writing superblocks and filesystem accounting information: 0/8 done38test # 32768, 98304, 163840, 22937639second # 40test # 41second # Virtualisation disk image created.42test # Allocating group tables: 0/8 done43test # Writing inode tables: 0/8 done44test # Creating journal (8192 blocks): done45test # Writing superblocks and filesystem accounting information: 0/8 done46test # 47test # Virtualisation disk image created.48second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49second # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 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 s186328 r8192 d116776 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/kmvhghjqsn16g72ggn63vanqz3z5whnf-nixos-system-second-test/init regInfo=/nix/store/50ha0j65c3c04pff3szqci7v1r6a7y1r-closure-info/registration console=ttyAMA0,115200n8 console=tty085second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/50ha0j65c3c04pff3szqci7v1r6a7y1r-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 74755 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.102second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.103second # [ 0.000000] Trampoline variant of Tasks RCU enabled.104second # [ 0.000000] Rude variant of Tasks RCU enabled.105second # [ 0.000000] Tracing variant of Tasks RCU enabled.106second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.107second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1108second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.109second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.110second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.111second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0112second # [ 0.000000] GICv3: 256 SPIs implemented113second # [ 0.000000] GICv3: 0 Extended SPIs implemented114second # [ 0.000000] Root IRQ handler: gic_handle_irq115second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI116second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0117second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000118second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]119second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)120second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)121second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000122second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000123second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.124second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns125second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040126second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).127second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns128second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns129second # [ 0.000068] arm-pv: using stolen time PV130test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]131test # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026132test # [ 0.000000] KASLR enabled133test # [ 0.000000] random: crng init done134test # [ 0.000000] Machine model: linux,dummy-virt135second # [ 0.000463] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)136test # [ 0.000000] efi: UEFI not found.137second # [ 0.000764] Console: colour dummy device 80x25138second # [ 0.000790] printk: legacy console [tty0] enabled139test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT140test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]141second # [ 0.001003] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)142test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]143second # [ 0.001008] pid_max: default: 32768 minimum: 301144test # [ 0.000000] Zone ranges:145second # [ 0.001087] LSM: initializing lsm=capability,landlock,yama,bpf,ima146test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]147second # [ 0.001221] landlock: Up and running.148test # [ 0.000000] DMA32 empty149second # [ 0.001223] Yama: becoming mindful.150second # [ 0.001660] LSM support for eBPF active151test # [ 0.000000] Normal empty152test # [ 0.000000] Device empty153test # [ 0.000000] Movable zone start for each node154second # [ 0.001834] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)155test # [ 0.000000] Early memory node ranges156test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]157second # [ 0.001866] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)158test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]159second # [ 0.003725] cacheinfo: Unable to detect cache hierarchy for CPU 0160second # [ 0.004543] rcu: Hierarchical SRCU implementation.161test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000162second # [ 0.004548] rcu: Max phase no-delay instances is 1000.163test # [ 0.000000] psci: probing for conduit method from DT.164second # [ 0.005495] fsl-mc MSI: its@8080000 domain created165test # [ 0.000000] psci: PSCIv1.3 detected in firmware.166second # [ 0.005653] EFI services will not be available.167second # [ 0.005782] smp: Bringing up secondary CPUs ...168test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs169test # [ 0.000000] psci: Trusted OS migration not required170test # [ 0.000000] psci: SMC Calling Convention v1.1171second # [ 0.005811] smp: Brought up 1 node, 1 CPU172second # [ 0.005814] SMP: Total of 1 processors activated.173second # [ 0.005816] CPU: All CPU(s) started at EL1174second # [ 0.005829] CPU features: detected: 32-bit EL0 Support175second # [ 0.005832] CPU features: detected: Data cache clean to the PoU not required for I/D coherence176second # [ 0.005835] CPU features: detected: Common not Private translations177second # [ 0.005837] CPU features: detected: CRC32 instructions178test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)179test # [ 0.000000] percpu: Embedded 76 pages/cpu s186328 r8192 d116776 u311296180test # [ 0.000000] Detected PIPT I-cache on CPU0181test # [ 0.000000] CPU features: detected: GICv3 CPU interface182test # [ 0.000000] CPU features: detected: Spectre-v4183test # [ 0.000000] CPU features: detected: Spectre-BHB184test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR185second # [ 0.005852] CPU features: detected: Data cache clean to Point of Persistence186test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)187second # [ 0.005855] CPU features: detected: Enhanced Virtualization Traps188second # [ 0.005868] CPU features: detected: RCpc load-acquire (LDAPR)189second # [ 0.005870] CPU features: detected: LSE atomic instructions190test # [ 0.000000] CPU features: detected: ARM erratum 1418040191test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion192second # [ 0.005872] CPU features: detected: Privileged Access Never193test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing194test # [ 0.000000] alternatives: applying boot alternatives195second # [ 0.005874] CPU features: detected: PMUv3196second # [ 0.005876] CPU features: detected: RAS Extension Support197second # [ 0.005880] CPU features: detected: Speculative Store Bypassing Safe (SSBS)198second # [ 0.005902] alternatives: applying system-wide alternatives199second # [ 0.007380] CPU features: detected: Hardware dirty bit management on CPU0200test # [ 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/vwbd99spgcc2gncrv0sjs6fkf8zrj0c6-nixos-system-test-test/init regInfo=/nix/store/w1fmgwqsvd89kk53crdna6jqjl55kk6y-closure-info/registration console=ttyAMA0,115200n8 console=tty0201second # [ 0.007573] Memory: 893844K/1048576K available (24320K kernel code, 7086K rwdata, 26340K rodata, 4736K init, 1103K bss, 113416K reserved, 32768K cma-reserved)202second # [ 0.008066] devtmpfs: initialized203test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/w1fmgwqsvd89kk53crdna6jqjl55kk6y-closure-info/registration", will be passed to user space.204test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes205second # [ 0.009660] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)206test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)207second # [ 0.009683] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).208second # [ 0.009815] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL209test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)210test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB211test # [ 0.000000] software IO TLB: area num 1.212test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)213test # [ 0.000000] Fallback order for Node 0: 0214test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144215second # [ 0.009818] 0 pages in range for non-PLT usage216second # [ 0.009819] 508336 pages in range for PLT usage217second # [ 0.009972] pinctrl core: initialized pinctrl subsystem218second # [ 0.010825] DMI not present or invalid.219second # [ 0.014441] NET: Registered PF_NETLINK/PF_ROUTE protocol family220second # [ 0.017119] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations221test # [ 0.000000] Policy zone: DMA222second # [ 0.017277] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations223second # [ 0.017450] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations224second # [ 0.017475] audit: initializing netlink subsys (disabled)225test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off226test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1227test # [ 0.000000] allocated 2097152 bytes of page_ext228second # [ 0.018151] thermal_sys: Registered thermal governor 'fair_share'229second # [ 0.018153] thermal_sys: Registered thermal governor 'bang_bang'230test # [ 0.000000] ftrace: allocating 74755 entries in 294 pages231test # [ 0.000000] ftrace: allocated 294 pages with 4 groups232test # [ 0.000000] rcu: Hierarchical RCU implementation.233test # [ 0.000000] rcu: RCU event tracing is enabled.234second # [ 0.018157] thermal_sys: Registered thermal governor 'step_wise'235second # [ 0.018159] thermal_sys: Registered thermal governor 'user_space'236second # [ 0.018161] thermal_sys: Registered thermal governor 'power_allocator'237test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.238test # [ 0.000000] Trampoline variant of Tasks RCU enabled.239second # [ 0.018193] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1240test # [ 0.000000] Rude variant of Tasks RCU enabled.241test # [ 0.000000] Tracing variant of Tasks RCU enabled.242second # [ 0.018208] cpuidle: using governor ladder243second # [ 0.018213] cpuidle: using governor menu244second # [ 0.018356] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.245test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.246test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1247second # [ 0.018380] ASID allocator initialised with 32768 entries248second # [ 0.019106] Serial: AMBA PL011 UART driver249test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.250second # [ 0.022329] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1251test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.252second # [ 0.022528] printk: console [ttyAMA0] enabled253test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.254test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0255test # [ 0.000000] GICv3: 256 SPIs implemented256test # [ 0.000000] GICv3: 0 Extended SPIs implemented257test # [ 0.000000] Root IRQ handler: gic_handle_irq258test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI259test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0260test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000261test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]262test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)263test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)264test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000265test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000266test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.267test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns268test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040269test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).270test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns271test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns272second # [ 0.097436] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages273test # [ 0.000060] arm-pv: using stolen time PV274second # [ 0.097462] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page275test # [ 0.000427] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)276second # [ 0.097469] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages277second # [ 0.097473] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page278second # [ 0.097476] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages279test # [ 0.000713] Console: colour dummy device 80x25280test # [ 0.000730] printk: legacy console [tty0] enabled281test # [ 0.000930] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)282second # [ 0.097479] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page283test # [ 0.000936] pid_max: default: 32768 minimum: 301284second # [ 0.097482] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages285second # [ 0.097486] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page286test # [ 0.001004] LSM: initializing lsm=capability,landlock,yama,bpf,ima287test # [ 0.001139] landlock: Up and running.288test # [ 0.001141] Yama: becoming mindful.289test # [ 0.001590] LSM support for eBPF active290test # [ 0.001736] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)291test # [ 0.001755] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)292test # [ 0.003486] cacheinfo: Unable to detect cache hierarchy for CPU 0293test # [ 0.004332] rcu: Hierarchical SRCU implementation.294test # [ 0.004337] rcu: Max phase no-delay instances is 1000.295second # [ 0.102755] fbcon: Taking over console296second # [ 0.102779] ACPI: Interpreter disabled.297second # [ 0.104037] iommu: Default domain type: Translated298second # [ 0.104050] iommu: DMA domain TLB invalidation policy: strict mode299second # [ 0.105184] SCSI subsystem initialized300test # [ 0.005256] fsl-mc MSI: its@8080000 domain created301test # [ 0.005417] EFI services will not be available.302test # [ 0.005507] smp: Bringing up secondary CPUs ...303test # [ 0.005533] smp: Brought up 1 node, 1 CPU304test # [ 0.005536] SMP: Total of 1 processors activated.305test # [ 0.005538] CPU: All CPU(s) started at EL1306second # [ 0.105809] usbcore: registered new interface driver usbfs307second # [ 0.105851] usbcore: registered new interface driver hub308second # [ 0.105862] usbcore: registered new device driver usb309second # [ 0.106079] pps_core: LinuxPPS API ver. 1 registered310second # [ 0.106085] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>311test # [ 0.005550] CPU features: detected: 32-bit EL0 Support312second # [ 0.106092] PTP clock support registered313test # [ 0.005554] CPU features: detected: Data cache clean to the PoU not required for I/D coherence314test # [ 0.005556] CPU features: detected: Common not Private translations315test # [ 0.005559] CPU features: detected: CRC32 instructions316test # [ 0.005561] CPU features: detected: Data cache clean to Point of Persistence317second # [ 0.106126] EDAC MC: Ver: 3.0.0318test # [ 0.005564] CPU features: detected: Enhanced Virtualization Traps319test # [ 0.005573] CPU features: detected: RCpc load-acquire (LDAPR)320test # [ 0.005575] CPU features: detected: LSE atomic instructions321test # [ 0.005577] CPU features: detected: Privileged Access Never322test # [ 0.005579] CPU features: detected: PMUv3323test # [ 0.005581] CPU features: detected: RAS Extension Support324test # [ 0.005585] CPU features: detected: Speculative Store Bypassing Safe (SSBS)325test # [ 0.005606] alternatives: applying system-wide alternatives326test # [ 0.007002] CPU features: detected: Hardware dirty bit management on CPU0327test # [ 0.007232] Memory: 893836K/1048576K available (24320K kernel code, 7086K rwdata, 26340K rodata, 4736K init, 1103K bss, 113404K reserved, 32768K cma-reserved)328test # [ 0.007729] devtmpfs: initialized329second # [ 0.113453] scmi_core: SCMI protocol bus registered330test # [ 0.009187] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)331second # [ 0.114283] FPGA manager framework332second # [ 0.115335] vgaarb: loaded333test # [ 0.009209] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).334second # [ 0.115825] clocksource: Switched to clocksource arch_sys_counter335test # [ 0.009351] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL336test # [ 0.009354] 0 pages in range for non-PLT usage337test # [ 0.009355] 508336 pages in range for PLT usage338test # [ 0.009466] pinctrl core: initialized pinctrl subsystem339test # [ 0.010227] DMI not present or invalid.340test # [ 0.013642] NET: Registered PF_NETLINK/PF_ROUTE protocol family341test # [ 0.016359] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations342test # [ 0.016522] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations343test # [ 0.016694] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations344test # [ 0.016717] audit: initializing netlink subsys (disabled)345test # [ 0.017321] thermal_sys: Registered thermal governor 'fair_share'346test # [ 0.017323] thermal_sys: Registered thermal governor 'bang_bang'347test # [ 0.017327] thermal_sys: Registered thermal governor 'step_wise'348test # [ 0.017328] thermal_sys: Registered thermal governor 'user_space'349test # [ 0.017330] thermal_sys: Registered thermal governor 'power_allocator'350test # [ 0.017359] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1351test # [ 0.017373] cpuidle: using governor ladder352test # [ 0.017378] cpuidle: using governor menu353test # [ 0.017508] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.354test # [ 0.017529] ASID allocator initialised with 32768 entries355test # [ 0.018228] Serial: AMBA PL011 UART driver356test # [ 0.021502] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1357second # [ 0.124416] VFS: Disk quotas dquot_6.6.0358second # [ 0.124463] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)359test # [ 0.021702] printk: console [ttyAMA0] enabled360second # [ 0.126960] netfs: FS-Cache loaded361second # [ 0.127102] pnp: PnP ACPI: disabled362second # [ 0.129619] NET: Registered PF_INET protocol family363second # [ 0.129827] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)364test # [ 0.094449] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages365test # [ 0.094474] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page366test # [ 0.094481] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages367test # [ 0.094485] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page368test # [ 0.094488] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages369test # [ 0.094492] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page370test # [ 0.094495] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages371test # [ 0.094498] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page372test # [ 0.099602] fbcon: Taking over console373test # [ 0.099628] ACPI: Interpreter disabled.374test # [ 0.100952] iommu: Default domain type: Translated375test # [ 0.100965] iommu: DMA domain TLB invalidation policy: strict mode376test # [ 0.102115] SCSI subsystem initialized377test # [ 0.106794] usbcore: registered new interface driver usbfs378test # [ 0.106832] usbcore: registered new interface driver hub379test # [ 0.106844] usbcore: registered new device driver usb380test # [ 0.107091] pps_core: LinuxPPS API ver. 1 registered381test # [ 0.107098] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>382test # [ 0.107105] PTP clock support registered383test # [ 0.107137] EDAC MC: Ver: 3.0.0384test # [ 0.110198] scmi_core: SCMI protocol bus registered385test # [ 0.111084] FPGA manager framework386test # [ 0.112159] vgaarb: loaded387test # [ 0.112639] clocksource: Switched to clocksource arch_sys_counter388test # [ 0.122188] VFS: Disk quotas dquot_6.6.0389test # [ 0.122237] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390test # [ 0.124766] netfs: FS-Cache loaded391test # [ 0.124918] pnp: PnP ACPI: disabled392second # [ 0.155183] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)393second # [ 0.155218] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)394second # [ 0.155233] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)395second # [ 0.155271] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)396second # [ 0.155339] TCP: Hash tables configured (established 8192 bind 8192)397test # [ 0.127438] NET: Registered PF_INET protocol family398second # [ 0.155449] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)399second # [ 0.155477] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)400test # [ 0.127656] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)401second # [ 0.155536] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)402second # [ 0.155699] NET: Registered PF_UNIX/PF_LOCAL protocol family403second # [ 0.155732] NET: Registered PF_XDP protocol family404second # [ 0.155754] PCI: CLS 0 bytes, default 64405second # [ 0.155937] Trying to unpack rootfs image as initramfs...406second # [ 0.170174] kvm [1]: HYP mode not available407test # [ 0.152453] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)408test # [ 0.152490] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)409test # [ 0.152504] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)410test # [ 0.152544] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)411test # [ 0.152611] TCP: Hash tables configured (established 8192 bind 8192)412test # [ 0.155699] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)413test # [ 0.155751] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.155777] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)415test # [ 0.155931] NET: Registered PF_UNIX/PF_LOCAL protocol family416test # [ 0.155995] NET: Registered PF_XDP protocol family417test # [ 0.156018] PCI: CLS 0 bytes, default 64418test # [ 0.156236] Trying to unpack rootfs image as initramfs...419test # [ 0.167832] kvm [1]: HYP mode not available420second # [ 0.244251] Initialise system trusted keyrings421second # [ 0.244780] workingset: timestamp_bits=42 max_order=18 bucket_order=0422second # [ 0.245821] squashfs: version 4.0 (2009/01/31) Phillip Lougher423second # [ 0.246370] 9p: Installing v9fs 9p2000 file system support424second # [ 0.265797] Key type asymmetric registered425second # [ 0.265829] Asymmetric key parser 'x509' registered426second # [ 0.265914] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)427second # [ 0.271959] io scheduler mq-deadline registered428second # [ 0.271984] io scheduler kyber registered429test # [ 0.237070] Initialise system trusted keyrings430second # [ 0.275092] pl061_gpio 9030000.pl061: PL061 GPIO chip registered431test # [ 0.237604] workingset: timestamp_bits=42 max_order=18 bucket_order=0432test # [ 0.238564] squashfs: version 4.0 (2009/01/31) Phillip Lougher433test # [ 0.239102] 9p: Installing v9fs 9p2000 file system support434second # [ 0.275924] ledtrig-cpu: registered to indicate activity on CPUs435second # [ 0.276282] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:436second # [ 0.276306] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000437second # [ 0.276321] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000438second # [ 0.276327] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000439second # [ 0.276361] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits440second # [ 0.276387] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]441second # [ 0.276471] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00442second # [ 0.276490] pci_bus 0000:00: root bus resource [bus 00-ff]443second # [ 0.276495] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]444second # [ 0.276499] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]445second # [ 0.276503] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]446second # [ 0.276578] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint447second # [ 0.277041] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint448second # [ 0.277159] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]449second # [ 0.277169] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]450second # [ 0.277190] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]451second # [ 0.277202] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]452second # [ 0.277488] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint453second # [ 0.277601] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]454second # [ 0.277612] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]455second # [ 0.277632] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]456second # [ 0.277964] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint457second # [ 0.278078] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]458second # [ 0.278088] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]459second # [ 0.278109] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]460second # [ 0.278387] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint461second # [ 0.278500] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]462second # [ 0.278511] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]463second # [ 0.278531] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]464second # [ 0.278815] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint465second # [ 0.278926] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]466second # [ 0.278937] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]467second # [ 0.278957] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]468second # [ 0.279234] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint469second # [ 0.279346] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]470second # [ 0.279357] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]471second # [ 0.279377] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]472second # [ 0.279663] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint473test # [ 0.262109] Key type asymmetric registered474second # [ 0.279776] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]475test # [ 0.262143] Asymmetric key parser 'x509' registered476second # [ 0.279787] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]477test # [ 0.262210] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)478second # [ 0.279810] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]479test # [ 0.263597] io scheduler mq-deadline registered480second # [ 0.279824] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]481test # [ 0.263612] io scheduler kyber registered482second # [ 0.308270] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint483second # [ 0.308401] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]484second # [ 0.308421] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]485second # [ 0.308704] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint486second # [ 0.308818] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]487second # [ 0.308838] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]488second # [ 0.309094] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint489second # [ 0.309205] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]490second # [ 0.309417] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint491second # [ 0.309580] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]492second # [ 0.309591] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]493test # [ 0.272888] pl061_gpio 9030000.pl061: PL061 GPIO chip registered494second # [ 0.309664] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]495test # [ 0.273279] ledtrig-cpu: registered to indicate activity on CPUs496test # [ 0.273580] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:497second # [ 0.309973] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint498second # [ 0.310089] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]499test # [ 0.273602] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000500second # [ 0.310100] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]501test # [ 0.273618] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000502second # [ 0.310120] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]503test # [ 0.273642] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000504second # [ 0.310554] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned505second # [ 0.310566] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned506test # [ 0.273675] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits507second # [ 0.310571] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned508test # [ 0.273703] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]509second # [ 0.310606] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned510test # [ 0.273782] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00511test # [ 0.273806] pci_bus 0000:00: root bus resource [bus 00-ff]512second # [ 0.310637] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned513test # [ 0.273811] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]514second # [ 0.310669] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned515test # [ 0.273815] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]516second # [ 0.310701] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned517test # [ 0.273819] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]518second # [ 0.310731] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned519test # [ 0.273916] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint520second # [ 0.310764] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned521test # [ 0.274359] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint522second # [ 0.310796] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned523test # [ 0.274481] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]524test # [ 0.274493] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]525second # [ 0.310829] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned526test # [ 0.274513] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]527second # [ 0.310860] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned528test # [ 0.274525] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]529second # [ 0.310953] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned530test # [ 0.274803] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint531second # [ 0.311002] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned532test # [ 0.274917] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]533second # [ 0.311017] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned534test # [ 0.274928] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]535second # [ 0.311032] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned536test # [ 0.274948] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]537second # [ 0.311047] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned538test # [ 0.275238] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint539second # [ 0.311062] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned540test # [ 0.275351] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]541second # [ 0.311078] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned542test # [ 0.275362] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]543test # [ 0.275382] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]544second # [ 0.311094] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned545second # [ 0.311109] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned546test # [ 0.275661] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint547test # [ 0.275787] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]548second # [ 0.311125] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned549test # [ 0.275799] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]550second # [ 0.311142] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned551test # [ 0.275819] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]552second # [ 0.311159] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned553second # [ 0.311175] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned554test # [ 0.276150] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint555test # [ 0.276264] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]556second # [ 0.311192] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned557test # [ 0.276275] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]558second # [ 0.311207] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned559test # [ 0.276295] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560second # [ 0.311223] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned561second # [ 0.311239] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned562test # [ 0.276576] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint563second # [ 0.311260] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned564test # [ 0.276716] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]565second # [ 0.311276] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned566test # [ 0.276727] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]567second # [ 0.311291] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned568test # [ 0.276748] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]569second # [ 0.311307] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned570test # [ 0.277032] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint571second # [ 0.311323] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned572test # [ 0.277146] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]573second # [ 0.311343] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]574test # [ 0.277157] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]575second # [ 0.311349] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]576test # [ 0.277180] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]577second # [ 0.311353] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]578test # [ 0.277192] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]579second # [ 0.312069] pci 0000:00:0a.0: enabling device (0000 -> 0002)580test # [ 0.277489] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint581test # [ 0.277607] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]582test # [ 0.277626] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]583test # [ 0.277928] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint584test # [ 0.278046] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]585test # [ 0.278065] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]586test # [ 0.278318] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint587test # [ 0.278430] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]588test # [ 0.278599] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint589test # [ 0.278791] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]590test # [ 0.278805] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]591test # [ 0.278825] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]592test # [ 0.279120] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint593test # [ 0.279236] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]594test # [ 0.279247] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]595test # [ 0.279267] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]596test # [ 0.279808] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned597test # [ 0.279820] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned598test # [ 0.279826] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned599test # [ 0.279862] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned600test # [ 0.279893] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned601test # [ 0.279924] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned602second # [ 0.353049] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)603second # [ 0.355144] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)604test # [ 0.279954] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned605test # [ 0.279984] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned606test # [ 0.280017] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned607test # [ 0.280048] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned608test # [ 0.280080] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned609test # [ 0.280112] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned610test # [ 0.280190] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned611test # [ 0.280221] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned612test # [ 0.280235] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned613test # [ 0.280250] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned614test # [ 0.280266] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned615test # [ 0.280281] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned616test # [ 0.280297] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned617test # [ 0.280313] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned618test # [ 0.280329] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned619test # [ 0.280345] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned620test # [ 0.280361] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned621test # [ 0.280377] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned622test # [ 0.280392] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned623test # [ 0.280408] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned624test # [ 0.280424] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned625test # [ 0.280439] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned626test # [ 0.280454] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned627test # [ 0.280476] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned628test # [ 0.280492] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned629test # [ 0.280508] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned630test # [ 0.280523] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned631test # [ 0.280538] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned632second # [ 0.365129] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)633test # [ 0.280558] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]634second # [ 0.366933] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)635test # [ 0.280565] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]636test # [ 0.280569] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]637test # [ 0.337353] pci 0000:00:0a.0: enabling device (0000 -> 0002)638second # [ 0.376973] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)639second # [ 0.378778] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)640test # [ 0.344147] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)641second # [ 0.384906] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)642test # [ 0.354030] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)643test # [ 0.355915] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)644second # [ 0.392027] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)645second # [ 0.393901] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)646second # [ 0.399991] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)647second # [ 0.402227] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)648test # [ 0.365983] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)649test # [ 0.367717] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)650test # [ 0.370876] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)651second # [ 0.416691] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled652test # [ 0.376848] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)653test # [ 0.379101] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)654second # [ 0.418501] msm_serial: driver initialized655second # [ 0.418601] SuperH (H)SCI(F) driver initialized656second # [ 0.418636] STM32 USART driver initialized657test # [ 0.392883] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)658test # [ 0.395031] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)659test # [ 0.397318] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)660second # [ 0.444904] loop: module loaded661second # [ 0.445077] virtio_blk virtio5: 1/0/0 default/read/poll queues662second # [ 0.445769] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)663test # [ 0.409532] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled664test # [ 0.411158] msm_serial: driver initialized665test # [ 0.411307] SuperH (H)SCI(F) driver initialized666test # [ 0.411345] STM32 USART driver initialized667second # [ 0.452312] megasas: 07.734.00.00-rc1668second # [ 0.452865] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]669second # [ 0.455482] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000670second # [ 0.455503] Intel/Sharp Extended Query Table at 0x0031671second # [ 0.465770] Using buffer write method672second # [ 0.465865] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]673second # [ 0.467808] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000674second # [ 0.469666] Intel/Sharp Extended Query Table at 0x0031675second # [ 0.471721] Using buffer write method676second # [ 0.471761] Concatenating MTD devices:677second # [ 0.471766] (0): "0.flash"678second # [ 0.471769] (1): "0.flash"679second # [ 0.471772] into device "0.flash"680test # [ 0.434765] loop: module loaded681test # [ 0.434910] virtio_blk virtio5: 1/0/0 default/read/poll queues682test # [ 0.435604] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)683test # [ 0.441081] megasas: 07.734.00.00-rc1684test # [ 0.441573] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]685test # [ 0.458009] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000686test # [ 0.458047] Intel/Sharp Extended Query Table at 0x0031687test # [ 0.459994] Using buffer write method688test # [ 0.460043] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689test # [ 0.469774] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690test # [ 0.469812] Intel/Sharp Extended Query Table at 0x0031691test # [ 0.471518] Using buffer write method692test # [ 0.471560] Concatenating MTD devices:693test # [ 0.471565] (0): "0.flash"694test # [ 0.471568] (1): "0.flash"695test # [ 0.471571] into device "0.flash"696second # [ 0.698602] Freeing initrd memory: 24808K697second # [ 0.706244] tun: Universal TUN/TAP device driver, 1.6698second # [ 0.709263] thunder_xcv, ver 1.0699second # [ 0.709303] thunder_bgx, ver 1.0700second # [ 0.709316] nicpf, ver 1.0701second # [ 0.709627] e1000: Intel(R) PRO/1000 Network Driver702second # [ 0.709636] e1000: Copyright (c) 1999-2006 Intel Corporation.703second # [ 0.709652] e1000e: Intel(R) PRO/1000 Network Driver704second # [ 0.709659] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.705second # [ 0.709674] igb: Intel(R) Gigabit Ethernet Network Driver706second # [ 0.709678] igb: Copyright (c) 2007-2014 Intel Corporation.707second # [ 0.709689] igbvf: Intel(R) Gigabit Virtual Function Network Driver708second # [ 0.709694] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.709second # [ 0.709795] sky2: driver version 1.30710second # [ 0.710604] usbcore: registered new interface driver usb-storage711second # [ 0.710660] usbcore: registered new interface driver usbserial_generic712second # [ 0.710668] usbserial: USB Serial support registered for generic713second # [ 0.710948] hv_vmbus: registering driver hyperv_keyboard714second # [ 0.718974] ehci-pci 0000:00:0a.0: EHCI Host Controller715second # [ 0.719031] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1716second # [ 0.719313] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000717second # [ 0.721192] rtc-pl031 9010000.pl031: registered as rtc0718second # [ 0.721240] rtc-pl031 9010000.pl031: setting system clock to 2026-09-11T20:08:12 UTC (1789157292)719second # [ 0.721490] i2c_dev: i2c /dev entries driver720second # [ 0.724555] sdhci: Secure Digital Host Controller Interface driver721second # [ 0.724574] sdhci: Copyright(c) Pierre Ossman722second # [ 0.724705] Synopsys Designware Multimedia Card Interface Driver723second # [ 0.724867] sdhci-pltfm: SDHCI platform and OF driver helper724second # [ 0.725855] hid: raw HID events driver (C) Jiri Kosina725second # [ 0.726013] usbcore: registered new interface driver usbhid726second # [ 0.726018] usbhid: USB HID core driver727second # [ 0.729912] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00728second # [ 0.730450] hub 1-0:1.0: USB hub found729second # [ 0.730538] hub 1-0:1.0: 6 ports detected730test # [ 0.692695] Freeing initrd memory: 24796K731second # [ 0.732029] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available732second # [ 0.732968] drop_monitor: Initializing network drop monitor service733second # [ 0.733189] NET: Registered PF_INET6 protocol family734second # [ 0.735808] Segment Routing with IPv6735second # [ 0.736221] In-situ OAM (IOAM) with IPv6736second # [ 0.736291] NET: Registered PF_PACKET protocol family737test # [ 0.700782] tun: Universal TUN/TAP device driver, 1.6738second # [ 0.737146] 9pnet: Installing 9P2000 support739second # [ 0.739003] Key type dns_resolver registered740test # [ 0.703714] thunder_xcv, ver 1.0741test # [ 0.703765] thunder_bgx, ver 1.0742test # [ 0.703778] nicpf, ver 1.0743test # [ 0.704146] e1000: Intel(R) PRO/1000 Network Driver744second # [ 0.742852] registered taskstats version 1745test # [ 0.704154] e1000: Copyright (c) 1999-2006 Intel Corporation.746second # [ 0.743052] Loading compiled-in X.509 certificates747test # [ 0.704170] e1000e: Intel(R) PRO/1000 Network Driver748test # [ 0.704176] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.749test # [ 0.704189] igb: Intel(R) Gigabit Ethernet Network Driver750test # [ 0.704192] igb: Copyright (c) 2007-2014 Intel Corporation.751second # [ 0.748759] Demotion targets for Node 0: null752test # [ 0.704203] igbvf: Intel(R) Gigabit Virtual Function Network Driver753test # [ 0.704207] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.754test # [ 0.704272] sky2: driver version 1.30755test # [ 0.709760] usbcore: registered new interface driver usb-storage756test # [ 0.709877] usbcore: registered new interface driver usbserial_generic757test # [ 0.709887] usbserial: USB Serial support registered for generic758test # [ 0.710192] hv_vmbus: registering driver hyperv_keyboard759second # [ 0.748879] Key type .fscrypt registered760second # [ 0.748885] Key type fscrypt-provisioning registered761second # [ 0.749012] ima: No TPM chip found, activating TPM-bypass!762second # [ 0.749027] ima: Allocated hash algorithm: sha1763second # [ 0.749090] ima: No architecture policies found764test # [ 0.713301] ehci-pci 0000:00:0a.0: EHCI Host Controller765test # [ 0.713347] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1766second # [ 0.752013] input: gpio-keys as /devices/platform/gpio-keys/input/input0767test # [ 0.713656] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000768test # [ 0.715424] rtc-pl031 9010000.pl031: registered as rtc0769test # [ 0.715476] rtc-pl031 9010000.pl031: setting system clock to 2026-09-11T20:08:12 UTC (1789157292)770test # [ 0.715753] i2c_dev: i2c /dev entries driver771test # [ 0.718711] sdhci: Secure Digital Host Controller Interface driver772test # [ 0.718731] sdhci: Copyright(c) Pierre Ossman773test # [ 0.718872] Synopsys Designware Multimedia Card Interface Driver774test # [ 0.719041] sdhci-pltfm: SDHCI platform and OF driver helper775test # [ 0.720130] hid: raw HID events driver (C) Jiri Kosina776test # [ 0.720289] usbcore: registered new interface driver usbhid777test # [ 0.720294] usbhid: USB HID core driver778test # [ 0.724009] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available779second # [ 0.763404] clk: Disabling unused clocks780second # [ 0.763436] PM: genpd: Disabling unused power domains781test # [ 0.725479] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00782test # [ 0.725954] hub 1-0:1.0: USB hub found783test # [ 0.726032] hub 1-0:1.0: 6 ports detected784test # [ 0.727780] drop_monitor: Initializing network drop monitor service785test # [ 0.727939] NET: Registered PF_INET6 protocol family786second # [ 0.767089] Freeing unused kernel memory: 4736K787second # [ 0.767239] Run /init as init process788test # [ 0.729736] Segment Routing with IPv6789test # [ 0.729766] In-situ OAM (IOAM) with IPv6790test # [ 0.729826] NET: Registered PF_PACKET protocol family791test # [ 0.730947] 9pnet: Installing 9P2000 support792test # [ 0.733132] Key type dns_resolver registered793test # [ 0.736556] registered taskstats version 1794test # [ 0.737102] Loading compiled-in X.509 certificates795test # [ 0.742470] Demotion targets for Node 0: null796test # [ 0.742572] Key type .fscrypt registered797test # [ 0.742578] Key type fscrypt-provisioning registered798test # [ 0.742723] ima: No TPM chip found, activating TPM-bypass!799test # [ 0.742736] ima: Allocated hash algorithm: sha1800test # [ 0.742838] ima: No architecture policies found801test # [ 0.746296] input: gpio-keys as /devices/platform/gpio-keys/input/input0802second # [ 0.797279] systemd[1]: Successfully made /usr/ read-only.803test # [ 0.758165] clk: Disabling unused clocks804test # [ 0.758199] PM: genpd: Disabling unused power domains805test # [ 0.761857] Freeing unused kernel memory: 4736K806test # [ 0.761981] Run /init as init process807test # [ 0.797452] systemd[1]: Successfully made /usr/ read-only.808second # [ 0.975875] usb 1-1: new high-speed USB device number 2 using ehci-pci809test # [ 0.972693] usb 1-1: new high-speed USB device number 2 using ehci-pci810second # [ 1.129506] 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/input1811second # [ 1.132029] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)812second # [ 1.134390] systemd[1]: Detected virtualization qemu.813second # [ 1.134821] systemd[1]: Detected architecture arm64.814second # [ 1.135268] systemd[1]: Running in initrd.815second # [ 1.137300] systemd[1]: Initializing machine ID from random generator.816second # [ 1.138744] systemd[1]: Hostname set to <second>.817test # [ 1.120417] 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/input1818test # [ 1.132707] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)819test # [ 1.135479] systemd[1]: Detected virtualization qemu.820test # [ 1.135987] systemd[1]: Detected architecture arm64.821test # [ 1.136426] systemd[1]: Running in initrd.822test # [ 1.139207] systemd[1]: Initializing machine ID from random generator.823test # [ 1.140700] systemd[1]: Hostname set to <test>.824second # [ 1.216140] 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.204949] 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.271077] systemd[1]: Queued start job for default target Initrd Default Target.827second # [ 1.282049] systemd[1]: Created slice Slice /system/modprobe.828second # [ 1.282802] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.829second # [ 1.283479] systemd[1]: Expecting device /dev/disk/by-label/nixos...830second # [ 1.284222] systemd[1]: Reached target Path Units.831second # [ 1.284654] systemd[1]: Reached target Slice Units.832second # [ 1.285063] systemd[1]: Reached target Swaps.833second # [ 1.285430] systemd[1]: Reached target Timer Units.834second # [ 1.286197] systemd[1]: Listening on D-Bus System Message Bus Socket.835second # [ 1.286912] systemd[1]: Listening on Journal Socket (/dev/log).836second # [ 1.287535] systemd[1]: Listening on Journal Sockets.837second # [ 1.288154] systemd[1]: Listening on udev Control Socket.838second # [ 1.288709] systemd[1]: Listening on udev Kernel Socket.839second # [ 1.289268] systemd[1]: Reached target Socket Units.840second # [ 1.291465] systemd[1]: Starting Create List of Static Device Nodes...841second # [ 1.299508] systemd[1]: Starting Load Kernel Module 9pnet_virtio...842second # [ 1.300186] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs843second # [ 1.302495] systemd[1]: Mounting Kernel Configuration File System...844test # [ 1.275047] systemd[1]: Queued start job for default target Initrd Default Target.845second # [ 1.324126] systemd[1]: Starting Journal Service...846test # [ 1.288281] systemd[1]: Created slice Slice /system/modprobe.847test # [ 1.289140] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.848test # [ 1.289816] systemd[1]: Expecting device /dev/disk/by-label/nixos...849test # [ 1.290330] systemd[1]: Reached target Path Units.850test # [ 1.290726] systemd[1]: Reached target Slice Units.851test # [ 1.291126] systemd[1]: Reached target Swaps.852test # [ 1.291494] systemd[1]: Reached target Timer Units.853test # [ 1.292391] systemd[1]: Listening on D-Bus System Message Bus Socket.854test # [ 1.293174] systemd[1]: Listening on Journal Socket (/dev/log).855test # [ 1.293796] systemd[1]: Listening on Journal Sockets.856test # [ 1.294347] systemd[1]: Listening on udev Control Socket.857test # [ 1.295046] systemd[1]: Listening on udev Kernel Socket.858test # [ 1.295520] systemd[1]: Reached target Socket Units.859test # [ 1.297786] systemd[1]: Starting Create List of Static Device Nodes...860second # [ 1.337090] usb 1-2: new high-speed USB device number 3 using ehci-pci861second # [ 1.338167] systemd[1]: Starting Load Kernel Modules...862second # [ 1.338231] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki863test # [ 1.304792] systemd[1]: Starting Load Kernel Module 9pnet_virtio...864test # [ 1.305491] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs865test # [ 1.312820] systemd[1]: Mounting Kernel Configuration File System...866second # [ 1.358131] systemd[1]: Starting Coldplug All udev Devices...867second # [ 1.359582] systemd[1]: Finished Create List of Static Device Nodes.868second # [ 1.362016] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.869test # [ 1.324740] usb 1-2: new high-speed USB device number 3 using ehci-pci870test # [ 1.325801] systemd[1]: Starting Journal Service...871second # [ 1.376649] systemd[1]: Finished Load Kernel Module 9pnet_virtio.872second # [ 1.377173] systemd[1]: Mounted Kernel Configuration File System.873test # [ 1.344901] systemd[1]: Starting Load Kernel Modules...874test # [ 1.345460] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki875test # [ 1.352537] systemd[1]: Starting Coldplug All udev Devices...876test # [ 1.355204] systemd[1]: Finished Create List of Static Device Nodes.877test # [ 1.357797] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.878second # [ 1.392205] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...879test # [ 1.364965] systemd[1]: Finished Load Kernel Module 9pnet_virtio.880test # [ 1.365450] systemd[1]: Mounted Kernel Configuration File System.881test # [ 1.369054] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...882second # [ 1.433396] systemd-journald[73]: Collecting audit messages is disabled.883second # [ 1.448247] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.884second # [ 1.449524] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev885second # [ 1.451732] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.886test # [ 1.413277] systemd-journald[73]: Collecting audit messages is disabled.887second # [ 1.461012] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0888second # [ 1.461270] [drm] features: -virgl +edid -resource_blob -host_visible889second # [ 1.461276] [drm] features: -context_init890second # [ 1.461846] [drm] number of scanouts: 1891second # [ 1.461865] [drm] number of cap sets: 0892test # [ 1.434649] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.893test # [ 1.436040] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.894second # [ 1.464875] systemd[1]: Starting Create Static Device Nodes in /dev...895test # [ 1.438099] systemd[1]: Starting Create Static Device Nodes in /dev...896test # [ 1.438749] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev897second # [ 1.484332] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic898second # [ 1.484356] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0899test # [ 1.449500] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0900test # [ 1.449766] [drm] features: -virgl +edid -resource_blob -host_visible901test # [ 1.449773] [drm] features: -context_init902test # [ 1.450309] [drm] number of scanouts: 1903test # [ 1.450326] [drm] number of cap sets: 0904second # [ 1.502520] 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/input2905second # [ 1.502635] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0906test # [ 1.469121] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic907test # [ 1.469143] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0908second # [ 1.512387] Console: switching to colour frame buffer device 160x50909second # [ 1.515310] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device910second # [ 1.517696] systemd[1]: Finished Create Static Device Nodes in /dev.911second # [ 1.517909] systemd[1]: Reached target Preparation for Local File Systems.912second # [ 1.517951] systemd[1]: Reached target Local File Systems.913second # [ 1.528291] systemd[1]: Starting Rule-based Manager for Device Events and Files...914test # [ 1.493235] Console: switching to colour frame buffer device 160x50915test # [ 1.496394] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device916second # [ 1.530190] systemd-modules-load[74]: Inserted module 'dm_mod'917test # [ 1.502473] systemd[1]: Finished Create Static Device Nodes in /dev.918test # [ 1.502691] systemd[1]: Reached target Preparation for Local File Systems.919test # [ 1.502736] systemd[1]: Reached target Local File Systems.920second # [ 1.544166] systemd[1]: Started Journal Service.921test # [ 1.506640] systemd[1]: Starting Rule-based Manager for Device Events and Files...922second # [ 1.539089] systemd-modules-load[74]: Module 'virtio_balloon' is built in923second # [ 1.541280] systemd-modules-load[74]: Module 'virtio_console' is built in924test # [ 1.510151] 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/input2925test # [ 1.510348] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0926second # [ 1.544376] systemd-modules-load[74]: Inserted module 'virtio_gpu'927second # [ 1.548389] systemd-modules-load[74]: Module 'virtio_rng' is built in928second # [ 1.551757] systemd[1]: Finished Load Kernel Modules.929second # [ 1.554675] systemd[1]: Starting Apply Kernel Variables...930test # [ 1.516452] systemd-modules-load[74]: Inserted module 'dm_mod'931test # [ 1.517288] systemd-modules-load[74]: Module 'virtio_balloon' is built in932test # [ 1.526710] systemd[1]: Started Journal Service.933test # [ 1.520420] systemd-modules-load[74]: Module 'virtio_console' is built in934test # [ 1.524312] systemd-modules-load[74]: Inserted module 'virtio_gpu'935test # [ 1.525020] systemd-modules-load[74]: Module 'virtio_rng' is built in936test # [ 1.528368] systemd[1]: Finished Load Kernel Modules.937second # [ 1.568135] systemd[1]: Starting Create System Files and Directories...938test # [ 1.537049] systemd[1]: Starting Apply Kernel Variables...939test # [ 1.551955] systemd[1]: Starting Create System Files and Directories...940second # [ 1.613101] systemd[1]: Finished Apply Kernel Variables.941second # [ 1.615460] systemd-udevd[80]: Using default interface naming scheme 'v260'.942second # [ 1.629991] systemd[1]: Finished Create System Files and Directories.943test # [ 1.598898] systemd[1]: Finished Apply Kernel Variables.944second # [ 1.647031] systemd[1]: Started Rule-based Manager for Device Events and Files.945test # [ 1.611918] systemd-udevd[80]: Using default interface naming scheme 'v260'.946test # [ 1.613511] systemd[1]: Finished Create System Files and Directories.947test # [ 1.641710] systemd[1]: Started Rule-based Manager for Device Events and Files.948second # [ 1.725189] systemd[1]: Starting Virtual Console Setup...949test # [ 1.707116] systemd[1]: Starting Virtual Console Setup...950second # [ 1.776463] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.951second # [ 1.779404] systemd[1]: Finished Virtual Console Setup.952test # [ 1.764551] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.953test # [ 1.767372] systemd[1]: Finished Virtual Console Setup.954second # [ 2.032667] systemd[1]: Finished Coldplug All udev Devices.955second # [ 2.036196] systemd[1]: Reached target System Initialization.956second # [ 2.036781] systemd[1]: Reached target Basic System.957test # [ 2.017931] systemd[1]: Finished Coldplug All udev Devices.958test # [ 2.018571] systemd[1]: Reached target System Initialization.959test # [ 2.019113] systemd[1]: Reached target Basic System.960second # [ 2.138609] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.961test # [ 2.122436] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.962second # [ 2.169819] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.963test # [ 2.147326] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.964second # [ 2.219491] systemd[1]: Found device /dev/disk/by-label/nixos.965test # [ 2.183558] systemd[1]: Found device /dev/disk/by-label/nixos.966second # [ 2.222655] systemd[1]: Reached target Initrd Root Device.967test # [ 2.186501] systemd[1]: Reached target Initrd Root Device.968second # [ 2.225497] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969test # [ 2.189244] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...970test # [ 2.232185] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks971test # [ 2.238818] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.972second # [ 2.281360] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks973second # [ 2.287507] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.974second # [ 2.353116] systemd[1]: Mounting /sysroot...975second # [ 2.392871] EXT4-fs (vda): mounted filesystem bf83a622-d6f0-40c3-a452-0a7bb33878d1 r/w with ordered data mode. Quota mode: none.976second # [ 2.388740] systemd[1]: Mounted /sysroot.977second # [ 2.390730] systemd[1]: Reached target Initrd Root File System.978test # [ 2.351778] systemd[1]: Mounting /sysroot...979second # [ 2.396180] systemd[1]: Mounting /sysroot/nix/.ro-store...980second # [ 2.404797] systemd[1]: Mounting /sysroot/nix/.rw-store...981test # [ 2.380712] EXT4-fs (vda): mounted filesystem d865bef7-6356-4b99-b42e-4435ea11da72 r/w with ordered data mode. Quota mode: none.982second # [ 2.415281] systemd[1]: Mounting /sysroot/run...983test # [ 2.377244] systemd[1]: Mounted /sysroot.984test # [ 2.381205] systemd[1]: Reached target Initrd Root File System.985test # [ 2.384130] systemd[1]: Starting Mountpoints Configured in the Real Root...986second # [ 2.425934] systemd[1]: Mounting /sysroot/tmp/shared...987second # [ 2.446497] systemd[1]: Mounting /sysroot/tmp/xchg...988test # [ 2.412084] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.989test # [ 2.414975] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...990test # [ 2.418575] systemd[1]: Reloading...991second # [ 2.458646] systemd[1]: Starting Mountpoints Configured in the Real Root...992second # [ 2.483119] systemd[1]: Mounted /sysroot/nix/.ro-store.993second # [ 2.506675] systemd[1]: Mounted /sysroot/nix/.rw-store.994second # [ 2.508523] systemd[1]: Mounted /sysroot/run.995second # [ 2.518599] systemd[1]: Mounted /sysroot/tmp/xchg.996second # [ 2.520874] systemd[1]: Mounted /sysroot/tmp/shared.997second # [ 2.526277] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.998second # [ 2.529756] systemd[1]: Starting rw-sysroot-nix-store.service...999second # [ 2.542154] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1000second # [ 2.544150] systemd[1]: Reloading...1001test # [ 2.613341] systemd[1]: Reloading finished in 196 ms.1002test # [ 2.627296] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1003test # [ 2.630634] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1004test # [ 2.632959] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1005test # [ 2.644505] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1006test # [ 2.645511] systemd[1]: Finished Mountpoints Configured in the Real Root.1007test # [ 2.648107] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1008test # [ 2.660859] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1009test # [ 2.661578] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1010second # [ 2.760303] systemd[1]: Reloading finished in 218 ms.1011second # [ 2.776464] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1012second # [ 2.779076] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1013second # [ 2.782524] systemd[1]: Finished rw-sysroot-nix-store.service.1014second # [ 2.783106] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1015second # [ 2.790773] systemd[1]: Starting rw-sysroot-nix-store.service...1016second # [ 2.793627] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1017second # [ 2.798130] systemd[1]: Finished Mountpoints Configured in the Real Root.1018second # [ 2.799357] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1019second # [ 2.817444] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1020second # [ 2.818175] systemd[1]: Finished rw-sysroot-nix-store.service.1021test # [ 3.094938] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/lib/udev/mtd_probe": No such file or directory1022test # [ 3.098827] (udev-worker)[101]: mtd0ro: /nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1023test # [ 3.110400] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1024test # [ 3.111910] systemd[1]: Stopped Virtual Console Setup.1025test # [ 3.116838] systemd[1]: Stopping Virtual Console Setup...1026test # [ 3.117371] systemd[1]: Starting Virtual Console Setup...1027test # [ 3.139698] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones.1028second # [ 3.179548] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/lib/udev/mtd_probe": No such file or directory1029test # [ 3.142536] systemd[1]: Finished Virtual Console Setup.1030second # [ 3.184842] (udev-worker)[97]: mtd0ro: /nix/store/x8r7i65cbx5zbf8f0dmnvwrm00r5ild8-systemd-260.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1031second # [ 3.200748] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1032second # [ 3.203498] systemd[1]: Stopped Virtual Console Setup.1033second # [ 3.204129] systemd[1]: Stopping Virtual Console Setup...1034second # [ 3.204621] systemd[1]: Starting Virtual Console Setup...1035second # [ 3.227784] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.1036second # [ 3.230302] systemd[1]: Finished Virtual Console Setup.1037second # [ 3.353624] systemd[1]: Mounting /sysroot/nix/store...1038test # [ 3.350883] systemd[1]: Mounting /sysroot/nix/.ro-store...1039second # [ 3.393790] systemd[1]: Mounted /sysroot/nix/store.1040second # [ 3.394816] systemd[1]: Reached target Initrd File Systems.1041second # [ 3.396872] systemd[1]: Starting Find NixOS closure...1042test # [ 3.360359] systemd[1]: Mounting /sysroot/nix/.rw-store...1043second # [ 3.404334] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1044test # [ 3.367481] systemd[1]: Mounting /sysroot/run...1045test # [ 3.382423] systemd[1]: Mounting /sysroot/tmp/shared...1046test # [ 3.392347] systemd[1]: Mounting /sysroot/tmp/xchg...1047second # [ 3.437644] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1048second # [ 3.440175] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1049second # [ 3.453478] systemd[1]: Finished Find NixOS closure.1050second # [ 3.456229] systemd[1]: Reached target Initrd Default Target.1051second # [ 3.460320] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1052test # [ 3.422450] systemd[1]: Mounted /sysroot/nix/.rw-store.1053test # [ 3.436916] systemd[1]: Starting rw-sysroot-nix-store.service...1054test # [ 3.439737] systemd[1]: Mounted /sysroot/nix/.ro-store.1055second # [ 3.488216] systemd[1]: initrd-cleanup.service: Deactivated successfully.1056test # [ 3.449857] systemd[1]: Mounted /sysroot/run.1057second # [ 3.489554] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1058test # [ 3.453491] systemd[1]: Mounted /sysroot/tmp/shared.1059second # [ 3.493323] systemd[1]: Stopped target Initrd Default Target.1060second # [ 3.496203] systemd[1]: Stopped target Basic System.1061second # [ 3.496877] systemd[1]: Stopped target Initrd Root Device.1062second # [ 3.497547] systemd[1]: Stopped target Path Units.1063second # [ 3.499705] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1064test # [ 3.461110] systemd[1]: Mounted /sysroot/tmp/xchg.1065second # [ 3.504232] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1066second # [ 3.505119] systemd[1]: Stopped target Slice Units.1067second # [ 3.505696] systemd[1]: Stopped target Socket Units.1068second # [ 3.506318] systemd[1]: Stopped target System Initialization.1069second # [ 3.506997] systemd[1]: Stopped target Swaps.1070second # [ 3.507512] systemd[1]: Stopped target Timer Units.1071test # [ 3.471116] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1072test # [ 3.472644] systemd[1]: Finished rw-sysroot-nix-store.service.1073second # [ 3.512248] systemd[1]: dbus.socket: Deactivated successfully.1074second # [ 3.512904] systemd[1]: Closed D-Bus System Message Bus Socket.1075second # [ 3.513514] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1076second # [ 3.514346] systemd[1]: Stopped Find NixOS closure.1077test # [ 3.475401] systemd[1]: Mounting /sysroot/nix/store...1078second # [ 3.514868] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1079second # [ 3.517599] systemd[1]: Starting rw-sysroot-nix-store.service...1080second # [ 3.519810] systemd[1]: systemd-sysctl.service: Deactivated successfully.1081second # [ 3.522957] systemd[1]: Stopped Apply Kernel Variables.1082second # [ 3.523480] systemd[1]: systemd-modules-load.service: Deactivated successfully.1083second # [ 3.527619] systemd[1]: Stopped Load Kernel Modules.1084second # [ 3.529139] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1085second # [ 3.530461] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1086second # [ 3.531162] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1087second # [ 3.531921] systemd[1]: Stopped Create System Files and Directories.1088second # [ 3.532629] systemd[1]: Stopped target Local File Systems.1089second # [ 3.533120] systemd[1]: Stopped target Preparation for Local File Systems.1090second # [ 3.533684] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1091second # [ 3.534306] systemd[1]: Stopped Coldplug All udev Devices.1092second # [ 3.534767] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1093second # [ 3.535353] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1094second # [ 3.544332] systemd[1]: Stopped Virtual Console Setup.1095second # [ 3.547255] systemd[1]: systemd-udevd.service: Deactivated successfully.1096test # [ 3.510650] systemd[1]: Mounted /sysroot/nix/store.1097test # [ 3.512084] systemd[1]: Reached target Initrd File Systems.1098second # [ 3.551863] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1099test # [ 3.514304] systemd[1]: Starting Find NixOS closure...1100second # [ 3.553064] systemd[1]: systemd-udevd.service: Consumed 1.008s CPU time over 2.022s wall clock time, 21.6M memory peak.1101second # [ 3.554000] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1102second # [ 3.554596] systemd[1]: Closed udev Control Socket.1103second # [ 3.555001] systemd[1]: Starting Cleanup udev Database...1104second # [ 3.555468] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1105second # [ 3.557459] systemd[1]: Stopped Create Static Device Nodes in /dev.1106second # [ 3.558692] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1107second # [ 3.560136] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1108second # [ 3.561222] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1109second # [ 3.561895] systemd[1]: Stopped Create List of Static Device Nodes.1110second # [ 3.562455] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1111test # [ 3.524216] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1112second # [ 3.563069] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1113second # [ 3.563574] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1114second # [ 3.564207] systemd[1]: Finished rw-sysroot-nix-store.service.1115second # [ 3.586603] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1116second # [ 3.587360] systemd[1]: Finished Cleanup udev Database.1117test # [ 3.548475] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1118second # [ 3.587831] systemd[1]: Reached target Switch Root.1119second # [ 3.592332] systemd[1]: Starting NixOS Activation...1120test # [ 3.559700] systemd[1]: Finished Find NixOS closure.1121test # [ 3.561133] systemd[1]: Reached target Initrd Default Target.1122test # [ 3.563350] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1123test # [ 3.591780] systemd[1]: initrd-cleanup.service: Deactivated successfully.1124test # [ 3.592926] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1125test # [ 3.595469] systemd[1]: Stopped target Initrd Default Target.1126test # [ 3.596534] systemd[1]: Stopped target Basic System.1127test # [ 3.598899] systemd[1]: Stopped target Initrd Root Device.1128test # [ 3.599553] systemd[1]: Stopped target Path Units.1129test # [ 3.599986] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1130test # [ 3.601141] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1131test # [ 3.602966] systemd[1]: Stopped target Slice Units.1132test # [ 3.604184] systemd[1]: Stopped target Socket Units.1133test # [ 3.608058] systemd[1]: Stopped target System Initialization.1134test # [ 3.608595] systemd[1]: Stopped target Swaps.1135test # [ 3.608990] systemd[1]: Stopped target Timer Units.1136test # [ 3.609525] systemd[1]: dbus.socket: Deactivated successfully.1137test # [ 3.609983] systemd[1]: Closed D-Bus System Message Bus Socket.1138test # [ 3.610440] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1139test # [ 3.611122] systemd[1]: Stopped Find NixOS closure.1140test # [ 3.611569] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1141test # [ 3.617884] systemd[1]: Starting rw-sysroot-nix-store.service...1142test # [ 3.618449] systemd[1]: systemd-sysctl.service: Deactivated successfully.1143test # [ 3.619032] systemd[1]: Stopped Apply Kernel Variables.1144test # [ 3.619496] systemd[1]: systemd-modules-load.service: Deactivated successfully.1145test # [ 3.623224] systemd[1]: Stopped Load Kernel Modules.1146test # [ 3.623713] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1147test # [ 3.625896] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1148test # [ 3.626645] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1149test # [ 3.627287] systemd[1]: Stopped Create System Files and Directories.1150test # [ 3.627851] systemd[1]: Stopped target Local File Systems.1151test # [ 3.630518] systemd[1]: Stopped target Preparation for Local File Systems.1152test # [ 3.631182] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1153test # [ 3.631765] systemd[1]: Stopped Coldplug All udev Devices.1154test # [ 3.639492] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1155test # [ 3.641317] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1156test # [ 3.644434] systemd[1]: Stopped Virtual Console Setup.1157test # [ 3.645056] systemd[1]: systemd-udevd.service: Deactivated successfully.1158test # [ 3.645677] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1159test # [ 3.646961] systemd[1]: systemd-udevd.service: Consumed 1.015s CPU time over 2.132s wall clock time, 21.6M memory peak.1160test # [ 3.648966] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1161test # [ 3.651710] systemd[1]: Closed udev Control Socket.1162test # [ 3.652389] systemd[1]: Starting Cleanup udev Database...1163test # [ 3.652883] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1164test # [ 3.654095] systemd[1]: Stopped Create Static Device Nodes in /dev.1165test # [ 3.654739] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1166test # [ 3.655457] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1167test # [ 3.656261] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1168test # [ 3.656874] systemd[1]: Stopped Create List of Static Device Nodes.1169test # [ 3.657412] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1170test # [ 3.658030] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1171test # [ 3.658562] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1172test # [ 3.659190] systemd[1]: Finished rw-sysroot-nix-store.service.1173test # [ 3.677968] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1174test # [ 3.678731] systemd[1]: Finished Cleanup udev Database.1175test # [ 3.679208] systemd[1]: Reached target Switch Root.1176test # [ 3.680927] systemd[1]: Starting NixOS Activation...1177second # [ 3.759626] initrd-nixos-activation-start[178]: booting system configuration /nix/store/kmvhghjqsn16g72ggn63vanqz3z5whnf-nixos-system-second-test1178second # [ 3.809668] initrd-nixos-activation-start[178]: running activation script...1179test # [ 3.888272] initrd-nixos-activation-start[179]: booting system configuration /nix/store/vwbd99spgcc2gncrv0sjs6fkf8zrj0c6-nixos-system-test-test1180test # [ 3.949852] initrd-nixos-activation-start[179]: running activation script...1181second # [ 4.194293] initrd-nixos-activation-start[201]: setting up /etc...1182second # [ 4.556993] initrd-nixos-activation-start[201]: setting up age secrets...1183test # [ 4.651543] initrd-nixos-activation-start[202]: setting up /etc...1184second # [ 4.979364] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1185second # [ 4.981318] systemd[1]: Finished NixOS Activation.1186second # [ 4.982160] systemd[1]: Starting Switch Root...1187test # [ 4.946137] initrd-nixos-activation-start[202]: setting up age secrets...1188second # [ 4.997301] systemd[1]: Switching root.1189second # [ 5.052139] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1190test # [ 5.201316] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1191test # [ 5.202376] systemd[1]: Finished NixOS Activation.1192test # [ 5.204165] systemd[1]: Starting Switch Root...1193test # [ 5.225942] systemd[1]: Switching root.1194test # [ 5.286422] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1195second # [ 5.601122] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1196second # [ 5.608654] systemd[1]: Detected virtualization qemu.1197second # [ 5.611027] systemd[1]: Detected architecture arm64.1198second # [ 5.612418] systemd[1]: Detected first boot.1199second # [ 5.619032] systemd[1]: Initializing machine ID from random generator.1200second # [ 5.894250] systemd[1]: bpf-restrict-fs: LSM BPF program attached1201test # [ 5.898158] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1202test # [ 5.906085] systemd[1]: Detected virtualization qemu.1203test # [ 5.908020] systemd[1]: Detected architecture arm64.1204test # [ 5.910571] systemd[1]: Detected first boot.1205test # [ 5.916570] systemd[1]: Initializing machine ID from random generator.1206second # [ 6.039460] systemd[1]: Applying preset policy.1207test # [ 6.214014] systemd[1]: bpf-restrict-fs: LSM BPF program attached1208second # [ 6.435998] systemd[1]: Populated /etc with preset unit settings.1209test # [ 6.402485] systemd[1]: Applying preset policy.1210test # [ 6.945067] systemd[1]: Populated /etc with preset unit settings.1211second # [ 6.985722] systemd[1]: initrd-switch-root.service: Deactivated successfully.1212second # [ 6.986666] systemd[1]: Stopped initrd-switch-root.service.1213second # [ 6.989282] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1214second # [ 6.991332] systemd[1]: Created slice Slice /system/getty.1215second # [ 6.992581] systemd[1]: Created slice User and Session Slice.1216second # [ 6.993247] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1217second # [ 6.994770] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1218second # [ 6.996144] systemd[1]: Expecting device /dev/hvc0...1219second # [ 6.997137] systemd[1]: Expecting device /dev/ttyAMA0...1220second # [ 6.998188] systemd[1]: Reached target Local Encrypted Volumes.1221second # [ 6.999267] systemd[1]: Stopped target initrd-fs.target.1222second # [ 7.000373] systemd[1]: Stopped target initrd-root-fs.target.1223second # [ 7.001988] systemd[1]: Stopped target initrd-switch-root.target.1224second # [ 7.003551] systemd[1]: Reached target Virtual Machines and Containers.1225second # [ 7.005287] systemd[1]: Reached target Path Units.1226second # [ 7.006207] systemd[1]: Reached target Remote File Systems.1227second # [ 7.007299] systemd[1]: Reached target Slice Units.1228second # [ 7.008789] systemd[1]: Reached target Swaps.1229second # [ 7.014103] systemd[1]: Listening on Process Core Dump Socket.1230second # [ 7.018319] systemd[1]: Listening on Credential Encryption/Decryption.1231second # [ 7.024500] systemd[1]: Starting Journal Log Access Socket...1232second # [ 7.025952] systemd[1]: Listening on Journal Audit Socket.1233second # [ 7.027100] systemd[1]: Listening on Network Management Metrics Varlink Socket.1234second # [ 7.028871] systemd[1]: Listening on Network Management Netlink Socket.1235second # [ 7.030348] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1236second # [ 7.031993] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1237second # [ 7.033924] systemd[1]: Listening on udev Control Socket.1238second # [ 7.038341] systemd[1]: Mounting Huge Pages File System...1239second # [ 7.042333] systemd[1]: Mounting POSIX Message Queue File System...1240second # [ 7.049667] systemd[1]: Mounting Kernel Debug File System...1241second # [ 7.057389] systemd[1]: Mounting Kernel Trace File System...1242second # [ 7.065631] systemd[1]: Starting Create List of Static Device Nodes...1243second # [ 7.077097] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1244second # [ 7.078645] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1245second # [ 7.092665] systemd[1]: Mounting Kernel Configuration File System...1246second # [ 7.094250] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1247second # [ 7.096516] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1248second # [ 7.106286] systemd[1]: Starting Load Kernel Module fuse...1249second # [ 7.108718] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671250second # [ 7.164258] systemd[1]: Starting Journal Service...1251second # [ 7.186322] systemd[1]: Starting Load Kernel Modules...1252second # [ 7.209556] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1253second # [ 7.229705] systemd[1]: Starting Remount Root and Kernel File Systems...1254second # [ 7.232836] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1255second # [ 7.258719] systemd[1]: Starting Coldplug All udev Devices...1256second # [ 7.274131] systemd[1]: Listening on Journal Log Access Socket.1257second # [ 7.292859] fuse: init (API version 7.45)1258second # [ 7.296406] systemd[1]: Mounted Huge Pages File System.1259second # [ 7.297025] systemd[1]: Mounted POSIX Message Queue File System.1260second # [ 7.297447] systemd[1]: Mounted Kernel Debug File System.1261second # [ 7.297860] systemd[1]: Mounted Kernel Trace File System.1262second # [ 7.298453] systemd[1]: Finished Create List of Static Device Nodes.1263second # [ 7.298977] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1264second # [ 7.299412] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1265second # [ 7.317515] systemd-journald[301]: Collecting audit messages is enabled.1266second # [ 7.319366] systemd[1]: Queued start job for default target Multi-User System.1267second # [ 7.328591] systemd[1]: Mounted Kernel Configuration File System.1268second # [ 7.333057] systemd[1]: Started Journal Service.1269second # [ 7.329377] systemd[1]: systemd-journald.service: Deactivated successfully.1270second # [ 7.334495] systemd-modules-load[302]: Module 'atkbd' is built in1271second # [ 7.336641] systemd-modules-load[302]: Module 'ctr' is built in1272second # [ 7.340631] systemd-modules-load[302]: Module 'loop' is built in1273second # [ 7.343562] systemd[1]: modprobe@fuse.service: Deactivated successfully.[ 7.352647] EXT4-fs (vda): re-mounted bf83a622-d6f0-40c3-a452-0a7bb33878d1.1274second # 1275second # [ 7.351338] systemd[1]: Finished Load Kernel Module fuse.1276second # [ 7.355242] systemd[1]: Finished Load Kernel Modules.1277second # [ 7.366477] systemd[1]: Finished Remount Root and Kernel File Systems.1278second # [ 7.374669] systemd[1]: Mounting FUSE Control File System...1279second # [ 7.378475] systemd[1]: Starting Firewall...1280second # [ 7.383924] systemd[1]: Starting Flush Journal to Persistent Storage...1281second # [ 7.385825] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1282second # [ 7.396314] systemd-oomd[303]: No swap; memory pressure usage will be degraded1283second # [ 7.423374] systemd[1]: Starting Load/Save OS Random Seed...1284second # [ 7.434071] systemd[1]: Starting Apply Kernel Variables...1285second # [ 7.474958] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1286second # [ 7.481073] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1287test # [ 7.454789] systemd[1]: initrd-switch-root.service: Deactivated successfully.1288second # [ 7.485207] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1289test # [ 7.455787] systemd[1]: Stopped initrd-switch-root.service.1290test # [ 7.458288] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1291test # [ 7.461040] systemd[1]: Created slice Slice /system/getty.1292test # [ 7.461538] systemd[1]: Created slice User and Session Slice.1293test # [ 7.462147] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1294test # [ 7.462537] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1295test # [ 7.462869] systemd[1]: Expecting device /dev/hvc0...1296test # [ 7.463158] systemd[1]: Expecting device /dev/ttyAMA0...1297test # [ 7.463452] systemd[1]: Reached target Local Encrypted Volumes.1298test # [ 7.463774] systemd[1]: Stopped target initrd-fs.target.1299test # [ 7.464057] systemd[1]: Stopped target initrd-root-fs.target.1300test # [ 7.464332] systemd[1]: Stopped target initrd-switch-root.target.1301test # [ 7.464617] systemd[1]: Reached target Virtual Machines and Containers.1302test # [ 7.470966] systemd[1]: Reached target Path Units.1303test # [ 7.472578] systemd[1]: Reached target Remote File Systems.1304test # [ 7.474107] systemd[1]: Reached target Slice Units.1305test # [ 7.475626] systemd[1]: Reached target Swaps.1306second # [ 7.514997] systemd-journald[301]: Received client request to flush runtime journal.1307test # [ 7.480086] systemd[1]: Listening on Process Core Dump Socket.1308test # [ 7.483778] systemd[1]: Listening on Credential Encryption/Decryption.1309test # [ 7.488281] systemd[1]: Starting Journal Log Access Socket...1310test # [ 7.490216] systemd[1]: Listening on Journal Audit Socket.1311test # [ 7.491473] systemd[1]: Listening on Network Management Metrics Varlink Socket.1312test # [ 7.492944] systemd[1]: Listening on Network Management Netlink Socket.1313test # [ 7.494264] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1314test # [ 7.495853] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1315test # [ 7.498237] systemd[1]: Listening on udev Control Socket.1316test # [ 7.502725] systemd[1]: Mounting Huge Pages File System...1317test # [ 7.507164] systemd[1]: Mounting POSIX Message Queue File System...1318test # [ 7.515125] systemd[1]: Mounting Kernel Debug File System...1319test # [ 7.523729] systemd[1]: Mounting Kernel Trace File System...1320test # [ 7.537200] systemd[1]: Starting Create List of Static Device Nodes...1321test # [ 7.548901] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1322test # [ 7.551502] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1323test # [ 7.561434] systemd[1]: Mounting Kernel Configuration File System...1324test # [ 7.563542] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1325test # [ 7.568814] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1326second # [ 7.602293] systemd[1]: Mounted FUSE Control File System.1327second # [ 7.610725] systemd[1]: Finished Flush Journal to Persistent Storage.1328second # [ 7.615148] systemd[1]: Finished Load/Save OS Random Seed.1329test # [ 7.586558] systemd[1]: Starting Load Kernel Module fuse...1330test # [ 7.589081] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671331second # [ 7.622623] systemd[1]: Reached target First Boot Complete.1332second # [ 7.646178] systemd[1]: Finished Apply Kernel Variables.1333second # [ 7.662628] systemd[1]: Starting Network Name Resolution...1334test # [ 7.656209] systemd[1]: Starting Journal Service...1335second # [ 7.689625] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1336second # [ 7.694061] systemd[1]: Starting Create Static Device Nodes in /dev...1337test # [ 7.672250] systemd[1]: Starting Load Kernel Modules...1338test # [ 7.699070] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1339test # [ 7.714452] systemd[1]: Starting Remount Root and Kernel File Systems...1340test # [ 7.718943] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1341test # [ 7.744723] fuse: init (API version 7.45)1342test # [ 7.751026] systemd[1]: Starting Coldplug All udev Devices...1343test # [ 7.763340] systemd[1]: Listening on Journal Log Access Socket.1344test # [ 7.765031] systemd[1]: Mounted Huge Pages File System.1345test # [ 7.766411] systemd[1]: Mounted POSIX Message Queue File System.1346test # [ 7.768197] systemd[1]: Mounted Kernel Debug File System.1347test # [ 7.770362] systemd[1]: Mounted Kernel Trace File System.1348test # [ 7.773023] systemd[1]: Finished Create List of Static Device Nodes.1349test # [ 7.775857] systemd-journald[322]: Collecting audit messages is enabled.1350second # [ 7.819203] systemd-resolved[334]: Positive Trust Anchors:1351second # [ 7.820754] systemd-resolved[334]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1352test # [ 7.790241] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1353second # [ 7.822120] systemd-resolved[334]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161354test # [ 7.796884] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1355test # [ 7.797500] systemd[1]: Started Journal Service.1356test # [ 7.791552] systemd[1]: Queued start job for default target Multi-User System.1357test # [ 7.792588] systemd[1]: systemd-journald.service: Deactivated successfully.1358test # [ 7.793596] systemd-modules-load[323]: Module 'atkbd' is built in1359test # [ 7.794303] systemd-modules-load[323]: Module 'ctr' is built in1360test # [ 7.794959] systemd-modules-load[323]: Module 'loop' is built in1361test # [ 7.795613] systemd[1]: Mounted Kernel Configuration File System.1362second # [ 7.823978] systemd-resolved[334]: 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 test1363test # [ 7.806820] systemd[1]: modprobe@fuse.service: Deactivated successfully.1364test # [ 7.809019] systemd[1]: Finished Load Kernel Module fuse.1365test # [ 7.817064] systemd[1]: Finished Load Kernel Modules.1366second # [ 7.857220] systemd[1]: Finished Create Static Device Nodes in /dev.1367second # [ 7.864359] systemd[1]: Reached target Preparation for Local File Systems.1368second # [ 7.865379] systemd[1]: Starting Rule-based Manager for Device Events and Files...1369test # [ 7.845779] EXT4-fs (vda): re-mounted d865bef7-6356-4b99-b42e-4435ea11da72.1370test # [ 7.841371] systemd[1]: Mounting FUSE Control File System...1371test # [ 7.847161] systemd[1]: Starting Firewall...1372test # [ 7.852730] systemd[1]: Starting Apply Kernel Variables...1373test # [ 7.871810] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1374test # [ 7.888364] systemd-oomd[325]: No swap; memory pressure usage will be degraded1375test # [ 7.890515] systemd[1]: Finished Remount Root and Kernel File Systems.1376test # [ 7.900469] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1377test # [ 7.929580] systemd[1]: Starting Flush Journal to Persistent Storage...1378test # [ 7.930297] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1379test # [ 7.940549] systemd[1]: Starting Load/Save OS Random Seed...1380test # [ 7.941198] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1381second # [ 7.981035] systemd[1]: Mounting /run/wrappers...1382second # [ 7.995557] systemd-udevd[349]: Using default interface naming scheme 'v260'.1383second # [ 8.065181] systemd[1]: Mounted /run/wrappers.1384test # [ 8.028752] systemd[1]: Mounted FUSE Control File System.1385second # [ 8.068329] systemd[1]: Reached target Local File Systems.1386test # [ 8.032758] systemd[1]: Finished Apply Kernel Variables.1387second # [ 8.074335] systemd[1]: Listening on Boot Loader Control Service Socket.1388test # [ 8.043019] systemd[1]: Starting Network Name Resolution...1389second # [ 8.086339] systemd[1]: Starting register-nix-paths.service...1390second # [ 8.090477] systemd[1]: Starting Create SUID/SGID Wrappers...1391second # [ 8.091292] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1392second # [ 8.098564] systemd[1]: Starting Save Transient machine-id to Disk...1393second # [ 8.110550] systemd-resolved[334]: Using system hostname 'second'.1394test # [ 8.082112] systemd-journald[322]: Received client request to flush runtime journal.1395second # [ 8.121221] systemd[1]: Starting Create System Files and Directories...1396second # [ 8.124864] systemd[1]: Started Network Name Resolution.1397test # [ 8.178268] systemd[1]: Finished Load/Save OS Random Seed.1398test # [ 8.185387] systemd[1]: Reached target First Boot Complete.1399test # [ 8.189327] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1400test # [ 8.192069] systemd[1]: Starting Create Static Device Nodes in /dev...1401test # [ 8.196425] systemd[1]: Finished Flush Journal to Persistent Storage.1402test # [ 8.238482] systemd-resolved[350]: Positive Trust Anchors:1403test # [ 8.240245] systemd-resolved[350]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1404test # [ 8.241309] systemd-resolved[350]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161405second # [ 8.287107] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1406test # [ 8.242803] systemd-resolved[350]: 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 test1407second # [ 8.308731] systemd[1]: Finished Save Transient machine-id to Disk.1408test # [ 8.296508] systemd[1]: Finished Create Static Device Nodes in /dev.1409test # [ 8.297334] systemd[1]: Reached target Preparation for Local File Systems.1410test # [ 8.305607] systemd[1]: Starting Rule-based Manager for Device Events and Files...1411second # [ 8.350852] systemd[1]: Finished Create System Files and Directories.1412second # [ 8.363143] systemd[1]: Starting Rebuild Journal Catalog...1413second # [ 8.378131] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1414second # [ 8.397772] systemd[1]: Started Rule-based Manager for Device Events and Files.1415test # [ 8.456575] systemd[1]: Mounting /run/wrappers...1416test # [ 8.463861] systemd-udevd[367]: Using default interface naming scheme 'v260'.1417test # [ 8.488578] systemd-resolved[350]: Using system hostname 'test'.1418test # [ 8.497120] systemd[1]: Started Network Name Resolution.1419second # [ 8.541012] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1420test # [ 8.532391] systemd[1]: Mounted /run/wrappers.1421test # [ 8.537283] systemd[1]: Reached target Local File Systems.1422test # [ 8.542486] systemd[1]: Listening on Boot Loader Control Service Socket.1423test # [ 8.547457] systemd[1]: Starting register-nix-paths.service...1424test # [ 8.552203] systemd[1]: Starting Create SUID/SGID Wrappers...1425test # [ 8.556342] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1426test # [ 8.559293] systemd[1]: Starting Save Transient machine-id to Disk...1427second # [ 8.620459] systemd[1]: Finished Rebuild Journal Catalog.1428second # [ 8.634183] systemd[1]: Starting Update is Completed...1429test # [ 8.601083] systemd[1]: Starting Create System Files and Directories...1430second # [ 8.686812] systemd[1]: Finished Coldplug All udev Devices.1431second # [ 8.723428] systemd[1]: Finished Update is Completed.1432test # [ 8.736781] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1433test # [ 8.757126] systemd[1]: Finished Save Transient machine-id to Disk.1434test # [ 8.804478] systemd[1]: Finished Create System Files and Directories.1435test # [ 8.819836] systemd[1]: Starting Rebuild Journal Catalog...1436test # [ 8.826297] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1437test # [ 8.872670] systemd[1]: Started Rule-based Manager for Device Events and Files.1438second # [ 8.987833] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1439test # [ 8.971221] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1440test # [ 9.064806] systemd[1]: Finished Rebuild Journal Catalog.1441test # [ 9.082080] systemd[1]: Starting Update is Completed...1442test # [ 9.177937] systemd[1]: Finished Update is Completed.1443test # [ 9.194314] systemd[1]: Finished Coldplug All udev Devices.1444second # [ 9.337541] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1445second # [ 9.341910] systemd[1]: Finished Create SUID/SGID Wrappers.1446second # [ 9.361750] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1447second # [ 9.423589] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1448test # [ 9.462560] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1449second # [ 9.549706] systemd[1]: Finished register-nix-paths.service.1450second # [ 9.552331] systemd[1]: Reached target System Initialization.1451second # [ 9.556437] systemd[1]: Started Discard unused filesystem blocks once a week.1452second # [ 9.559921] systemd[1]: Started Daily Cleanup of Temporary Directories.1453second # [ 9.563848] systemd[1]: Reached target Timer Units.1454second # [ 9.568237] systemd[1]: Listening on D-Bus System Message Bus Socket.1455second # [ 9.570543] systemd[1]: Listening on Nix Daemon Socket.1456second # [ 9.571690] systemd[1]: Listening on Authorization Manager Agent Helper.1457second # [ 9.575924] systemd[1]: Listening on Hostname Service Socket.1458second # [ 9.578084] systemd[1]: Reached target Socket Units.1459second # [ 9.579756] systemd[1]: Starting D-Bus System Message Bus...1460second # [ 9.597112] systemd[1]: Finished Firewall.1461second # [ 9.598680] systemd[1]: Reached target Preparation for Network.1462second # [ 9.607544] systemd[1]: Starting Network Management...1463second # [ 9.776546] dbus-broker-launch[532]: Looking up NSS user entry for 'systemd-timesync'...1464second # [ 9.790677] dbus-broker-launch[532]: NSS returned no entry for 'systemd-timesync'1465second # [ 9.793872] dbus-broker-launch[532]: Invalid user-name in /nix/store/xqydlq0ffl2pc4g5c9sbgql9bacfzy50-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1466test # [ 9.784216] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1467test # [ 9.787319] systemd[1]: Finished Create SUID/SGID Wrappers.1468second # [ 9.836549] (udev-worker)[457]: Network interface NamePolicy= disabled on kernel command line.1469second # [ 9.857766] (udev-worker)[446]: Network interface NamePolicy= disabled on kernel command line.1470second # [ 9.864326] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/ymh91gdvr306kjzkdbl3hk635w870k65-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1471second # [ 9.867839] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/ymh91gdvr306kjzkdbl3hk635w870k65-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1472second # [ 9.877633] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/wrvznzg05dkx9ia8dwkg7f4i04nhv3v6-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1473second # [ 9.886056] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/wns3agiik86mwy41ad6z21sjzqgla78w-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1474second # [ 9.897278] cfg80211: Loading compiled-in X.509 certificates for regulatory database1475second # [ 9.893787] systemd[1]: Started D-Bus System Message Bus.1476test # [ 9.879696] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1477second # [ 9.936414] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1478second # [ 9.937010] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1479second # [ 9.945650] dbus-broker-launch[532]: Ready1480second # [ 9.949869] systemd[1]: Reached target Basic System.1481second # [ 9.956691] systemd[1]: Starting Network Manager Script Dispatcher Service...1482second # [ 9.964714] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1483second # [ 9.973855] systemd[1]: Starting Network Manager...1484test # [ 9.950822] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1485second # [ 10.013209] systemd-networkd[535]: /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.1486test # [ 9.985242] systemd[1]: Finished register-nix-paths.service.1487second # [ 10.023003] systemd-networkd[535]: /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.1488test # [ 9.987401] systemd[1]: Reached target System Initialization.1489test # [ 9.991271] systemd[1]: Started Discard unused filesystem blocks once a week.1490second # [ 10.030723] systemd-networkd[535]: lo: Link UP1491test # [ 9.993054] systemd[1]: Started Daily Cleanup of Temporary Directories.1492second # [ 10.033200] systemd-networkd[535]: lo: Gained carrier1493second # [ 10.035040] systemd[1]: Started backdoor.service.1494test # [ 9.996439] systemd[1]: Reached target Timer Units.1495test # [ 9.999904] systemd[1]: Listening on D-Bus System Message Bus Socket.1496test # [ 10.002077] systemd[1]: Listening on Nix Daemon Socket.1497test # [ 10.006570] systemd[1]: Listening on Authorization Manager Agent Helper.1498second # [ 10.043422] systemd[1]: Starting Import lastlog data into lastlog2 database...1499test # [ 10.008763] systemd[1]: Listening on Hostname Service Socket.1500test # [ 10.010464] systemd[1]: Reached target Socket Units.1501test # [ 10.014585] systemd[1]: Starting D-Bus System Message Bus...1502second # [ 10.078053] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1503second # [ 10.089142] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1504test # [ 10.064500] systemd[1]: Finished Firewall.1505second # [ 10.099000] systemd-networkd[535]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1506test # [ 10.068494] systemd[1]: Reached target Preparation for Network.1507second # [ 10.107596] systemd-networkd[535]: eth1: Link UP1508test # [ 10.074969] systemd[1]: Starting Network Management...1509second # [ 10.114113] systemd-networkd[535]: eth1: Gained carrier1510second # [ 10.116324] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1511second # [ 10.148950] systemd[1]: Starting Post-Boot Actions...1512second # [ 10.164669] izfdm2vcilqki06lkkfdqg1q1s7gnwp8-wifi-secrets[546]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1513second # [ 10.185087] systemd[1]: Started Reset console on configuration changes.1514test # [ 10.191440] dbus-broker-launch[549]: Looking up NSS user entry for 'systemd-timesync'...1515second # [ 10.239904] systemd[1]: Started Network Management.1516test # [ 10.209415] dbus-broker-launch[549]: NSS returned no entry for 'systemd-timesync'1517second # [ 10.250255] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1518test # [ 10.211503] dbus-broker-launch[549]: Invalid user-name in /nix/store/xqydlq0ffl2pc4g5c9sbgql9bacfzy50-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1519second # [ 10.265262] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1520second # connecting to host...1521test # [ 10.262556] dbus-broker-launch[549]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/ymh91gdvr306kjzkdbl3hk635w870k65-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1522test # [ 10.269185] dbus-broker-launch[549]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/ymh91gdvr306kjzkdbl3hk635w870k65-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1523test # [ 10.276611] dbus-broker-launch[549]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/wrvznzg05dkx9ia8dwkg7f4i04nhv3v6-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1524test # [ 10.285978] dbus-broker-launch[549]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/wns3agiik86mwy41ad6z21sjzqgla78w-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1525second # [ 10.332289] systemd[1]: Finished Post-Boot Actions.1526test # [ 10.295492] systemd[1]: Started D-Bus System Message Bus.1527test # [ 10.324393] (udev-worker)[471]: Network interface NamePolicy= disabled on kernel command line.1528second # [ 10.365672] systemd[1]: Started Name Service Cache Daemon (nsncd).1529second # [ 10.371630] nsncd[550]: Sep 11 20:08:22.148 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1530second # [ 10.382141] systemd[1]: Reached target Host and Network Name Lookups.1531test # [ 10.351797] cfg80211: Loading compiled-in X.509 certificates for regulatory database1532second # [ 10.386689] systemd[1]: Reached target User and Group Name Lookups.1533test # [ 10.356986] dbus-broker-launch[549]: Ready1534test # [ 10.361843] systemd[1]: Reached target Basic System.1535test # [ 10.364579] (udev-worker)[475]: Network interface NamePolicy= disabled on kernel command line.1536second # [ 10.404642] systemd[1]: Starting User Login Management...1537test # [ 10.368353] systemd[1]: Starting Network Manager Script Dispatcher Service...1538second # [ 10.411544] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1539test # [ 10.374688] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1540second # [ 10.430344] systemd[1]: Finished Import lastlog data into lastlog2 database.1541test # [ 10.403670] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1542test # [ 10.404205] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1543test # [ 10.394620] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1544second # [ 10.435686] systemd[1]: Started Network Manager Script Dispatcher Service.1545test # [ 10.433350] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1546second # [ 10.497458] mousedev: PS/2 mouse device common for all mice1547test # [ 10.470201] systemd[1]: Starting Network Manager...1548test # [ 10.490198] systemd-networkd[555]: /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.1549test # [ 10.502313] systemd-networkd[555]: /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.1550second # [ 10.542863] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1551second # [ 10.548755] systemd[1]: Starting Hostname Service...1552test # [ 10.518949] systemd-networkd[555]: lo: Link UP1553test # [ 10.521028] systemd-networkd[555]: lo: Gained carrier1554test # [ 10.525987] systemd[1]: Started backdoor.service.1555test # [ 10.554060] systemd[1]: Starting Import lastlog data into lastlog2 database...1556test # [ 10.558479] izfdm2vcilqki06lkkfdqg1q1s7gnwp8-wifi-secrets[563]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1557second # [ 10.602465] systemd-logind[580]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1558test # [ 10.569163] ispsphlnyb2js715g0mg6bn3157dmskk-wifi-secrets[565]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1559second # [ 10.604542] systemd-logind[580]: Watching system buttons on /dev/input/event0 (gpio-keys)1560second # [ 10.614285] systemd-logind[580]: New seat seat0.1561second # [ 10.614729] systemd[1]: Started User Login Management.1562second # [ 10.620721] systemd[1]: Starting linger-users.service...1563test # [ 10.596209] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1564test # [ 10.611423] vz5k34ilhns09vh81dvgw89nvkf1plwv-wifi-secrets[568]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1565test # [ 10.630335] systemd[1]: Starting Post-Boot Actions...1566second # [ 10.707131] systemd[1]: linger-users.service: Deactivated successfully.1567test # [ 10.668945] systemd[1]: Started Reset console on configuration changes.1568second # [ 10.708712] systemd[1]: Finished linger-users.service.1569second # [ 10.712570] systemd[1]: Started Hostname Service.1570test # [ 10.708754] systemd[1]: Started Network Management.1571test # [ 10.735940] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1572test # [ 10.755621] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1573test # connecting to host...1574test # [ 10.764945] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1575test # [ 10.770776] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1576test # [ 10.771570] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1577test # [ 10.785174] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1578second # [ 10.827345] systemd-networkd[535]: eth0: Link UP1579second # [ 10.827876] systemd-networkd[535]: eth0: Gained carrier1580test # [ 10.801217] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1581second # [ 10.851997] systemd[1]: Started Network Manager.1582second # [ 10.853898] systemd[1]: Reached target Network.1583test # [ 10.814091] systemd-networkd[555]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1584second # [ 10.860250] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1585test # [ 10.823052] systemd-networkd[555]: eth1: Link UP1586test # [ 10.825173] systemd-networkd[555]: eth1: Gained carrier1587test # [ 10.825656] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1588second # [ 10.869742] systemd[1]: Starting Permit User Sessions...1589test: Guest shell says: b'Spawning backdoor root shell...\n'1590test: connected to guest root shell1591test: (connecting took 11.17 seconds)1592test: (finished: waiting for the VM to finish booting, in 11.17 seconds)1593test # [ 10.866131] systemd[1]: Finished Post-Boot Actions.1594test # [ 10.889099] systemd[1]: Started Network Manager Script Dispatcher Service.1595test # [ 10.896550] nsncd[577]: Sep 11 20:08:22.686 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1596test # [ 10.905391] systemd[1]: Started Name Service Cache Daemon (nsncd).1597test # [ 10.914940] systemd[1]: Reached target Host and Network Name Lookups.1598test # [ 10.915580] systemd[1]: Reached target User and Group Name Lookups.1599test # [ 10.929672] systemd[1]: Starting User Login Management...1600test # [ 10.941964] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1601test # [ 10.955858] systemd[1]: Finished Import lastlog data into lastlog2 database.1602test # [ 10.991854] systemd[1]: Starting Hostname Service...1603second # [ 11.040788] systemd[1]: Finished Permit User Sessions.1604second # [ 11.054448] systemd[1]: Started Getty on tty1.1605second # [ 11.057398] systemd[1]: Reached target Login Prompts.1606test # [ 11.064905] mousedev: PS/2 mouse device common for all mice1607second # [ 11.096779] systemd-resolved[334]: eth0: Bus client set default route setting: yes1608second # [ 11.101441] systemd-resolved[334]: eth0: Bus client set DNS server list to: 10.0.2.31609second # [ 11.182812] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1610second # [ 11.185639] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1611test # [ 11.173397] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1612test # [ 11.178076] systemd-logind[619]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1613test # [ 11.188215] systemd-logind[619]: Watching system buttons on /dev/input/event0 (gpio-keys)1614test # [ 11.188934] systemd-logind[619]: New seat seat0.1615test # [ 11.189343] systemd[1]: Started User Login Management.1616test # [ 11.193999] systemd[1]: Starting linger-users.service...1617test # [ 11.194686] systemd[1]: Started Hostname Service.1618test # [ 11.262868] systemd[1]: linger-users.service: Deactivated successfully.1619test # [ 11.265098] systemd[1]: Finished linger-users.service.1620test # [ 11.318550] systemd-networkd[555]: eth0: Link UP1621test # [ 11.319095] systemd-networkd[555]: eth0: Gained carrier1622second # [ 11.379946] systemd[1]: Reached target Multi-User System.1623test # [ 11.341871] systemd[1]: Started Network Manager.1624test # [ 11.343676] systemd[1]: Reached target Network.1625second # [ 11.386334] systemd[1]: Startup finished in 768ms (kernel) + 4.354s (initrd) + 6.258s (userspace) = 11.381s.1626test # [ 11.351678] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1627test # [ 11.356204] systemd[1]: Starting Permit User Sessions...1628test # [ 11.511112] systemd[1]: Finished Permit User Sessions.1629test # [ 11.526780] systemd[1]: Started Getty on tty1.1630test # [ 11.529107] systemd[1]: Reached target Login Prompts.1631second # [ 11.586867] systemd-networkd[535]: eth1: Gained IPv6LL1632test # [ 11.553740] systemd-resolved[350]: eth0: Bus client set default route setting: yes1633test # [ 11.558667] systemd-resolved[350]: eth0: Bus client set DNS server list to: 10.0.2.31634test # [ 11.570739] NetworkManager[569]: <warn> [1789157303.3618] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1635test # [ 11.573238] NetworkManager[569]: <warn> [1789157303.3634] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1636test # [ 11.638745] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1637test # [ 11.643387] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1638test # [ 11.765293] systemd[1]: Reached target Multi-User System.1639test # [ 11.767507] systemd[1]: Startup finished in 767ms (kernel) + 4.616s (initrd) + 6.383s (userspace) = 11.767s.1640second # [ 11.880125] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31641second # [ 12.168178] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1642second # [ 12.217981] systemd[1]: Starting Virtual Console Setup...1643test: (finished: waiting for unit NetworkManager.service, in 12.47 seconds)1644test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1645second # [ 12.230987] systemd-logind[580]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1646second # [ 12.242243] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1647second # [ 12.244102] systemd[1]: Stopped Virtual Console Setup.1648second # [ 12.247512] systemd[1]: Starting Virtual Console Setup...1649test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.05 seconds)1650test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1651test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds)1652test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1653test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1654(finished: run the VM test script, in 13.09 seconds)1655test # [ 12.321351] systemd-networkd[555]: eth1: Gained IPv6LL1656second # [ 12.386019] systemd-networkd[535]: eth0: Gained IPv6LL1657test script finished in 13.15s1658cleanup1659kill QemuMachine (pid 14)1660second # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/akbq19lqha5w5h9hcchn309znqm94pq0-python3-3.13.15/bin/python3.13)1661kill QemuMachine (pid 15)1662test # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/akbq19lqha5w5h9hcchn309znqm94pq0-python3-3.13.15/bin/python3.13)1663(finished: cleanup, in 0.21 seconds)