vm-test-run-wifi
checks.aarch64-linux.wifi
· build #812
· raw
1build01: building ri64pss2lm70ka5pgv3x9g5i28ghb10d-vm-test-run-wifi.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7additionally exposed symbols:8 second, test,9 vlan1,10 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh11start all VMs12second: starting vm13test: starting vm14second # Disk image does not exist, creating the virtualisation disk image...15second: QEMU running (pid 14)16second # Formatting '/build/vm-state-second/tmp.8Jo64gaW84', fmt=raw size=107374182417test: QEMU running (pid 15)18second # mke2fs 1.47.4 (6-Mar-2025)19test # Disk image does not exist, creating the virtualisation disk image...20second # Discarding device blocks: 0/262144 done21test # Formatting '/build/vm-state-test/tmp.YZJWN8zvtG', fmt=raw size=107374182422second # Creating filesystem with 262144 4k blocks and 65536 inodes23test # mke2fs 1.47.4 (6-Mar-2025)24second # Filesystem UUID: 31875a8d-42c9-4c2c-b02f-645307be074d25test # Discarding device blocks: 0/262144 done26second # Superblock backups stored on blocks:27test # Creating filesystem with 262144 4k blocks and 65536 inodes28second # 32768, 98304, 163840, 22937629test # Filesystem UUID: b48464e5-db7f-41e5-8d50-b657cb09b49430second # 31test # Superblock backups stored on blocks:32second # Allocating group tables: 0/8 done33test # 32768, 98304, 163840, 22937634second # Writing inode tables: 0/8 done35test # 36second # Creating journal (8192 blocks): done37test # Allocating group tables: 0/8 done38second # Writing superblocks and filesystem accounting information: 0/8 done39test # Writing inode tables: 0/8 done40second # 41test # Creating journal (8192 blocks): done42second # Virtualisation disk image created.43test # Writing superblocks and filesystem accounting information: 0/8 done44(finished: start all VMs, in 0.61 seconds)45test # 46test: waiting for unit NetworkManager.service47test # Virtualisation disk image created.48test: waiting for the VM to finish booting49second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]50second # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 202651second # [ 0.000000] KASLR enabled52second # [ 0.000000] random: crng init done53second # [ 0.000000] Machine model: linux,dummy-virt54second # [ 0.000000] efi: UEFI not found.55second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT56second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]57second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]58second # [ 0.000000] Zone ranges:59second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]60second # [ 0.000000] DMA32 empty61second # [ 0.000000] Normal empty62second # [ 0.000000] Device empty63second # [ 0.000000] Movable zone start for each node64second # [ 0.000000] Early memory node ranges65second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]66second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]67second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000068second # [ 0.000000] psci: probing for conduit method from DT.69second # [ 0.000000] psci: PSCIv1.3 detected in firmware.70second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs71second # [ 0.000000] psci: Trusted OS migration not required72second # [ 0.000000] psci: SMC Calling Convention v1.173second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)74second # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u31129675second # [ 0.000000] Detected PIPT I-cache on CPU076second # [ 0.000000] CPU features: detected: GICv3 CPU interface77second # [ 0.000000] CPU features: detected: Spectre-v478second # [ 0.000000] CPU features: detected: Spectre-BHB79second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR80second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)81second # [ 0.000000] CPU features: detected: ARM erratum 141804082second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion83second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing84second # [ 0.000000] alternatives: applying boot alternatives85second # [ 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/s614ay0b3m9f2hds0vf6jxk9bx9j93nz-nixos-system-second-test/init regInfo=/nix/store/kxrnvzrjbm9l06p8zjza49zl975fwd64-closure-info/registration console=ttyAMA0,115200n8 console=tty086second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/kxrnvzrjbm9l06p8zjza49zl975fwd64-closure-info/registration", will be passed to user space.87second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes88second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)89second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)90second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB91second # [ 0.000000] software IO TLB: area num 1.92second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)93second # [ 0.000000] Fallback order for Node 0: 094second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214495second # [ 0.000000] Policy zone: DMA96second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off97second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=198second # [ 0.000000] allocated 2097152 bytes of page_ext99second # [ 0.000000] ftrace: allocating 74832 entries in 294 pages100second # [ 0.000000] ftrace: allocated 294 pages with 4 groups101second # [ 0.000000] rcu: Hierarchical RCU implementation.102second # [ 0.000000] rcu: RCU event tracing is enabled.103second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.104second # [ 0.000000] Trampoline variant of Tasks RCU enabled.105second # [ 0.000000] Rude variant of Tasks RCU enabled.106second # [ 0.000000] Tracing variant of Tasks RCU enabled.107second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.108second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1109second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.110second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.111second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.112second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0113second # [ 0.000000] GICv3: 256 SPIs implemented114second # [ 0.000000] GICv3: 0 Extended SPIs implemented115second # [ 0.000000] Root IRQ handler: gic_handle_irq116second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI117second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0118second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000119second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]120second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)121second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)122second # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000123second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000124second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.125second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns126second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040127second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).128second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns129second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns130second # [ 0.000058] arm-pv: using stolen time PV131second # [ 0.000331] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)132second # [ 0.000594] Console: colour dummy device 80x25133second # [ 0.000606] printk: legacy console [tty0] enabled134second # [ 0.000815] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)135second # [ 0.000820] pid_max: default: 32768 minimum: 301136second # [ 0.000896] LSM: initializing lsm=capability,landlock,yama,bpf,ima137second # [ 0.001044] landlock: Up and running.138second # [ 0.001046] Yama: becoming mindful.139second # [ 0.001383] LSM support for eBPF active140second # [ 0.001526] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)141second # [ 0.001544] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)142second # [ 0.004128] rcu: Hierarchical SRCU implementation.143second # [ 0.004133] rcu: Max phase no-delay instances is 1000.144second # [ 0.005058] fsl-mc MSI: its@8080000 domain created145second # [ 0.005239] EFI services will not be available.146second # [ 0.005320] smp: Bringing up secondary CPUs ...147second # [ 0.005351] smp: Brought up 1 node, 1 CPU148second # [ 0.005354] SMP: Total of 1 processors activated.149second # [ 0.005356] CPU: All CPU(s) started at EL1150second # [ 0.005367] CPU features: detected: 32-bit EL0 Support151second # [ 0.005370] CPU features: detected: Data cache clean to the PoU not required for I/D coherence152second # [ 0.005373] CPU features: detected: Common not Private translations153second # [ 0.005375] CPU features: detected: CRC32 instructions154second # [ 0.005377] CPU features: detected: Data cache clean to Point of Persistence155second # [ 0.005380] CPU features: detected: Enhanced Virtualization Traps156second # [ 0.005390] CPU features: detected: RCpc load-acquire (LDAPR)157second # [ 0.005392] CPU features: detected: LSE atomic instructions158second # [ 0.005394] CPU features: detected: Privileged Access Never159second # [ 0.005396] CPU features: detected: PMUv3160second # [ 0.005398] CPU features: detected: RAS Extension Support161second # [ 0.005402] CPU features: detected: Speculative Store Bypassing Safe (SSBS)162second # [ 0.005420] alternatives: applying system-wide alternatives163second # [ 0.006868] CPU features: detected: Hardware dirty bit management on CPU0164test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]165second # [ 0.007039] Memory: 892916K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114364K reserved, 32768K cma-reserved)166second # [ 0.007468] devtmpfs: initialized167second # [ 0.008883] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)168second # [ 0.008904] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).169test # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026170test # [ 0.000000] KASLR enabled171test # [ 0.000000] random: crng init done172test # [ 0.000000] Machine model: linux,dummy-virt173test # [ 0.000000] efi: UEFI not found.174test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT175second # [ 0.009048] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL176test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]177second # [ 0.009052] 0 pages in range for non-PLT usage178second # [ 0.009053] 508272 pages in range for PLT usage179second # [ 0.009154] pinctrl core: initialized pinctrl subsystem180second # [ 0.009970] DMI not present or invalid.181second # [ 0.013138] NET: Registered PF_NETLINK/PF_ROUTE protocol family182second # [ 0.015490] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations183second # [ 0.015637] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations184test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]185test # [ 0.000000] Zone ranges:186second # [ 0.015806] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations187test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]188test # [ 0.000000] DMA32 empty189test # [ 0.000000] Normal empty190test # [ 0.000000] Device empty191test # [ 0.000000] Movable zone start for each node192test # [ 0.000000] Early memory node ranges193test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]194test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]195second # [ 0.015828] audit: initializing netlink subsys (disabled)196test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000197second # [ 0.016110] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1198second # [ 0.016446] thermal_sys: Registered thermal governor 'fair_share'199test # [ 0.000000] psci: probing for conduit method from DT.200test # [ 0.000000] psci: PSCIv1.3 detected in firmware.201test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs202test # [ 0.000000] psci: Trusted OS migration not required203second # [ 0.016448] thermal_sys: Registered thermal governor 'bang_bang'204test # [ 0.000000] psci: SMC Calling Convention v1.1205second # [ 0.016450] thermal_sys: Registered thermal governor 'step_wise'206test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)207second # [ 0.016452] thermal_sys: Registered thermal governor 'user_space'208test # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u311296209second # [ 0.016454] thermal_sys: Registered thermal governor 'power_allocator'210test # [ 0.000000] Detected PIPT I-cache on CPU0211second # [ 0.016483] cpuidle: using governor ladder212test # [ 0.000000] CPU features: detected: GICv3 CPU interface213second # [ 0.016488] cpuidle: using governor menu214test # [ 0.000000] CPU features: detected: Spectre-v4215test # [ 0.000000] CPU features: detected: Spectre-BHB216second # [ 0.016594] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.217second # [ 0.016615] ASID allocator initialised with 32768 entries218test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR219second # [ 0.017252] Serial: AMBA PL011 UART driver220test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)221test # [ 0.000000] CPU features: detected: ARM erratum 1418040222second # [ 0.020865] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1223second # [ 0.021035] printk: console [ttyAMA0] enabled224test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion225test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing226test # [ 0.000000] alternatives: applying boot alternatives227test # [ 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/vfs9dmici0qj2ixr6gsxb1n9p1z1d6yj-nixos-system-test-test/init regInfo=/nix/store/dg0ls64gm8dyi4r0vfq08piwaixby15a-closure-info/registration console=ttyAMA0,115200n8 console=tty0228test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/dg0ls64gm8dyi4r0vfq08piwaixby15a-closure-info/registration", will be passed to user space.229test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes230test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)231test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)232test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB233test # [ 0.000000] software IO TLB: area num 1.234test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)235test # [ 0.000000] Fallback order for Node 0: 0236test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144237test # [ 0.000000] Policy zone: DMA238test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off239test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1240test # [ 0.000000] allocated 2097152 bytes of page_ext241second # [ 0.094236] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages242test # [ 0.000000] ftrace: allocating 74832 entries in 294 pages243second # [ 0.094250] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page244test # [ 0.000000] ftrace: allocated 294 pages with 4 groups245test # [ 0.000000] rcu: Hierarchical RCU implementation.246second # [ 0.094253] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages247test # [ 0.000000] rcu: RCU event tracing is enabled.248second # [ 0.094257] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page249test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.250second # [ 0.094259] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages251test # [ 0.000000] Trampoline variant of Tasks RCU enabled.252second # [ 0.094261] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page253test # [ 0.000000] Rude variant of Tasks RCU enabled.254second # [ 0.094263] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages255test # [ 0.000000] Tracing variant of Tasks RCU enabled.256second # [ 0.094265] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page257test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.258second # [ 0.095232] fbcon: Taking over console259second # [ 0.095241] ACPI: Interpreter disabled.260test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1261second # [ 0.095875] iommu: Default domain type: Translated262test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.263second # [ 0.095879] iommu: DMA domain TLB invalidation policy: strict mode264second # [ 0.096162] SCSI subsystem initialized265test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.266second # [ 0.098097] usbcore: registered new interface driver usbfs267second # [ 0.098125] usbcore: registered new interface driver hub268test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.269second # [ 0.098139] usbcore: registered new device driver usb270test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0271second # [ 0.098347] pps_core: LinuxPPS API ver. 1 registered272test # [ 0.000000] GICv3: 256 SPIs implemented273test # [ 0.000000] GICv3: 0 Extended SPIs implemented274test # [ 0.000000] Root IRQ handler: gic_handle_irq275second # [ 0.098350] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>276test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI277second # [ 0.098355] PTP clock support registered278second # [ 0.098381] EDAC MC: Ver: 3.0.0279test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0280test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000281test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]282test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)283test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)284test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000285test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000286second # [ 0.107275] scmi_core: SCMI protocol bus registered287test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.288second # [ 0.107597] FPGA manager framework289second # [ 0.110667] vgaarb: loaded290test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns291test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040292test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).293test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns294test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns295test # [ 0.000055] arm-pv: using stolen time PV296second # [ 0.111752] clocksource: Switched to clocksource arch_sys_counter297test # [ 0.000316] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)298test # [ 0.000555] Console: colour dummy device 80x25299test # [ 0.000566] printk: legacy console [tty0] enabled300test # [ 0.000766] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)301test # [ 0.000771] pid_max: default: 32768 minimum: 301302test # [ 0.000845] LSM: initializing lsm=capability,landlock,yama,bpf,ima303test # [ 0.000957] landlock: Up and running.304test # [ 0.000959] Yama: becoming mindful.305test # [ 0.001271] LSM support for eBPF active306test # [ 0.001422] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)307test # [ 0.001442] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)308test # [ 0.003807] rcu: Hierarchical SRCU implementation.309test # [ 0.003812] rcu: Max phase no-delay instances is 1000.310test # [ 0.004848] fsl-mc MSI: its@8080000 domain created311test # [ 0.005031] EFI services will not be available.312test # [ 0.005116] smp: Bringing up secondary CPUs ...313test # [ 0.005146] smp: Brought up 1 node, 1 CPU314test # [ 0.005149] SMP: Total of 1 processors activated.315test # [ 0.005151] CPU: All CPU(s) started at EL1316test # [ 0.005161] CPU features: detected: 32-bit EL0 Support317second # [ 0.121901] VFS: Disk quotas dquot_6.6.0318test # [ 0.005164] CPU features: detected: Data cache clean to the PoU not required for I/D coherence319test # [ 0.005167] CPU features: detected: Common not Private translations320test # [ 0.005169] CPU features: detected: CRC32 instructions321second # [ 0.121934] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)322second # [ 0.123371] netfs: FS-Cache loaded323second # [ 0.123484] pnp: PnP ACPI: disabled324test # [ 0.005171] CPU features: detected: Data cache clean to Point of Persistence325test # [ 0.005173] CPU features: detected: Enhanced Virtualization Traps326test # [ 0.005183] CPU features: detected: RCpc load-acquire (LDAPR)327test # [ 0.005185] CPU features: detected: LSE atomic instructions328test # [ 0.005187] CPU features: detected: Privileged Access Never329test # [ 0.005189] CPU features: detected: PMUv3330test # [ 0.005191] CPU features: detected: RAS Extension Support331second # [ 0.126720] NET: Registered PF_INET protocol family332test # [ 0.005195] CPU features: detected: Speculative Store Bypassing Safe (SSBS)333second # [ 0.126912] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)334test # [ 0.005215] alternatives: applying system-wide alternatives335test # [ 0.006611] CPU features: detected: Hardware dirty bit management on CPU0336test # [ 0.006820] Memory: 892892K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114368K reserved, 32768K cma-reserved)337test # [ 0.007251] devtmpfs: initialized338test # [ 0.008640] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)339test # [ 0.008662] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).340test # [ 0.008804] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL341test # [ 0.008807] 0 pages in range for non-PLT usage342test # [ 0.008808] 508272 pages in range for PLT usage343test # [ 0.008922] pinctrl core: initialized pinctrl subsystem344test # [ 0.009677] DMI not present or invalid.345test # [ 0.012895] NET: Registered PF_NETLINK/PF_ROUTE protocol family346test # [ 0.015363] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations347test # [ 0.015514] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations348test # [ 0.015684] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations349test # [ 0.015707] audit: initializing netlink subsys (disabled)350test # [ 0.016098] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1351test # [ 0.016384] thermal_sys: Registered thermal governor 'fair_share'352test # [ 0.016386] thermal_sys: Registered thermal governor 'bang_bang'353test # [ 0.016389] thermal_sys: Registered thermal governor 'step_wise'354test # [ 0.016391] thermal_sys: Registered thermal governor 'user_space'355test # [ 0.016393] thermal_sys: Registered thermal governor 'power_allocator'356test # [ 0.016421] cpuidle: using governor ladder357test # [ 0.016426] cpuidle: using governor menu358test # [ 0.016570] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.359test # [ 0.016592] ASID allocator initialised with 32768 entries360test # [ 0.017226] Serial: AMBA PL011 UART driver361test # [ 0.020587] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1362test # [ 0.020751] printk: console [ttyAMA0] enabled363second # [ 0.151130] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)364test # [ 0.093362] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages365second # [ 0.151153] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)366test # [ 0.093376] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page367second # [ 0.151164] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)368test # [ 0.093379] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages369second # [ 0.151198] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370test # [ 0.093383] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page371second # [ 0.151265] TCP: Hash tables configured (established 8192 bind 8192)372test # [ 0.093385] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages373second # [ 0.151348] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)374test # [ 0.093387] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page375second # [ 0.151373] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)376test # [ 0.093389] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages377second # [ 0.151427] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)378test # [ 0.093391] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page379test # [ 0.094342] fbcon: Taking over console380test # [ 0.094353] ACPI: Interpreter disabled.381test # [ 0.095011] iommu: Default domain type: Translated382test # [ 0.095015] iommu: DMA domain TLB invalidation policy: strict mode383test # [ 0.095311] SCSI subsystem initialized384test # [ 0.097220] usbcore: registered new interface driver usbfs385test # [ 0.097251] usbcore: registered new interface driver hub386test # [ 0.097265] usbcore: registered new device driver usb387test # [ 0.097480] pps_core: LinuxPPS API ver. 1 registered388test # [ 0.097484] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>389test # [ 0.097488] PTP clock support registered390test # [ 0.097518] EDAC MC: Ver: 3.0.0391test # [ 0.106570] scmi_core: SCMI protocol bus registered392test # [ 0.106938] FPGA manager framework393second # [ 0.156550] NET: Registered PF_UNIX/PF_LOCAL protocol family394second # [ 0.156593] NET: Registered PF_XDP protocol family395test # [ 0.110525] vgaarb: loaded396second # [ 0.156615] PCI: CLS 0 bytes, default 64397test # [ 0.110789] clocksource: Switched to clocksource arch_sys_counter398second # [ 0.156839] Trying to unpack rootfs image as initramfs...399second # [ 0.160094] kvm [1]: HYP mode not available400test # [ 0.121442] VFS: Disk quotas dquot_6.6.0401test # [ 0.121469] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)402test # [ 0.122963] netfs: FS-Cache loaded403test # [ 0.123086] pnp: PnP ACPI: disabled404test # [ 0.126404] NET: Registered PF_INET protocol family405test # [ 0.126584] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)406test # [ 0.151341] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)407test # [ 0.151364] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)408test # [ 0.151377] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.151416] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.151483] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.151601] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.151655] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.151704] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.151827] NET: Registered PF_UNIX/PF_LOCAL protocol family415test # [ 0.151871] NET: Registered PF_XDP protocol family416test # [ 0.151892] PCI: CLS 0 bytes, default 64417test # [ 0.152233] Trying to unpack rootfs image as initramfs...418test # [ 0.155067] kvm [1]: HYP mode not available419second # [ 0.224200] Initialise system trusted keyrings420second # [ 0.224318] workingset: timestamp_bits=42 max_order=18 bucket_order=0421second # [ 0.224691] squashfs: version 4.0 (2009/01/31) Phillip Lougher422second # [ 0.229122] 9p: Installing v9fs 9p2000 file system support423second # [ 0.248436] Key type asymmetric registered424second # [ 0.248454] Asymmetric key parser 'x509' registered425second # [ 0.248515] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)426second # [ 0.253116] io scheduler mq-deadline registered427second # [ 0.253123] io scheduler kyber registered428second # [ 0.255648] pl061_gpio 9030000.pl061: PL061 GPIO chip registered429second # [ 0.257109] ledtrig-cpu: registered to indicate activity on CPUs430second # [ 0.257453] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:431second # [ 0.257469] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000432second # [ 0.257482] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000433second # [ 0.257487] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000434second # [ 0.257522] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits435second # [ 0.257542] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]436second # [ 0.257608] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00437second # [ 0.257624] pci_bus 0000:00: root bus resource [bus 00-ff]438second # [ 0.257627] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]439second # [ 0.257630] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]440second # [ 0.257632] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]441second # [ 0.257702] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint442second # [ 0.258141] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint443second # [ 0.258251] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]444second # [ 0.258260] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]445second # [ 0.258278] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]446second # [ 0.258287] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]447second # [ 0.258559] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint448second # [ 0.258677] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]449second # [ 0.258686] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]450second # [ 0.258704] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]451second # [ 0.258971] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint452second # [ 0.259078] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]453second # [ 0.259087] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]454second # [ 0.259105] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]455second # [ 0.259376] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint456second # [ 0.259482] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]457second # [ 0.259490] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]458second # [ 0.259508] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]459test # [ 0.232566] Initialise system trusted keyrings460second # [ 0.283826] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint461test # [ 0.232690] workingset: timestamp_bits=42 max_order=18 bucket_order=0462second # [ 0.283946] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]463test # [ 0.233093] squashfs: version 4.0 (2009/01/31) Phillip Lougher464second # [ 0.283955] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]465test # [ 0.233130] 9p: Installing v9fs 9p2000 file system support466second # [ 0.283974] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]467second # [ 0.284294] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint468second # [ 0.284401] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]469second # [ 0.284409] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]470second # [ 0.284427] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]471second # [ 0.284698] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint472second # [ 0.284808] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]473second # [ 0.284816] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]474second # [ 0.284834] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475second # [ 0.284846] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]476second # [ 0.285120] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint477second # [ 0.285230] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]478second # [ 0.285247] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]479second # [ 0.285512] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint480second # [ 0.285621] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]481second # [ 0.285639] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]482second # [ 0.285877] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint483second # [ 0.285982] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]484second # [ 0.286139] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint485second # [ 0.286352] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]486second # [ 0.286361] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]487second # [ 0.286379] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]488second # [ 0.286664] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint489second # [ 0.286772] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]490second # [ 0.286780] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]491second # [ 0.286797] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]492second # [ 0.287189] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned493second # [ 0.287195] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned494second # [ 0.287198] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned495second # [ 0.287229] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned496second # [ 0.287258] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned497second # [ 0.287286] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned498second # [ 0.287315] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned499second # [ 0.287344] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned500second # [ 0.287372] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned501test # [ 0.253663] Key type asymmetric registered502second # [ 0.287400] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned503test # [ 0.253683] Asymmetric key parser 'x509' registered504test # [ 0.253752] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)505second # [ 0.287429] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned506second # [ 0.287456] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned507second # [ 0.287526] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned508second # [ 0.287554] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned509second # [ 0.287567] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned510second # [ 0.287581] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned511test # [ 0.256093] io scheduler mq-deadline registered512second # [ 0.287593] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned513test # [ 0.256099] io scheduler kyber registered514second # [ 0.287605] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned515second # [ 0.287618] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned516second # [ 0.287630] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned517second # [ 0.287642] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned518second # [ 0.287655] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned519second # [ 0.287667] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned520second # [ 0.287679] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned521second # [ 0.287691] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned522second # [ 0.287704] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned523second # [ 0.287716] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned524second # [ 0.287728] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned525second # [ 0.287740] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned526second # [ 0.287771] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned527second # [ 0.287783] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned528second # [ 0.287795] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned529second # [ 0.287807] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned530second # [ 0.287819] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned531second # [ 0.287836] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]532second # [ 0.287840] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]533second # [ 0.287842] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]534second # [ 0.288501] pci 0000:00:0a.0: enabling device (0000 -> 0002)535test # [ 0.266920] pl061_gpio 9030000.pl061: PL061 GPIO chip registered536test # [ 0.267275] ledtrig-cpu: registered to indicate activity on CPUs537test # [ 0.267610] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:538test # [ 0.267628] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000539test # [ 0.267641] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000540test # [ 0.267645] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000541test # [ 0.267671] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits542test # [ 0.267691] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]543test # [ 0.267787] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00544test # [ 0.267804] pci_bus 0000:00: root bus resource [bus 00-ff]545test # [ 0.267807] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]546test # [ 0.267810] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]547test # [ 0.267812] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]548test # [ 0.267912] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint549test # [ 0.268348] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint550test # [ 0.268462] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]551test # [ 0.268471] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]552test # [ 0.268489] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]553test # [ 0.268498] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]554test # [ 0.268776] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555test # [ 0.268886] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]556test # [ 0.268895] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]557test # [ 0.268913] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]558test # [ 0.269184] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint559test # [ 0.269293] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]560test # [ 0.269302] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]561test # [ 0.269320] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]562test # [ 0.269587] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint563test # [ 0.269693] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]564test # [ 0.269701] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]565second # [ 0.337423] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)566test # [ 0.269718] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]567second # [ 0.339474] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)568test # [ 0.269991] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint569test # [ 0.270096] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]570test # [ 0.270105] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]571test # [ 0.270122] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]572test # [ 0.270384] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint573test # [ 0.270491] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]574test # [ 0.270499] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]575test # [ 0.270517] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]576test # [ 0.270784] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint577test # [ 0.291520] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]578test # [ 0.291530] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]579test # [ 0.291548] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]580test # [ 0.291565] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]581test # [ 0.291952] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint582test # [ 0.292063] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]583test # [ 0.292079] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]584second # [ 0.349884] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)585test # [ 0.292343] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint586second # [ 0.351672] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)587test # [ 0.292452] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]588test # [ 0.292469] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]589test # [ 0.292710] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint590test # [ 0.292816] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]591test # [ 0.292980] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint592second # [ 0.354581] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)593test # [ 0.293437] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]594test # [ 0.293447] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]595test # [ 0.293464] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]596test # [ 0.293745] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint597test # [ 0.293853] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]598test # [ 0.293862] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]599test # [ 0.293879] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]600test # [ 0.294277] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned601test # [ 0.294283] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned602test # [ 0.294287] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned603test # [ 0.294318] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned604test # [ 0.294347] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned605test # [ 0.294376] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned606test # [ 0.294405] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned607test # [ 0.294434] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned608second # [ 0.361273] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)609test # [ 0.294463] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned610test # [ 0.294490] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned611test # [ 0.294519] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned612test # [ 0.294547] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned613test # [ 0.294619] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned614test # [ 0.294669] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned615test # [ 0.294681] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned616test # [ 0.294693] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned617test # [ 0.294705] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned618test # [ 0.294718] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned619test # [ 0.294730] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned620test # [ 0.294742] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned621test # [ 0.294754] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned622test # [ 0.294766] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned623test # [ 0.294778] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned624second # [ 0.368610] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)625second # [ 0.370615] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)626test # [ 0.322843] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned627test # [ 0.322865] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned628test # [ 0.322878] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned629test # [ 0.322891] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned630test # [ 0.322904] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned631second # [ 0.380173] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)632test # [ 0.322916] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned633test # [ 0.322933] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned634second # [ 0.382306] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)635test # [ 0.322946] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned636test # [ 0.322958] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned637test # [ 0.322971] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned638test # [ 0.322984] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned639test # [ 0.323004] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]640test # [ 0.323008] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]641test # [ 0.323011] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]642test # [ 0.323689] pci 0000:00:0a.0: enabling device (0000 -> 0002)643second # [ 0.392213] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)644second # [ 0.396134] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled645test # [ 0.342134] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)646second # [ 0.398112] msm_serial: driver initialized647second # [ 0.398202] SuperH (H)SCI(F) driver initialized648second # [ 0.398240] STM32 USART driver initialized649test # [ 0.344702] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)650test # [ 0.346557] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)651test # [ 0.355978] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)652test # [ 0.357938] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)653second # [ 0.419213] loop: module loaded654second # [ 0.419343] virtio_blk virtio5: 1/0/0 default/read/poll queues655test # [ 0.363728] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)656test # [ 0.365616] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)657second # [ 0.423946] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)658second # [ 0.428130] megasas: 07.734.00.00-rc1659second # [ 0.428582] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]660test # [ 0.375988] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)661test # [ 0.377651] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)662second # [ 0.433957] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000663second # [ 0.433978] Intel/Sharp Extended Query Table at 0x0031664second # [ 0.435595] Using buffer write method665second # [ 0.435636] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]666test # [ 0.387444] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)667test # [ 0.389570] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)668second # [ 0.445589] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000669second # [ 0.445601] Intel/Sharp Extended Query Table at 0x0031670second # [ 0.447297] Using buffer write method671second # [ 0.447309] Concatenating MTD devices:672second # [ 0.447311] (0): "0.flash"673second # [ 0.447313] (1): "0.flash"674second # [ 0.447314] into device "0.flash"675test # [ 0.399516] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled676test # [ 0.400537] msm_serial: driver initialized677test # [ 0.400622] SuperH (H)SCI(F) driver initialized678test # [ 0.400661] STM32 USART driver initialized679test # [ 0.424466] loop: module loaded680test # [ 0.424589] virtio_blk virtio5: 1/0/0 default/read/poll queues681test # [ 0.425207] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682test # [ 0.428596] megasas: 07.734.00.00-rc1683test # [ 0.429072] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]684test # [ 0.451990] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000685test # [ 0.452019] Intel/Sharp Extended Query Table at 0x0031686test # [ 0.453711] Using buffer write method687test # [ 0.453763] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]688test # [ 0.457750] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689test # [ 0.457762] Intel/Sharp Extended Query Table at 0x0031690test # [ 0.460636] Using buffer write method691test # [ 0.460647] Concatenating MTD devices:692test # [ 0.460649] (0): "0.flash"693test # [ 0.460651] (1): "0.flash"694test # [ 0.460653] into device "0.flash"695second # [ 0.645288] Freeing initrd memory: 25500K696second # [ 0.652133] tun: Universal TUN/TAP device driver, 1.6697second # [ 0.654292] thunder_xcv, ver 1.0698second # [ 0.654306] thunder_bgx, ver 1.0699second # [ 0.654315] nicpf, ver 1.0700second # [ 0.654605] e1000: Intel(R) PRO/1000 Network Driver701second # [ 0.654608] e1000: Copyright (c) 1999-2006 Intel Corporation.702second # [ 0.654620] e1000e: Intel(R) PRO/1000 Network Driver703second # [ 0.654638] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.704second # [ 0.654651] igb: Intel(R) Gigabit Ethernet Network Driver705second # [ 0.654653] igb: Copyright (c) 2007-2014 Intel Corporation.706second # [ 0.654662] igbvf: Intel(R) Gigabit Virtual Function Network Driver707second # [ 0.654665] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.708second # [ 0.654731] sky2: driver version 1.30709second # [ 0.655555] usbcore: registered new interface driver usb-storage710second # [ 0.661625] ehci-pci 0000:00:0a.0: EHCI Host Controller711second # [ 0.661649] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1712second # [ 0.661906] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000713second # [ 0.661986] usbcore: registered new interface driver usbserial_generic714second # [ 0.662007] usbserial: USB Serial support registered for generic715second # [ 0.662332] hv_vmbus: registering driver hyperv_keyboard716second # [ 0.662908] rtc-pl031 9010000.pl031: registered as rtc0717second # [ 0.662934] rtc-pl031 9010000.pl031: setting system clock to 2026-09-30T15:04:08 UTC (1790780648)718second # [ 0.663091] i2c_dev: i2c /dev entries driver719second # [ 0.668927] sdhci: Secure Digital Host Controller Interface driver720second # [ 0.668932] sdhci: Copyright(c) Pierre Ossman721second # [ 0.669076] Synopsys Designware Multimedia Card Interface Driver722second # [ 0.669248] sdhci-pltfm: SDHCI platform and OF driver helper723second # [ 0.670090] hid: raw HID events driver (C) Jiri Kosina724second # [ 0.670225] usbcore: registered new interface driver usbhid725second # [ 0.670227] usbhid: USB HID core driver726test # [ 0.652365] Freeing initrd memory: 25504K727second # [ 0.709582] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00728second # [ 0.709976] hub 1-0:1.0: USB hub found729second # [ 0.710006] hub 1-0:1.0: 6 ports detected730second # [ 0.710339] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available731second # [ 0.711194] drop_monitor: Initializing network drop monitor service732second # [ 0.711329] NET: Registered PF_INET6 protocol family733second # [ 0.714611] Segment Routing with IPv6734second # [ 0.714643] In-situ OAM (IOAM) with IPv6735second # [ 0.714689] NET: Registered PF_PACKET protocol family736second # [ 0.714808] 9pnet: Installing 9P2000 support737test # [ 0.659272] tun: Universal TUN/TAP device driver, 1.6738test # [ 0.661466] thunder_xcv, ver 1.0739test # [ 0.661481] thunder_bgx, ver 1.0740test # [ 0.661490] nicpf, ver 1.0741test # [ 0.661791] e1000: Intel(R) PRO/1000 Network Driver742test # [ 0.661794] e1000: Copyright (c) 1999-2006 Intel Corporation.743test # [ 0.661806] e1000e: Intel(R) PRO/1000 Network Driver744second # [ 0.717761] Key type dns_resolver registered745test # [ 0.661811] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.746test # [ 0.661822] igb: Intel(R) Gigabit Ethernet Network Driver747test # [ 0.661824] igb: Copyright (c) 2007-2014 Intel Corporation.748test # [ 0.661833] igbvf: Intel(R) Gigabit Virtual Function Network Driver749test # [ 0.661836] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.750test # [ 0.661899] sky2: driver version 1.30751test # [ 0.662783] usbcore: registered new interface driver usb-storage752second # [ 0.720944] registered taskstats version 1753second # [ 0.721082] Loading compiled-in X.509 certificates754test # [ 0.668693] ehci-pci 0000:00:0a.0: EHCI Host Controller755test # [ 0.668719] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1756test # [ 0.668893] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000757test # [ 0.669024] usbcore: registered new interface driver usbserial_generic758test # [ 0.669043] usbserial: USB Serial support registered for generic759second # [ 0.726331] Demotion targets for Node 0: null760test # [ 0.669378] hv_vmbus: registering driver hyperv_keyboard761second # [ 0.726397] Key type .fscrypt registered762test # [ 0.669934] rtc-pl031 9010000.pl031: registered as rtc0763second # [ 0.726400] Key type fscrypt-provisioning registered764test # [ 0.669962] rtc-pl031 9010000.pl031: setting system clock to 2026-09-30T15:04:08 UTC (1790780648)765second # [ 0.726496] ima: No TPM chip found, activating TPM-bypass!766test # [ 0.670120] i2c_dev: i2c /dev entries driver767second # [ 0.726506] ima: Allocated hash algorithm: sha1768second # [ 0.726554] ima: No architecture policies found769second # [ 0.727054] input: gpio-keys as /devices/platform/gpio-keys/input/input0770test # [ 0.676036] sdhci: Secure Digital Host Controller Interface driver771test # [ 0.676041] sdhci: Copyright(c) Pierre Ossman772test # [ 0.676197] Synopsys Designware Multimedia Card Interface Driver773test # [ 0.676375] sdhci-pltfm: SDHCI platform and OF driver helper774test # [ 0.677255] hid: raw HID events driver (C) Jiri Kosina775test # [ 0.677396] usbcore: registered new interface driver usbhid776test # [ 0.677398] usbhid: USB HID core driver777test # [ 0.678069] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available778test # [ 0.682108] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00779test # [ 0.682484] hub 1-0:1.0: USB hub found780test # [ 0.682508] hub 1-0:1.0: 6 ports detected781second # [ 0.739529] clk: Disabling unused clocks782second # [ 0.739540] PM: genpd: Disabling unused power domains783test # [ 0.684008] drop_monitor: Initializing network drop monitor service784test # [ 0.684180] NET: Registered PF_INET6 protocol family785test # [ 0.684837] Segment Routing with IPv6786test # [ 0.684868] In-situ OAM (IOAM) with IPv6787test # [ 0.684914] NET: Registered PF_PACKET protocol family788test # [ 0.685017] 9pnet: Installing 9P2000 support789test # [ 0.686676] Key type dns_resolver registered790second # [ 0.742665] Freeing unused kernel memory: 4736K791second # [ 0.742752] Run /init as init process792test # [ 0.692062] registered taskstats version 1793test # [ 0.692216] Loading compiled-in X.509 certificates794test # [ 0.697528] Demotion targets for Node 0: null795test # [ 0.697597] Key type .fscrypt registered796test # [ 0.697600] Key type fscrypt-provisioning registered797test # [ 0.697701] ima: No TPM chip found, activating TPM-bypass!798test # [ 0.697711] ima: Allocated hash algorithm: sha1799test # [ 0.697777] ima: No architecture policies found800test # [ 0.698288] input: gpio-keys as /devices/platform/gpio-keys/input/input0801second # [ 0.762018] systemd[1]: Successfully made /usr/ read-only.802test # [ 0.710892] clk: Disabling unused clocks803test # [ 0.710900] PM: genpd: Disabling unused power domains804test # [ 0.713282] Freeing unused kernel memory: 4736K805test # [ 0.713361] Run /init as init process806test # [ 0.733275] systemd[1]: Successfully made /usr/ read-only.807second # [ 0.959800] usb 1-1: new high-speed USB device number 2 using ehci-pci808test # [ 0.930839] usb 1-1: new high-speed USB device number 2 using ehci-pci809second # [ 1.096215] systemd[1]: systemd 260.4 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)810second # [ 1.096245] systemd[1]: Detected virtualization qemu.811second # [ 1.096284] systemd[1]: Detected architecture arm64.812second # [ 1.096293] systemd[1]: Running in initrd.813second # [ 1.097300] systemd[1]: Initializing machine ID from random generator.814second # [ 1.097566] systemd[1]: Hostname set to <second>.815second # [ 1.117123] 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/input1816test # [ 1.067511] systemd[1]: systemd 260.4 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)817test # [ 1.067543] systemd[1]: Detected virtualization qemu.818test # [ 1.067583] systemd[1]: Detected architecture arm64.819test # [ 1.067592] systemd[1]: Running in initrd.820test # [ 1.068750] systemd[1]: Initializing machine ID from random generator.821test # [ 1.069031] systemd[1]: Hostname set to <test>.822test # [ 1.090271] 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/input1823second # [ 1.203918] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0824second # [ 1.205825] systemd[1]: Queued start job for default target Initrd Default Target.825second # [ 1.213126] systemd[1]: Created slice Slice /system/modprobe.826second # [ 1.213278] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.827second # [ 1.213301] systemd[1]: Expecting device /dev/disk/by-label/nixos...828second # [ 1.213320] systemd[1]: Reached target Path Units.829second # [ 1.213333] systemd[1]: Reached target Slice Units.830second # [ 1.213345] systemd[1]: Reached target Swaps.831second # [ 1.213360] systemd[1]: Reached target Timer Units.832second # [ 1.213549] systemd[1]: Listening on D-Bus System Message Bus Socket.833second # [ 1.213673] systemd[1]: Listening on Journal Socket (/dev/log).834second # [ 1.213815] systemd[1]: Listening on Journal Sockets.835second # [ 1.213887] systemd[1]: Listening on udev Control Socket.836second # [ 1.213937] systemd[1]: Listening on udev Kernel Socket.837second # [ 1.213954] systemd[1]: Reached target Socket Units.838second # [ 1.214989] systemd[1]: Starting Create List of Static Device Nodes...839second # [ 1.229707] systemd[1]: Starting Load Kernel Module 9pnet_virtio...840second # [ 1.229760] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs841second # [ 1.230638] systemd[1]: Mounting Kernel Configuration File System...842test # [ 1.174976] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0843second # [ 1.243313] systemd[1]: Starting Journal Service...844test # [ 1.187463] systemd[1]: Queued start job for default target Initrd Default Target.845test # [ 1.196403] systemd[1]: Created slice Slice /system/modprobe.846test # [ 1.196572] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.847test # [ 1.196596] systemd[1]: Expecting device /dev/disk/by-label/nixos...848test # [ 1.196614] systemd[1]: Reached target Path Units.849second # [ 1.251909] systemd[1]: Starting Load Kernel Modules...850test # [ 1.196628] systemd[1]: Reached target Slice Units.851test # [ 1.196642] systemd[1]: Reached target Swaps.852second # [ 1.251954] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki853test # [ 1.196655] systemd[1]: Reached target Timer Units.854test # [ 1.196807] systemd[1]: Listening on D-Bus System Message Bus Socket.855test # [ 1.196941] systemd[1]: Listening on Journal Socket (/dev/log).856test # [ 1.197085] systemd[1]: Listening on Journal Sockets.857test # [ 1.197163] systemd[1]: Listening on udev Control Socket.858test # [ 1.197214] systemd[1]: Listening on udev Kernel Socket.859test # [ 1.197230] systemd[1]: Reached target Socket Units.860test # [ 1.198298] systemd[1]: Starting Create List of Static Device Nodes...861second # [ 1.260628] systemd[1]: Starting Coldplug All udev Devices...862test # [ 1.209037] systemd[1]: Starting Load Kernel Module 9pnet_virtio...863test # [ 1.209081] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs864second # [ 1.264434] systemd[1]: Finished Create List of Static Device Nodes.865second # [ 1.265194] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.866second # [ 1.265997] systemd[1]: Finished Load Kernel Module 9pnet_virtio.867test # [ 1.213647] systemd[1]: Mounting Kernel Configuration File System...868second # [ 1.276493] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...869second # [ 1.276648] systemd[1]: Mounted Kernel Configuration File System.870test # [ 1.224455] systemd[1]: Starting Journal Service...871test # [ 1.235108] systemd[1]: Starting Load Kernel Modules...872test # [ 1.235148] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki873test # [ 1.250900] systemd[1]: Starting Coldplug All udev Devices...874test # [ 1.254050] systemd[1]: Finished Create List of Static Device Nodes.875second # [ 1.312785] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.876test # [ 1.259570] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.877test # [ 1.260255] systemd[1]: Finished Load Kernel Module 9pnet_virtio.878test # [ 1.260483] systemd[1]: Mounted Kernel Configuration File System.879test # [ 1.264730] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...880second # [ 1.318910] systemd-journald[73]: Collecting audit messages is disabled.881second # [ 1.323775] usb 1-2: new high-speed USB device number 3 using ehci-pci882second # [ 1.327110] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev883second # [ 1.332240] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.884test # [ 1.280221] systemd-journald[73]: Collecting audit messages is disabled.885second # [ 1.336587] systemd[1]: Starting Create Static Device Nodes in /dev...886test # [ 1.293499] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.887second # [ 1.348968] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0888test # [ 1.296025] usb 1-2: new high-speed USB device number 3 using ehci-pci889second # [ 1.349165] [drm] features: -virgl +edid -resource_blob -host_visible890second # [ 1.349167] [drm] features: -context_init891second # [ 1.349622] [drm] number of scanouts: 1892second # [ 1.349631] [drm] number of cap sets: 0893second # [ 1.350609] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic894second # [ 1.350627] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0895test # [ 1.311479] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.896test # [ 1.312533] systemd[1]: Starting Create Static Device Nodes in /dev...897second # [ 1.376204] Console: switching to colour frame buffer device 160x50898test # [ 1.322962] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev899second # [ 1.383840] systemd[1]: Finished Create Static Device Nodes in /dev.900second # [ 1.384026] systemd[1]: Reached target Preparation for Local File Systems.901second # [ 1.384043] systemd[1]: Reached target Local File Systems.902second # [ 1.389563] systemd[1]: Starting Rule-based Manager for Device Events and Files...903test # [ 1.339529] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0904test # [ 1.339745] [drm] features: -virgl +edid -resource_blob -host_visible905test # [ 1.339747] [drm] features: -context_init906test # [ 1.340232] [drm] number of scanouts: 1907test # [ 1.340241] [drm] number of cap sets: 0908test # [ 1.340811] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic909test # [ 1.340817] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0910second # [ 1.400306] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device911second # [ 1.407430] systemd-modules-load[74]: Inserted module 'dm_mod'912second # [ 1.419978] systemd[1]: Started Journal Service.913test # [ 1.363678] Console: switching to colour frame buffer device 160x50914second # [ 1.416565] systemd-modules-load[74]: Module 'virtio_balloon' is built in915second # [ 1.417279] systemd-modules-load[74]: Module 'virtio_console' is built in916test # [ 1.369828] systemd[1]: Finished Create Static Device Nodes in /dev.917test # [ 1.369977] systemd[1]: Reached target Preparation for Local File Systems.918test # [ 1.369994] systemd[1]: Reached target Local File Systems.919second # [ 1.425205] systemd-modules-load[74]: Inserted module 'virtio_gpu'920second # [ 1.425882] systemd-modules-load[74]: Module 'virtio_rng' is built in921second # [ 1.426512] systemd[1]: Finished Load Kernel Modules.922test # [ 1.378568] systemd[1]: Starting Rule-based Manager for Device Events and Files...923test # [ 1.378690] systemd[1]: Started Journal Service.924test # [ 1.376218] systemd-modules-load[74]: Inserted module 'dm_mod'925test # [ 1.376993] systemd-modules-load[74]: Module 'virtio_balloon' is built in926test # [ 1.377737] systemd-modules-load[74]: Module 'virtio_console' is built in927second # [ 1.432220] systemd[1]: Starting Apply Kernel Variables...928second # [ 1.432811] systemd[1]: Starting Create System Files and Directories...929test # [ 1.390605] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device930second # [ 1.447501] systemd-udevd[81]: Using default interface naming scheme 'v260'.931test # [ 1.388731] systemd-modules-load[74]: Inserted module 'virtio_gpu'932test # [ 1.402319] systemd-modules-load[74]: Module 'virtio_rng' is built in933test # [ 1.404184] systemd[1]: Starting Create System Files and Directories...934test # [ 1.408146] systemd[1]: Finished Load Kernel Modules.935test # [ 1.412131] systemd[1]: Starting Apply Kernel Variables...936second # [ 1.466247] systemd[1]: Finished Create System Files and Directories.937second # [ 1.468566] systemd[1]: Finished Apply Kernel Variables.938second # [ 1.481182] 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/input2939second # [ 1.481348] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0940test # [ 1.428928] systemd[1]: Finished Create System Files and Directories.941second # [ 1.487969] systemd[1]: Started Rule-based Manager for Device Events and Files.942test # [ 1.443192] 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/input2943test # [ 1.443362] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0944test # [ 1.452491] systemd[1]: Finished Apply Kernel Variables.945test # [ 1.465216] systemd-udevd[80]: Using default interface naming scheme 'v260'.946test # [ 1.485019] systemd[1]: Started Rule-based Manager for Device Events and Files.947second # [ 1.544115] systemd[1]: Starting Virtual Console Setup...948test # [ 1.537507] systemd[1]: Starting Virtual Console Setup...949second # [ 1.593372] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.950second # [ 1.594354] systemd[1]: Finished Virtual Console Setup.951test # [ 1.588367] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.952test # [ 1.592405] systemd[1]: Finished Virtual Console Setup.953second # [ 1.849586] systemd[1]: Finished Coldplug All udev Devices.954second # [ 1.850171] systemd[1]: Reached target System Initialization.955second # [ 1.850629] systemd[1]: Reached target Basic System.956test # [ 1.852665] systemd[1]: Finished Coldplug All udev Devices.957test # [ 1.853313] systemd[1]: Reached target System Initialization.958test # [ 1.856148] systemd[1]: Reached target Basic System.959second # [ 1.962242] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.960second # [ 1.984953] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.961test # [ 1.954184] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.962second # [ 2.032338] systemd[1]: Found device /dev/disk/by-label/nixos.963second # [ 2.034300] systemd[1]: Reached target Initrd Root Device.964second # [ 2.035602] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...965test # [ 1.982206] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.966test # [ 2.014133] systemd[1]: Found device /dev/disk/by-label/nixos.967test # [ 2.014725] systemd[1]: Reached target Initrd Root Device.968test # [ 2.017989] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969second # [ 2.078764] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks970second # [ 2.105081] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.971test # [ 2.052091] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks972test # [ 2.063741] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.973second # [ 2.256521] systemd[1]: Mounting /sysroot...974second # [ 2.288977] EXT4-fs (vda): mounted filesystem 31875a8d-42c9-4c2c-b02f-645307be074d r/w with ordered data mode. Quota mode: none.975second # [ 2.284996] systemd[1]: Mounted /sysroot.976second # [ 2.285464] systemd[1]: Reached target Initrd Root File System.977second # [ 2.288098] systemd[1]: Starting Mountpoints Configured in the Real Root...978test # [ 2.248119] systemd[1]: Mounting /sysroot...979second # [ 2.306466] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.980second # [ 2.311618] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...981second # [ 2.315278] systemd[1]: Reloading...982test # [ 2.280106] EXT4-fs (vda): mounted filesystem b48464e5-db7f-41e5-8d50-b657cb09b494 r/w with ordered data mode. Quota mode: none.983test # [ 2.277710] systemd[1]: Mounted /sysroot.984test # [ 2.280062] systemd[1]: Reached target Initrd Root File System.985test # [ 2.287760] systemd[1]: Starting Mountpoints Configured in the Real Root...986test # [ 2.301816] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.987test # [ 2.306880] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...988test # [ 2.308709] systemd[1]: Reloading...989second # [ 2.490517] systemd[1]: Reloading finished in 176 ms.990second # [ 2.499924] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...991second # [ 2.502800] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...992second # [ 2.511610] systemd[1]: Starting Load Kernel Module 9pnet_virtio...993second # [ 2.515795] systemd[1]: initrd-parse-etc.service: Deactivated successfully.994second # [ 2.518924] systemd[1]: Finished Mountpoints Configured in the Real Root.995second # [ 2.519531] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.996second # [ 2.532914] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.997second # [ 2.533640] systemd[1]: Finished Load Kernel Module 9pnet_virtio.998test # [ 2.504126] systemd[1]: Reloading finished in 197 ms.999test # [ 2.516387] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1000test # [ 2.518852] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1001test # [ 2.522565] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1002test # [ 2.523945] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1003test # [ 2.531243] systemd[1]: Finished Mountpoints Configured in the Real Root.1004test # [ 2.533498] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1005test # [ 2.548131] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1006test # [ 2.548823] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1007second # [ 2.874827] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/lib/udev/mtd_probe": No such file or directory1008second # [ 2.878215] (udev-worker)[94]: mtd0ro: /nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/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 directory1009second # [ 2.894036] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1010second # [ 2.895920] systemd[1]: Stopped Virtual Console Setup.1011second # [ 2.896921] systemd[1]: Stopping Virtual Console Setup...1012second # [ 2.898964] systemd[1]: Starting Virtual Console Setup...1013second # [ 2.929082] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1014second # [ 2.931668] systemd[1]: Finished Virtual Console Setup.1015test # [ 2.883970] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/lib/udev/mtd_probe": No such file or directory1016test # [ 2.886993] (udev-worker)[97]: mtd0ro: /nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/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 directory1017test # [ 2.906289] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1018test # [ 2.907013] systemd[1]: Stopped Virtual Console Setup.1019test # [ 2.907882] systemd[1]: Stopping Virtual Console Setup...1020test # [ 2.915135] systemd[1]: Starting Virtual Console Setup...1021test # [ 2.923899] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1022test # [ 2.925802] systemd[1]: Stopped Virtual Console Setup.1023test # [ 2.926585] systemd[1]: Starting Virtual Console Setup...1024test # [ 2.943762] systemd-vconsole-setup[144]: Configuration of first virtual console was skipped, ignoring remaining ones.1025test # [ 2.946660] systemd[1]: Finished Virtual Console Setup.1026second # [ 3.265780] systemd[1]: Mounting /sysroot/nix/.ro-store...1027second # [ 3.277429] systemd[1]: Mounting /sysroot/nix/.rw-store...1028second # [ 3.278695] systemd[1]: Mounting /sysroot/run...1029second # [ 3.288245] systemd[1]: Mounting /sysroot/tmp/shared...1030second # [ 3.296766] systemd[1]: Mounting /sysroot/tmp/xchg...1031test # [ 3.248961] systemd[1]: Mounting /sysroot/nix/.ro-store...1032test # [ 3.260360] systemd[1]: Mounting /sysroot/nix/.rw-store...1033test # [ 3.263964] systemd[1]: Mounting /sysroot/run...1034second # [ 3.325134] systemd[1]: Mounted /sysroot/nix/.ro-store.1035second # [ 3.326355] systemd[1]: Mounted /sysroot/nix/.rw-store.1036second # [ 3.327660] systemd[1]: Mounted /sysroot/run.1037second # [ 3.331364] systemd[1]: Mounted /sysroot/tmp/shared.1038test # [ 3.276326] systemd[1]: Mounting /sysroot/tmp/shared...1039second # [ 3.334667] systemd[1]: Mounted /sysroot/tmp/xchg.1040second # [ 3.337342] systemd[1]: Starting rw-sysroot-nix-store.service...1041test # [ 3.290491] systemd[1]: Mounting /sysroot/tmp/xchg...1042second # [ 3.353146] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1043second # [ 3.354119] systemd[1]: Finished rw-sysroot-nix-store.service.1044test # [ 3.322750] systemd[1]: Mounted /sysroot/nix/.ro-store.1045test # [ 3.325098] systemd[1]: Mounted /sysroot/nix/.rw-store.1046test # [ 3.328451] systemd[1]: Mounted /sysroot/run.1047test # [ 3.333084] systemd[1]: Mounted /sysroot/tmp/shared.1048test # [ 3.335646] systemd[1]: Mounted /sysroot/tmp/xchg.1049test # [ 3.344511] systemd[1]: Starting rw-sysroot-nix-store.service...1050test # [ 3.358896] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1051test # [ 3.359997] systemd[1]: Finished rw-sysroot-nix-store.service.1052second # [ 4.255025] systemd[1]: Mounting /sysroot/nix/store...1053second # [ 4.284461] systemd[1]: Mounted /sysroot/nix/store.1054second # [ 4.285615] systemd[1]: Reached target Initrd File Systems.1055second # [ 4.287582] systemd[1]: Starting Find NixOS closure...1056second # [ 4.295422] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1057test # [ 4.246246] systemd[1]: Mounting /sysroot/nix/store...1058second # [ 4.315486] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1059second # [ 4.317746] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1060test # [ 4.272709] systemd[1]: Mounted /sysroot/nix/store.1061test # [ 4.274301] systemd[1]: Reached target Initrd File Systems.1062test # [ 4.275719] systemd[1]: Starting Find NixOS closure...1063second # [ 4.331604] systemd[1]: Finished Find NixOS closure.1064second # [ 4.333134] systemd[1]: Reached target Initrd Default Target.1065second # [ 4.333875] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1066test # [ 4.282913] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1067second # [ 4.355239] systemd[1]: Stopped target Initrd Default Target.1068second # [ 4.356374] systemd[1]: Stopped target Basic System.1069second # [ 4.357114] systemd[1]: Stopped target Initrd Root Device.1070test # [ 4.305476] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1071test # [ 4.306209] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1072second # [ 4.360140] systemd[1]: Stopped target Path Units.1073second # [ 4.361102] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1074second # [ 4.361777] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1075second # [ 4.362761] systemd[1]: Stopped target Slice Units.1076second # [ 4.364111] systemd[1]: Stopped target Socket Units.1077second # [ 4.368116] systemd[1]: Stopped target System Initialization.1078second # [ 4.368651] systemd[1]: Stopped target Swaps.1079second # [ 4.369048] systemd[1]: Stopped target Timer Units.1080second # [ 4.369469] systemd[1]: dbus.socket: Deactivated successfully.1081test # [ 4.315657] systemd[1]: Finished Find NixOS closure.1082second # [ 4.369970] systemd[1]: Closed D-Bus System Message Bus Socket.1083second # [ 4.370699] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1084second # [ 4.371773] systemd[1]: Stopped Find NixOS closure.1085test # [ 4.317625] systemd[1]: Reached target Initrd Default Target.1086second # [ 4.372691] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1087second # [ 4.373929] systemd[1]: Starting rw-sysroot-nix-store.service...1088test # [ 4.320359] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1089second # [ 4.375234] systemd[1]: systemd-sysctl.service: Deactivated successfully.1090second # [ 4.379866] systemd[1]: Stopped Apply Kernel Variables.1091second # [ 4.380477] systemd[1]: systemd-modules-load.service: Deactivated successfully.1092second # [ 4.381126] systemd[1]: Stopped Load Kernel Modules.1093second # [ 4.381542] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1094second # [ 4.382173] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1095second # [ 4.382798] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1096second # [ 4.383405] systemd[1]: Stopped Create System Files and Directories.1097second # [ 4.386674] systemd[1]: Stopped target Local File Systems.1098second # [ 4.388253] systemd[1]: Stopped target Preparation for Local File Systems.1099second # [ 4.390614] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1100second # [ 4.392183] systemd[1]: Stopped Coldplug All udev Devices.1101test # [ 4.339635] systemd[1]: initrd-cleanup.service: Deactivated successfully.1102test # [ 4.342384] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1103test # [ 4.343023] systemd[1]: Stopped target Initrd Default Target.1104test # [ 4.343517] systemd[1]: Stopped target Basic System.1105test # [ 4.343986] systemd[1]: Stopped target Initrd Root Device.1106second # [ 4.399230] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1107second # [ 4.399969] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1108test # [ 4.346503] systemd[1]: Stopped target Path Units.1109test # [ 4.346978] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1110test # [ 4.347606] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1111second # [ 4.402984] systemd[1]: Stopped Virtual Console Setup.1112test # [ 4.349320] systemd[1]: Stopped target Slice Units.1113test # [ 4.349768] systemd[1]: Stopped target Socket Units.1114test # [ 4.352259] systemd[1]: Stopped target System Initialization.1115test # [ 4.352807] systemd[1]: Stopped target Swaps.1116test # [ 4.353213] systemd[1]: Stopped target Timer Units.1117test # [ 4.353641] systemd[1]: dbus.socket: Deactivated successfully.1118test # [ 4.354135] systemd[1]: Closed D-Bus System Message Bus Socket.1119second # [ 4.408286] systemd[1]: initrd-cleanup.service: Deactivated successfully.1120test # [ 4.354635] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1121test # [ 4.355251] systemd[1]: Stopped Find NixOS closure.1122second # [ 4.409000] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1123test # [ 4.355664] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1124second # [ 4.409583] systemd[1]: systemd-udevd.service: Deactivated successfully.1125second # [ 4.411663] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1126second # [ 4.412988] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1127test # [ 4.359966] systemd[1]: Starting rw-sysroot-nix-store.service...1128test # [ 4.360714] systemd[1]: systemd-sysctl.service: Deactivated successfully.1129second # [ 4.414602] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1130test # [ 4.362318] systemd[1]: Stopped Apply Kernel Variables.1131second # [ 4.416106] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1132second # [ 4.416749] systemd[1]: Finished rw-sysroot-nix-store.service.1133second # [ 4.418115] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1134second # [ 4.419562] systemd[1]: Closed udev Control Socket.1135second # [ 4.420107] systemd[1]: Starting Cleanup udev Database...1136test # [ 4.366263] systemd[1]: systemd-modules-load.service: Deactivated successfully.1137test # [ 4.366912] systemd[1]: Stopped Load Kernel Modules.1138test # [ 4.368230] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1139test # [ 4.369991] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1140second # [ 4.424267] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1141second # [ 4.424939] systemd[1]: Stopped Create Static Device Nodes in /dev.1142second # [ 4.425465] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1143test # [ 4.372226] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1144second # [ 4.426122] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1145second # [ 4.426712] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1146test # [ 4.373426] systemd[1]: Stopped Create System Files and Directories.1147second # [ 4.427831] systemd[1]: Stopped Create List of Static Device Nodes.1148test # [ 4.374481] systemd[1]: Stopped target Local File Systems.1149test # [ 4.375004] systemd[1]: Stopped target Preparation for Local File Systems.1150test # [ 4.375580] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1151test # [ 4.380455] systemd[1]: Stopped Coldplug All udev Devices.1152test # [ 4.383722] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1153test # [ 4.386561] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1154test # [ 4.388410] systemd[1]: Stopped Virtual Console Setup.1155test # [ 4.392167] systemd[1]: systemd-udevd.service: Deactivated successfully.1156test # [ 4.392743] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1157test # [ 4.393350] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1158test # [ 4.393943] systemd[1]: Closed udev Control Socket.1159test # [ 4.394358] systemd[1]: Starting Cleanup udev Database...1160test # [ 4.394798] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1161test # [ 4.395408] systemd[1]: Stopped Create Static Device Nodes in /dev.1162test # [ 4.395920] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1163second # [ 4.452662] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1164test # [ 4.398849] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1165second # [ 4.453699] systemd[1]: Finished Cleanup udev Database.1166test # [ 4.399970] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1167test # [ 4.400793] systemd[1]: Stopped Create List of Static Device Nodes.1168second # [ 4.455172] systemd[1]: Reached target Switch Root.1169test # [ 4.401352] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1170test # [ 4.401955] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1171test # [ 4.402475] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1172second # [ 4.455966] systemd[1]: Starting NixOS Activation...1173test # [ 4.403069] systemd[1]: Finished rw-sysroot-nix-store.service.1174test # [ 4.426133] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1175test # [ 4.426880] systemd[1]: Finished Cleanup udev Database.1176test # [ 4.427516] systemd[1]: Reached target Switch Root.1177test # [ 4.432407] systemd[1]: Starting NixOS Activation...1178test # [ 4.573375] initrd-nixos-activation-start[181]: booting system configuration /nix/store/vfs9dmici0qj2ixr6gsxb1n9p1z1d6yj-nixos-system-test-test1179second # [ 4.629717] initrd-nixos-activation-start[179]: booting system configuration /nix/store/s614ay0b3m9f2hds0vf6jxk9bx9j93nz-nixos-system-second-test1180test # [ 4.619386] initrd-nixos-activation-start[181]: running activation script...1181second # [ 4.677498] initrd-nixos-activation-start[179]: running activation script...1182test # [ 4.994063] initrd-nixos-activation-start[204]: setting up /etc...1183second # [ 5.050336] initrd-nixos-activation-start[202]: setting up /etc...1184test # [ 5.217595] initrd-nixos-activation-start[204]: setting up age secrets...1185second # [ 5.300544] initrd-nixos-activation-start[202]: setting up age secrets...1186second # [ 5.483496] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1187second # [ 5.485334] systemd[1]: Finished NixOS Activation.1188second # [ 5.488075] systemd[1]: Starting Switch Root...1189second # [ 5.500465] systemd[1]: Switching root.1190test # [ 5.467025] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1191test # [ 5.468843] systemd[1]: Finished NixOS Activation.1192test # [ 5.469638] systemd[1]: Starting Switch Root...1193test # [ 5.484914] systemd[1]: Switching root.1194second # [ 5.556963] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1195test # [ 5.540196] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1196test # [ 6.127348] systemd[1]: systemd 260.4 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)1197test # [ 6.127439] systemd[1]: Detected virtualization qemu.1198second # [ 6.190256] systemd[1]: systemd 260.4 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)1199second # [ 6.190299] systemd[1]: Detected virtualization qemu.1200second # [ 6.190332] systemd[1]: Detected architecture arm64.1201test # [ 6.127488] systemd[1]: Detected architecture arm64.1202second # [ 6.190408] systemd[1]: Detected first boot.1203test # [ 6.127597] systemd[1]: Detected first boot.1204second # [ 6.198171] systemd[1]: Initializing machine ID from random generator.1205test # [ 6.143980] systemd[1]: Initializing machine ID from random generator.1206second # [ 6.536874] systemd[1]: bpf-restrict-fs: LSM BPF program attached1207test # [ 6.483075] systemd[1]: bpf-restrict-fs: LSM BPF program attached1208second # [ 6.691074] systemd[1]: Applying preset policy.1209test # [ 6.672978] systemd[1]: Applying preset policy.1210second # [ 7.175661] systemd[1]: Populated /etc with preset unit settings.1211test # [ 7.231746] systemd[1]: Populated /etc with preset unit settings.1212second # [ 7.593793] systemd[1]: initrd-switch-root.service: Deactivated successfully.1213second # [ 7.594086] systemd[1]: Stopped initrd-switch-root.service.1214second # [ 7.595078] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1215second # [ 7.595724] systemd[1]: Created slice Slice /system/getty.1216second # [ 7.599145] systemd[1]: Created slice User and Session Slice.1217second # [ 7.599697] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1218second # [ 7.601697] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1219second # [ 7.602196] systemd[1]: Expecting device /dev/hvc0...1220second # [ 7.602703] systemd[1]: Expecting device /dev/ttyAMA0...1221second # [ 7.603104] systemd[1]: Reached target Local Encrypted Volumes.1222second # [ 7.603604] systemd[1]: Stopped target initrd-fs.target.1223second # [ 7.607062] systemd[1]: Stopped target initrd-root-fs.target.1224second # [ 7.607534] systemd[1]: Stopped target initrd-switch-root.target.1225second # [ 7.609580] systemd[1]: Reached target Virtual Machines and Containers.1226second # [ 7.610070] systemd[1]: Reached target Path Units.1227second # [ 7.610582] systemd[1]: Reached target Remote File Systems.1228second # [ 7.611045] systemd[1]: Reached target Slice Units.1229second # [ 7.611517] systemd[1]: Reached target Swaps.1230second # [ 7.617224] systemd[1]: Listening on Process Core Dump Socket.1231second # [ 7.619634] systemd[1]: Listening on Credential Encryption/Decryption.1232second # [ 7.625079] systemd[1]: Starting Journal Log Access Socket...1233second # [ 7.626235] systemd[1]: Listening on Journal Audit Socket.1234second # [ 7.626892] systemd[1]: Listening on Network Management Metrics Varlink Socket.1235second # [ 7.627513] systemd[1]: Listening on Network Management Netlink Socket.1236second # [ 7.630115] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1237second # [ 7.630673] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1238second # [ 7.631354] systemd[1]: Listening on udev Control Socket.1239second # [ 7.637831] systemd[1]: Mounting Huge Pages File System...1240second # [ 7.640929] systemd[1]: Mounting POSIX Message Queue File System...1241second # [ 7.644378] systemd[1]: Mounting Kernel Debug File System...1242second # [ 7.652060] systemd[1]: Mounting Kernel Trace File System...1243second # [ 7.663987] systemd[1]: Starting Create List of Static Device Nodes...1244second # [ 7.671464] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1245second # [ 7.674745] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1246second # [ 7.683041] systemd[1]: Mounting Kernel Configuration File System...1247second # [ 7.683692] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1248second # [ 7.688122] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1249test # [ 7.653365] systemd[1]: initrd-switch-root.service: Deactivated successfully.1250test # [ 7.653753] systemd[1]: Stopped initrd-switch-root.service.1251second # [ 7.708122] systemd[1]: Starting Load Kernel Module fuse...1252test # [ 7.657063] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1253second # [ 7.711473] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671254test # [ 7.658189] systemd[1]: Created slice Slice /system/getty.1255test # [ 7.660153] systemd[1]: Created slice User and Session Slice.1256test # [ 7.660813] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1257test # [ 7.661490] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1258test # [ 7.662076] systemd[1]: Expecting device /dev/hvc0...1259test # [ 7.662619] systemd[1]: Expecting device /dev/ttyAMA0...1260test # [ 7.666114] systemd[1]: Reached target Local Encrypted Volumes.1261test # [ 7.666706] systemd[1]: Stopped target initrd-fs.target.1262test # [ 7.668679] systemd[1]: Stopped target initrd-root-fs.target.1263test # [ 7.669240] systemd[1]: Stopped target initrd-switch-root.target.1264test # [ 7.669850] systemd[1]: Reached target Virtual Machines and Containers.1265test # [ 7.670440] systemd[1]: Reached target Path Units.1266test # [ 7.673323] systemd[1]: Reached target Remote File Systems.1267test # [ 7.673877] systemd[1]: Reached target Slice Units.1268test # [ 7.674460] systemd[1]: Reached target Swaps.1269test # [ 7.680653] systemd[1]: Listening on Process Core Dump Socket.1270test # [ 7.684209] systemd[1]: Listening on Credential Encryption/Decryption.1271test # [ 7.688910] systemd[1]: Starting Journal Log Access Socket...1272test # [ 7.690170] systemd[1]: Listening on Journal Audit Socket.1273test # [ 7.692456] systemd[1]: Listening on Network Management Metrics Varlink Socket.1274test # [ 7.693134] systemd[1]: Listening on Network Management Netlink Socket.1275test # [ 7.693877] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1276second # [ 7.749651] systemd[1]: Starting Journal Service...1277test # [ 7.694377] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1278test # [ 7.698316] systemd[1]: Listening on udev Control Socket.1279test # [ 7.703584] systemd[1]: Mounting Huge Pages File System...1280test # [ 7.707877] systemd[1]: Mounting POSIX Message Queue File System...1281test # [ 7.712139] systemd[1]: Mounting Kernel Debug File System...1282test # [ 7.720568] systemd[1]: Mounting Kernel Trace File System...1283second # [ 7.784527] systemd[1]: Starting Load Kernel Modules...1284test # [ 7.732422] systemd[1]: Starting Create List of Static Device Nodes...1285test # [ 7.747654] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1286test # [ 7.749027] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1287second # [ 7.811076] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1288test # [ 7.761312] systemd[1]: Mounting Kernel Configuration File System...1289test # [ 7.762105] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1290test # [ 7.767221] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1291second # [ 7.831565] systemd[1]: Starting Remount Root and Kernel File Systems...1292test # [ 7.778421] systemd[1]: Starting Load Kernel Module fuse...1293test # [ 7.781558] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671294second # [ 7.836491] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1295second # [ 7.848296] systemd[1]: Starting Coldplug All udev Devices...1296second # [ 7.858824] systemd[1]: Listening on Journal Log Access Socket.1297second # [ 7.879658] systemd[1]: Mounted Huge Pages File System.1298second # [ 7.888829] fuse: init (API version 7.45)1299test # [ 7.841609] systemd[1]: Starting Journal Service...1300second # [ 7.900600] systemd[1]: Mounted POSIX Message Queue File System.1301second # [ 7.907603] systemd[1]: Mounted Kernel Debug File System.1302second # [ 7.912718] systemd[1]: Mounted Kernel Trace File System.1303second # [ 7.921384] systemd[1]: Finished Create List of Static Device Nodes.1304test # [ 7.867960] systemd[1]: Starting Load Kernel Modules...1305second # [ 7.922046] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1306second # [ 7.922479] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1307second # [ 7.922938] systemd[1]: Mounted Kernel Configuration File System.1308second # [ 7.923368] systemd[1]: modprobe@fuse.service: Deactivated successfully.1309second # [ 7.930650] systemd[1]: Finished Load Kernel Module fuse.1310second # [ 7.940306] systemd-journald[301]: Collecting audit messages is enabled.1311second # [ 7.940828] systemd[1]: Finished Load Kernel Modules.1312second # [ 7.950075] systemd[1]: Mounting FUSE Control File System...1313test # [ 7.901235] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1314second # [ 7.950384] systemd[1]: Queued start job for default target Multi-User System.1315second # [ 7.952928] systemd[1]: systemd-journald.service: Deactivated successfully.1316second # [ 7.954527] systemd-modules-load[302]: Module 'atkbd' is built in1317second # [ 7.965634] systemd[1]: Starting Firewall...1318second # [ 7.961867] systemd-modules-load[302]: Module 'ctr' is built in1319test # [ 7.916505] systemd[1]: Starting Remount Root and Kernel File Systems...1320second # [ 7.968633] systemd-modules-load[302]: Module 'loop' is built in1321test # [ 7.920949] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1322second # [ 7.990516] systemd[1]: Starting Apply Kernel Variables...1323second # [ 7.999456] systemd-oomd[303]: No swap; memory pressure usage will be degraded[ 8.004601] EXT4-fs (vda): re-mounted 31875a8d-42c9-4c2c-b02f-645307be074d.1324test # [ 7.951872] fuse: init (API version 7.45)1325test # [ 7.953916] systemd[1]: Starting Coldplug All udev Devices...1326second # 1327test # [ 7.963289] systemd-journald[325]: Collecting audit messages is enabled.1328test # [ 7.968794] systemd[1]: Started Journal Service.1329test # [ 7.965804] systemd[1]: Queued start job for default target Multi-User System.1330second # [ 8.026102] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1331second # [ 8.027391] systemd[1]: Started Journal Service.1332test # [ 7.968898] systemd[1]: systemd-journald.service: Deactivated successfully.1333test # [ 7.970658] systemd-modules-load[326]: Module 'atkbd' is built in1334test # [ 7.972546] systemd-modules-load[326]: Module 'ctr' is built in1335test # [ 7.973961] systemd-modules-load[326]: Module 'loop' is built in1336test # [ 7.975618] systemd[1]: Listening on Journal Log Access Socket.1337test # [ 7.976952] systemd[1]: Mounted Huge Pages File System.1338test # [ 7.979740] systemd[1]: Mounted POSIX Message Queue File System.1339test # [ 7.981055] systemd[1]: Mounted Kernel Debug File System.1340test # [ 7.981742] systemd[1]: Mounted Kernel Trace File System.1341second # [ 8.038619] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1342test # [ 7.984846] systemd[1]: Finished Create List of Static Device Nodes.1343test # [ 7.989534] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1344test # [ 7.991327] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1345test # [ 7.993932] systemd[1]: Mounted Kernel Configuration File System.1346test # [ 7.994728] systemd[1]: modprobe@fuse.service: Deactivated successfully.1347test # [ 7.998868] systemd[1]: Finished Load Kernel Module fuse.1348second # [ 8.053776] systemd[1]: Finished Remount Root and Kernel File Systems.1349test # [ 8.002877] systemd[1]: Finished Load Kernel Modules.1350test # [ 8.029787] systemd[1]: Mounting FUSE Control File System...1351test # [ 8.034082] systemd[1]: Starting Firewall...1352test # [ 8.044416] systemd[1]: Starting Apply Kernel Variables...1353test # [ 8.054945] EXT4-fs (vda): re-mounted b48464e5-db7f-41e5-8d50-b657cb09b494.1354test # [ 8.062186] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1355second # [ 8.117305] systemd[1]: Starting Flush Journal to Persistent Storage...1356second # [ 8.119208] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1357test # [ 8.074665] systemd[1]: Finished Remount Root and Kernel File Systems.1358second # [ 8.128586] systemd[1]: Starting Load/Save OS Random Seed...1359second # [ 8.132351] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1360second # [ 8.134536] systemd[1]: Mounted FUSE Control File System.1361second # [ 8.149631] systemd[1]: Finished Apply Kernel Variables.1362test # [ 8.111750] systemd-oomd[328]: No swap; memory pressure usage will be degraded1363test # [ 8.129663] systemd[1]: Starting Flush Journal to Persistent Storage...1364second # [ 8.188579] systemd[1]: Starting Network Name Resolution...1365test # [ 8.131697] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1366test # [ 8.137565] systemd[1]: Starting Load/Save OS Random Seed...1367test # [ 8.141249] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1368test # [ 8.153847] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1369second # [ 8.230573] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1370second # [ 8.243565] systemd[1]: Starting Create Static Device Nodes in /dev...1371second # [ 8.271712] systemd-journald[301]: Received client request to flush runtime journal.1372test # [ 8.233205] systemd[1]: Mounted FUSE Control File System.1373test # [ 8.258914] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1374test # [ 8.263210] systemd[1]: Starting Create Static Device Nodes in /dev...1375test # [ 8.279164] systemd-journald[325]: Received client request to flush runtime journal.1376second # [ 8.356828] systemd[1]: Finished Load/Save OS Random Seed.1377second # [ 8.360546] systemd[1]: Reached target First Boot Complete.1378second # [ 8.366184] systemd[1]: Finished Flush Journal to Persistent Storage.1379second # [ 8.375702] systemd-resolved[331]: Positive Trust Anchors:1380second # [ 8.377228] systemd-resolved[331]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1381second # [ 8.381362] systemd-resolved[331]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161382second # [ 8.385014] systemd-resolved[331]: 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 test1383test # [ 8.346451] systemd[1]: Finished Load/Save OS Random Seed.1384test # [ 8.347290] systemd[1]: Reached target First Boot Complete.1385test # [ 8.349421] systemd[1]: Finished Apply Kernel Variables.1386test # [ 8.352194] systemd[1]: Starting Network Name Resolution...1387second # [ 8.413784] systemd[1]: Finished Create Static Device Nodes in /dev.1388second # [ 8.416226] systemd[1]: Reached target Preparation for Local File Systems.1389test # [ 8.365420] systemd[1]: Finished Flush Journal to Persistent Storage.1390second # [ 8.420727] systemd[1]: Starting Rule-based Manager for Device Events and Files...1391test # [ 8.414247] systemd[1]: Finished Create Static Device Nodes in /dev.1392test # [ 8.415955] systemd[1]: Reached target Preparation for Local File Systems.1393test # [ 8.429008] systemd[1]: Starting Rule-based Manager for Device Events and Files...1394second # [ 8.558417] systemd-udevd[348]: Using default interface naming scheme 'v260'.1395test # [ 8.511054] systemd-resolved[360]: Positive Trust Anchors:1396test # [ 8.511938] systemd-resolved[360]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1397test # [ 8.514347] systemd-resolved[360]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161398test # [ 8.524402] systemd-resolved[360]: 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 test1399second # [ 8.596074] systemd[1]: Mounting /run/wrappers...1400second # [ 8.622671] systemd-resolved[331]: Using system hostname 'second'.1401test # [ 8.569912] systemd-udevd[368]: Using default interface naming scheme 'v260'.1402second # [ 8.633885] systemd[1]: Started Network Name Resolution.1403second # [ 8.667177] systemd[1]: Mounted /run/wrappers.1404second # [ 8.673107] systemd[1]: Reached target Local File Systems.1405second # [ 8.677989] systemd[1]: Listening on Boot Loader Control Service Socket.1406second # [ 8.682922] systemd[1]: Starting register-nix-paths.service...1407second # [ 8.695913] systemd[1]: Starting Create SUID/SGID Wrappers...1408second # [ 8.696695] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1409second # [ 8.704163] systemd[1]: Starting Save Transient machine-id to Disk...1410test # [ 8.658752] systemd[1]: Mounting /run/wrappers...1411second # [ 8.711721] systemd[1]: Starting Create System Files and Directories...1412test # [ 8.740297] systemd[1]: Mounted /run/wrappers.1413test # [ 8.743722] systemd[1]: Reached target Local File Systems.1414test # [ 8.751823] systemd[1]: Listening on Boot Loader Control Service Socket.1415test # [ 8.756084] systemd[1]: Starting register-nix-paths.service...1416test # [ 8.764133] systemd[1]: Starting Create SUID/SGID Wrappers...1417test # [ 8.764789] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1418test # [ 8.770979] systemd[1]: Starting Save Transient machine-id to Disk...1419test # [ 8.807735] systemd-resolved[360]: Using system hostname 'test'.1420test # [ 8.821098] systemd[1]: Starting Create System Files and Directories...1421test # [ 8.823529] systemd[1]: Started Network Name Resolution.1422second # [ 8.957652] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1423second # [ 8.963919] systemd[1]: Finished Save Transient machine-id to Disk.1424second # [ 8.969044] systemd[1]: Finished Create System Files and Directories.1425second # [ 8.977743] systemd[1]: Started Rule-based Manager for Device Events and Files.1426second # [ 8.994463] systemd[1]: Starting Rebuild Journal Catalog...1427second # [ 9.004516] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1428test # [ 8.964807] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1429test # [ 8.981981] systemd[1]: Finished Save Transient machine-id to Disk.1430test # [ 9.048905] systemd[1]: Started Rule-based Manager for Device Events and Files.1431test # [ 9.076326] systemd[1]: Finished Create System Files and Directories.1432test # [ 9.091985] systemd[1]: Starting Rebuild Journal Catalog...1433test # [ 9.096314] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1434second # [ 9.173816] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1435second # [ 9.229145] systemd[1]: Finished Rebuild Journal Catalog.1436second # [ 9.246243] systemd[1]: Starting Update is Completed...1437test # [ 9.247309] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1438second # [ 9.331922] systemd[1]: Finished Coldplug All udev Devices.1439second # [ 9.335552] systemd[1]: Finished Update is Completed.1440test # [ 9.309432] systemd[1]: Finished Rebuild Journal Catalog.1441test # [ 9.325443] systemd[1]: Starting Update is Completed...1442test # [ 9.388774] systemd[1]: Finished Coldplug All udev Devices.1443test # [ 9.413637] systemd[1]: Finished Update is Completed.1444second # [ 9.557810] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1445test # [ 9.648216] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1446second # [ 9.847985] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1447second # [ 9.856124] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1448second # [ 9.859268] systemd[1]: Finished Create SUID/SGID Wrappers.1449second # [ 9.914896] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1450test # [ 9.946338] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1451second # [ 10.024265] systemd[1]: Finished Firewall.1452test # [ 9.972458] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1453second # [ 10.027038] systemd[1]: Reached target Preparation for Network.1454test # [ 9.974068] systemd[1]: Finished Create SUID/SGID Wrappers.1455second # [ 10.031498] systemd[1]: Starting Network Management...1456test # [ 10.035501] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1457second # [ 10.116319] systemd[1]: Finished register-nix-paths.service.1458second # [ 10.117787] systemd[1]: Reached target System Initialization.1459second # [ 10.121445] systemd[1]: Started Discard unused filesystem blocks once a week.1460second # [ 10.123126] systemd[1]: Started Daily Cleanup of Temporary Directories.1461second # [ 10.126254] systemd[1]: Reached target Timer Units.1462second # [ 10.127545] systemd[1]: Listening on D-Bus System Message Bus Socket.1463second # [ 10.130676] systemd[1]: Listening on Nix Daemon Socket.1464second # [ 10.133831] systemd[1]: Listening on Authorization Manager Agent Helper.1465second # [ 10.136723] systemd[1]: Listening on Hostname Service Socket.1466second # [ 10.138326] systemd[1]: Reached target Socket Units.1467second # [ 10.141021] systemd[1]: Starting D-Bus System Message Bus...1468test # [ 10.115794] systemd[1]: Finished register-nix-paths.service.1469test # [ 10.118512] systemd[1]: Reached target System Initialization.1470test # [ 10.121342] systemd[1]: Started Discard unused filesystem blocks once a week.1471test # [ 10.124260] systemd[1]: Started Daily Cleanup of Temporary Directories.1472test # [ 10.126776] systemd[1]: Reached target Timer Units.1473test # [ 10.129319] systemd[1]: Listening on D-Bus System Message Bus Socket.1474test # [ 10.132262] systemd[1]: Listening on Nix Daemon Socket.1475test # [ 10.137500] systemd[1]: Listening on Authorization Manager Agent Helper.1476test # [ 10.139777] systemd[1]: Listening on Hostname Service Socket.1477test # [ 10.143418] systemd[1]: Reached target Socket Units.1478test # [ 10.144816] systemd[1]: Starting D-Bus System Message Bus...1479test # [ 10.195474] systemd[1]: Finished Firewall.1480test # [ 10.196107] systemd[1]: Reached target Preparation for Network.1481test # [ 10.201870] systemd[1]: Starting Network Management...1482second # [ 10.260091] (udev-worker)[461]: Network interface NamePolicy= disabled on kernel command line.1483second # [ 10.263215] (udev-worker)[456]: Network interface NamePolicy= disabled on kernel command line.1484second # [ 10.286110] cfg80211: Loading compiled-in X.509 certificates for regulatory database1485second # [ 10.323521] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1486second # [ 10.326271] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1487second # [ 10.360385] dbus-broker-launch[535]: Looking up NSS user entry for 'systemd-timesync'...1488test # [ 10.318296] (udev-worker)[472]: Network interface NamePolicy= disabled on kernel command line.1489test # [ 10.321585] (udev-worker)[486]: Network interface NamePolicy= disabled on kernel command line.1490second # [ 10.379412] dbus-broker-launch[535]: NSS returned no entry for 'systemd-timesync'1491second # [ 10.381564] dbus-broker-launch[535]: Invalid user-name in /nix/store/s3qds9d5y4dgflsgdjkj7pfnrbsm10sr-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1492second # [ 10.389299] systemd-networkd[532]: /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.1493test # [ 10.342724] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...1494second # [ 10.395098] systemd-networkd[532]: /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.1495second # [ 10.403494] systemd-networkd[532]: lo: Link UP1496second # [ 10.405796] systemd-networkd[532]: lo: Gained carrier1497second # [ 10.407824] systemd[1]: Started Network Management.1498second # [ 10.411293] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1499test # [ 10.369433] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'1500second # [ 10.423937] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1501second # [ 10.427457] systemd-networkd[532]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1502test # [ 10.371701] dbus-broker-launch[555]: Invalid user-name in /nix/store/s3qds9d5y4dgflsgdjkj7pfnrbsm10sr-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1503second # [ 10.431657] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1504second # [ 10.436065] systemd-networkd[532]: eth1: Link UP1505second # [ 10.437462] systemd-networkd[532]: eth1: Gained carrier1506second # [ 10.438832] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1507second # [ 10.463171] mousedev: PS/2 mouse device common for all mice1508second # [ 10.473098] dbus-broker-launch[535]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1509second # [ 10.476265] dbus-broker-launch[535]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1510second # [ 10.482577] dbus-broker-launch[535]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/sx40vhhwgyvayv82kxrdfsb24z1wvcrg-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1511second # [ 10.488071] dbus-broker-launch[535]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1512second # [ 10.495833] systemd[1]: Started D-Bus System Message Bus.1513test # [ 10.447554] cfg80211: Loading compiled-in X.509 certificates for regulatory database1514second # [ 10.497916] systemd[1]: Reached target Basic System.1515second # [ 10.500605] systemd[1]: Starting Network Manager Script Dispatcher Service...1516test # [ 10.448316] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1517second # [ 10.504225] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1518second # [ 10.507931] systemd[1]: Starting Network Manager...1519test # [ 10.453129] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1520test # [ 10.462942] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/sx40vhhwgyvayv82kxrdfsb24z1wvcrg-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1521second # [ 10.522092] systemd[1]: Started backdoor.service.1522test # [ 10.469873] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1523test # [ 10.477240] systemd[1]: Started D-Bus System Message Bus.1524test # [ 10.481068] systemd[1]: Reached target Basic System.1525test # [ 10.483756] systemd[1]: Starting Network Manager Script Dispatcher Service...1526test # [ 10.489901] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1527test # [ 10.494959] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1528test # [ 10.495460] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1529test # [ 10.499202] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1530second # [ 10.560552] systemd[1]: Starting Import lastlog data into lastlog2 database...1531second # [ 10.564279] dbus-broker-launch[535]: Ready1532test # [ 10.537336] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1533test # [ 10.538445] dbus-broker-launch[555]: Ready1534second # [ 10.597266] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1535second # [ 10.610460] systemd[1]: Starting Post-Boot Actions...1536test # [ 10.568745] systemd[1]: Starting Network Manager...1537test # [ 10.585180] systemd-networkd[560]: /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.1538second # [ 10.645184] systemd[1]: Started Reset console on configuration changes.1539test # [ 10.597786] systemd-networkd[560]: /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.1540test # [ 10.611192] systemd-networkd[560]: lo: Link UP1541test # [ 10.619895] systemd-networkd[560]: lo: Gained carrier1542second # [ 10.673299] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1543test # [ 10.622595] systemd[1]: Started backdoor.service.1544second # [ 10.687518] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[548]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1545test # [ 10.634234] systemd-networkd[560]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1546test # [ 10.649631] systemd-networkd[560]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1547test # [ 10.653404] systemd-networkd[560]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1548test # [ 10.663772] systemd-networkd[560]: eth1: Link UP[ 10.674489] mousedev: PS/2 mouse device common for all mice1549test # 1550test # [ 10.673448] systemd-networkd[560]: eth1: Gained carrier1551test # [ 10.677348] systemd-networkd[560]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1552test # [ 10.692853] 4bb5snallvknp7ll9gml95rlfxqybb0y-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1553second # connecting to host...1554test # [ 10.697151] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[569]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1555second # [ 10.756353] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1556test # [ 10.703697] systemd[1]: Starting Import lastlog data into lastlog2 database...1557second # [ 10.761273] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1558test # [ 10.713619] 9zw00hrl9ri87shidqszb96sxar6g9fp-wifi-secrets[573]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1559test # [ 10.727083] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1560test # [ 10.735967] systemd[1]: Starting Post-Boot Actions...1561second # [ 10.792732] systemd[1]: Finished Post-Boot Actions.1562test # [ 10.748984] systemd[1]: Started Reset console on configuration changes.1563test # [ 10.772388] systemd[1]: Started Network Management.1564test # [ 10.778254] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1565test # [ 10.781867] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1566second # [ 10.842592] systemd[1]: Finished Import lastlog data into lastlog2 database.1567test # [ 10.790072] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1568test # [ 10.796449] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1569test # [ 10.801267] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1570test # [ 10.802091] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1571second # [ 10.861062] systemd[1]: Started Name Service Cache Daemon (nsncd).1572second # [ 10.865647] systemd[1]: Reached target Host and Network Name Lookups.1573second # [ 10.866607] systemd[1]: Reached target User and Group Name Lookups.1574second # [ 10.870297] nsncd[552]: Sep 30 15:04:18.710 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1575second # [ 10.877097] systemd[1]: Starting User Login Management...1576second # [ 10.903488] systemd[1]: Started Network Manager Script Dispatcher Service.1577test # connecting to host...1578test: Guest shell says: b'Spawning backdoor root shell...\n'1579test: connected to guest root shell1580second # [ 11.006383] systemd[1]: Starting Hostname Service...1581second # [ 11.027393] systemd-logind[582]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1582test: (connecting took 11.23 seconds)1583test # [ 10.949659] systemd[1]: Finished Post-Boot Actions.1584test: (finished: waiting for the VM to finish booting, in 11.23 seconds)1585second # [ 11.030340] systemd-logind[582]: Watching system buttons on /dev/input/event0 (gpio-keys)1586test # [ 10.950476] systemd[1]: Started Network Manager Script Dispatcher Service.1587second # [ 11.030987] systemd-logind[582]: New seat seat0.1588test # [ 10.966215] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1589second # [ 11.033326] systemd[1]: Started User Login Management.1590test # [ 10.978010] systemd[1]: Started Name Service Cache Daemon (nsncd).1591test # [ 10.981949] nsncd[584]: Sep 30 15:04:18.814 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1592test # [ 10.988899] systemd[1]: Reached target Host and Network Name Lookups.1593second # [ 11.043555] systemd[1]: Starting linger-users.service...1594test # [ 10.993495] systemd[1]: Reached target User and Group Name Lookups.1595test # [ 11.011964] systemd[1]: Starting User Login Management...1596test # [ 11.021551] systemd[1]: Finished Import lastlog data into lastlog2 database.1597second # [ 11.122288] systemd[1]: linger-users.service: Deactivated successfully.1598second # [ 11.122952] systemd[1]: Finished linger-users.service.1599second # [ 11.146971] systemd[1]: Started Hostname Service.1600test # [ 11.101531] systemd[1]: Starting Hostname Service...1601test # [ 11.176254] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1602second # [ 11.247240] systemd-networkd[532]: eth0: Link UP1603second # [ 11.247714] systemd-networkd[532]: eth0: Gained carrier1604test # [ 11.201090] systemd-logind[623]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1605test # [ 11.202344] systemd-logind[623]: Watching system buttons on /dev/input/event0 (gpio-keys)1606test # [ 11.202981] systemd-logind[623]: New seat seat0.1607test # [ 11.210581] systemd[1]: Started User Login Management.1608second # [ 11.268928] systemd[1]: Started Network Manager.1609second # [ 11.271742] systemd[1]: Reached target Network.1610test # [ 11.218660] systemd[1]: Starting linger-users.service...1611second # [ 11.275584] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1612second # [ 11.282224] systemd[1]: Starting Permit User Sessions...1613test # [ 11.270452] systemd[1]: Started Hostname Service.1614test # [ 11.287208] systemd[1]: linger-users.service: Deactivated successfully.1615test # [ 11.288909] systemd[1]: Finished linger-users.service.1616test # [ 11.372188] systemd-networkd[560]: eth0: Link UP1617test # [ 11.372663] systemd-networkd[560]: eth0: Gained carrier1618second # [ 11.442329] systemd[1]: Finished Permit User Sessions.1619test # [ 11.389558] systemd[1]: Started Network Manager.1620test # [ 11.391921] systemd[1]: Reached target Network.1621test # [ 11.395738] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1622test # [ 11.404694] systemd[1]: Starting Permit User Sessions...1623second # [ 11.459813] systemd[1]: Started Getty on tty1.1624second # [ 11.462187] systemd[1]: Reached target Login Prompts.1625second # [ 11.500859] systemd-resolved[331]: eth0: Bus client set default route setting: yes1626second # [ 11.504946] systemd-resolved[331]: eth0: Bus client set DNS server list to: 10.0.2.31627second # [ 11.580714] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1628second # [ 11.581962] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1629test # [ 11.560947] systemd[1]: Finished Permit User Sessions.1630test # [ 11.579847] systemd[1]: Started Getty on tty1.1631test # [ 11.582398] systemd[1]: Reached target Login Prompts.1632test # [ 11.605843] systemd-resolved[360]: eth0: Bus client set default route setting: yes1633test # [ 11.609527] systemd-resolved[360]: eth0: Bus client set DNS server list to: 10.0.2.31634test # [ 11.631710] NetworkManager[574]: <warn> [1790780659.4604] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1635second # [ 11.714243] systemd[1]: Reached target Multi-User System.1636second # [ 11.718976] systemd[1]: Startup finished in 741ms (kernel) + 4.937s (initrd) + 6.036s (userspace) = 11.715s.1637test # [ 11.689018] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1638test # [ 11.690416] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1639test # [ 11.823604] systemd[1]: Reached target Multi-User System.1640test # [ 11.827641] systemd[1]: Startup finished in 713ms (kernel) + 4.917s (initrd) + 6.195s (userspace) = 11.826s.1641second # [ 12.066244] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31642second # [ 12.098265] systemd-networkd[532]: eth1: Gained IPv6LL1643test: (finished: waiting for unit NetworkManager.service, in 12.50 seconds)1644test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1645second # [ 12.312896] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1646test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1647test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1648second # [ 12.354051] systemd[1]: Starting Virtual Console Setup...1649test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds)1650test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1651second # [ 12.377801] systemd-logind[582]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1652second # [ 12.383063] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1653second # [ 12.383713] systemd[1]: Stopped Virtual Console Setup.1654second # [ 12.388310] systemd[1]: Starting Virtual Console Setup...1655test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1656(finished: run the VM test script, in 13.22 seconds)1657test # [ 12.412083] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31658test script finished in 13.29s1659cleanup1660kill QemuMachine (pid 14)1661second # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1662kill QemuMachine (pid 15)1663test # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1664(finished: cleanup, in 0.25 seconds)