vm-test-run-wifi
checks.aarch64-linux.wifi
· build #828
· raw
1build01: building bb3jf6byil4qzh4wyilhqr81qmfv6d1x-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.1DZXwxl0xI', 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.wGbvvxPleI', fmt=raw size=107374182422second # Creating filesystem with 262144 4k blocks and 65536 inodes23test # mke2fs 1.47.4 (6-Mar-2025)24second # Filesystem UUID: 310cb11f-273b-4fff-9e5b-eabf9989aa9a25(finished: start all VMs, in 0.47 seconds)26second # Superblock backups stored on blocks:27test: waiting for unit NetworkManager.service28second # 32768, 98304, 163840, 22937629test: waiting for the VM to finish booting30second # 31test # Discarding device blocks: 0/262144 done32second # Allocating group tables: 0/8 done33test # Creating filesystem with 262144 4k blocks and 65536 inodes34second # Writing inode tables: 0/8 done35test # Filesystem UUID: a7d97bec-f338-4b31-bc3c-b01d549e5c8e36second # Creating journal (8192 blocks): done37test # Superblock backups stored on blocks:38second # Writing superblocks and filesystem accounting information: 0/8 done39test # 32768, 98304, 163840, 22937640second # 41test # 42second # Virtualisation disk image created.43test # Allocating group tables: 0/8 done44test # Writing inode tables: 0/8 done45test # Creating journal (8192 blocks): done46test # Writing superblocks and filesystem accounting information: 0/8 done47test # 48test # Virtualisation disk image created.49second # [ 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/pqx07i8m96vqazxjzqkz0x63zvr28zlh-nixos-system-second-test/init regInfo=/nix/store/fyz5jxakcckzwwwjkdyc3ww7gd3lw43y-closure-info/registration console=ttyAMA0,115200n8 console=tty086second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/fyz5jxakcckzwwwjkdyc3ww7gd3lw43y-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 @44cf0000 (indirect, esz 8, psz 64K, shr 1)121second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)122second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000123second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000124second # [ 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.000060] arm-pv: using stolen time PV131second # [ 0.000353] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)132second # [ 0.000632] Console: colour dummy device 80x25133second # [ 0.000645] printk: legacy console [tty0] enabled134second # [ 0.000858] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)135second # [ 0.000863] pid_max: default: 32768 minimum: 301136second # [ 0.000937] LSM: initializing lsm=capability,landlock,yama,bpf,ima137second # [ 0.001061] landlock: Up and running.138second # [ 0.001064] Yama: becoming mindful.139second # [ 0.001412] LSM support for eBPF active140second # [ 0.001569] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)141second # [ 0.001592] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)142second # [ 0.004244] rcu: Hierarchical SRCU implementation.143second # [ 0.004250] rcu: Max phase no-delay instances is 1000.144second # [ 0.005223] fsl-mc MSI: its@8080000 domain created145second # [ 0.005407] EFI services will not be available.146second # [ 0.005489] smp: Bringing up secondary CPUs ...147second # [ 0.005522] smp: Brought up 1 node, 1 CPU148second # [ 0.005525] SMP: Total of 1 processors activated.149second # [ 0.005526] CPU: All CPU(s) started at EL1150second # [ 0.005539] CPU features: detected: 32-bit EL0 Support151second # [ 0.005542] CPU features: detected: Data cache clean to the PoU not required for I/D coherence152second # [ 0.005545] CPU features: detected: Common not Private translations153second # [ 0.005547] CPU features: detected: CRC32 instructions154second # [ 0.005549] CPU features: detected: Data cache clean to Point of Persistence155second # [ 0.005552] CPU features: detected: Enhanced Virtualization Traps156test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]157second # [ 0.005562] CPU features: detected: RCpc load-acquire (LDAPR)158second # [ 0.005564] CPU features: detected: LSE atomic instructions159test # [ 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 2026160second # [ 0.005566] CPU features: detected: Privileged Access Never161test # [ 0.000000] KASLR enabled162second # [ 0.005568] CPU features: detected: PMUv3163test # [ 0.000000] random: crng init done164second # [ 0.005570] CPU features: detected: RAS Extension Support165second # [ 0.005574] CPU features: detected: Speculative Store Bypassing Safe (SSBS)166second # [ 0.005594] alternatives: applying system-wide alternatives167test # [ 0.000000] Machine model: linux,dummy-virt168test # [ 0.000000] efi: UEFI not found.169test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT170second # [ 0.007079] CPU features: detected: Hardware dirty bit management on CPU0171test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]172test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]173test # [ 0.000000] Zone ranges:174test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]175second # [ 0.007268] Memory: 892864K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114364K reserved, 32768K cma-reserved)176test # [ 0.000000] DMA32 empty177second # [ 0.007775] devtmpfs: initialized178test # [ 0.000000] Normal empty179test # [ 0.000000] Device empty180second # [ 0.009258] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)181test # [ 0.000000] Movable zone start for each node182test # [ 0.000000] Early memory node ranges183second # [ 0.009281] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).184test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]185second # [ 0.009440] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL186test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]187second # [ 0.009443] 0 pages in range for non-PLT usage188test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000189second # [ 0.009444] 508272 pages in range for PLT usage190test # [ 0.000000] psci: probing for conduit method from DT.191second # [ 0.009551] pinctrl core: initialized pinctrl subsystem192second # [ 0.010367] DMI not present or invalid.193test # [ 0.000000] psci: PSCIv1.3 detected in firmware.194second # [ 0.013744] NET: Registered PF_NETLINK/PF_ROUTE protocol family195test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs196test # [ 0.000000] psci: Trusted OS migration not required197second # [ 0.016297] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations198test # [ 0.000000] psci: SMC Calling Convention v1.1199second # [ 0.016447] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations200test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)201second # [ 0.016618] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202test # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u311296203second # [ 0.016643] audit: initializing netlink subsys (disabled)204test # [ 0.000000] Detected PIPT I-cache on CPU0205test # [ 0.000000] CPU features: detected: GICv3 CPU interface206second # [ 0.017326] thermal_sys: Registered thermal governor 'fair_share'207test # [ 0.000000] CPU features: detected: Spectre-v4208second # [ 0.017328] thermal_sys: Registered thermal governor 'bang_bang'209test # [ 0.000000] CPU features: detected: Spectre-BHB210second # [ 0.017331] thermal_sys: Registered thermal governor 'step_wise'211test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR212second # [ 0.017333] thermal_sys: Registered thermal governor 'user_space'213test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)214second # [ 0.017335] thermal_sys: Registered thermal governor 'power_allocator'215test # [ 0.000000] CPU features: detected: ARM erratum 1418040216second # [ 0.017371] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1217test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion218second # [ 0.017387] cpuidle: using governor ladder219test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing220second # [ 0.017392] cpuidle: using governor menu221test # [ 0.000000] alternatives: applying boot alternatives222second # [ 0.017508] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.223second # [ 0.017530] ASID allocator initialised with 32768 entries224second # [ 0.018199] Serial: AMBA PL011 UART driver225second # [ 0.021633] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1226second # [ 0.021777] printk: console [ttyAMA0] enabled227test # [ 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/ahf9gzwzi9csh09wax04dzqd5jng77s7-nixos-system-test-test/init regInfo=/nix/store/86l77s864w8i2p3byc9lyk59dfxd7h68-closure-info/registration console=ttyAMA0,115200n8 console=tty0228test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/86l77s864w8i2p3byc9lyk59dfxd7h68-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_ext241test # [ 0.000000] ftrace: allocating 74832 entries in 294 pages242test # [ 0.000000] ftrace: allocated 294 pages with 4 groups243test # [ 0.000000] rcu: Hierarchical RCU implementation.244test # [ 0.000000] rcu: RCU event tracing is enabled.245test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.246second # [ 0.095328] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages247test # [ 0.000000] Trampoline variant of Tasks RCU enabled.248test # [ 0.000000] Rude variant of Tasks RCU enabled.249second # [ 0.095343] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page250test # [ 0.000000] Tracing variant of Tasks RCU enabled.251second # [ 0.095346] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages252test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.253second # [ 0.095350] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page254test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1255second # [ 0.095352] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages256second # [ 0.095354] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page257test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.258second # [ 0.095356] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages259test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.260second # [ 0.095358] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page261second # [ 0.096299] fbcon: Taking over console262test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.263second # [ 0.096309] ACPI: Interpreter disabled.264test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0265second # [ 0.099016] iommu: Default domain type: Translated266test # [ 0.000000] GICv3: 256 SPIs implemented267second # [ 0.099020] iommu: DMA domain TLB invalidation policy: strict mode268test # [ 0.000000] GICv3: 0 Extended SPIs implemented269second # [ 0.099314] SCSI subsystem initialized270test # [ 0.000000] Root IRQ handler: gic_handle_irq271test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI272test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0273test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000274test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]275test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)276second # [ 0.105148] usbcore: registered new interface driver usbfs277second # [ 0.105184] usbcore: registered new interface driver hub278test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)279second # [ 0.105199] usbcore: registered new device driver usb280test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000281second # [ 0.105410] pps_core: LinuxPPS API ver. 1 registered282test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000283second # [ 0.105413] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>284test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.285second # [ 0.105418] PTP clock support registered286second # [ 0.105453] EDAC MC: Ver: 3.0.0287second # [ 0.105642] scmi_core: SCMI protocol bus registered288test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns289second # [ 0.105916] FPGA manager framework290test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040291test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).292second # [ 0.110661] vgaarb: loaded293second # [ 0.110870] clocksource: Switched to clocksource arch_sys_counter294test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns295test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns296test # [ 0.000056] arm-pv: using stolen time PV297test # [ 0.000354] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)298test # [ 0.000615] Console: colour dummy device 80x25299test # [ 0.000628] printk: legacy console [tty0] enabled300test # [ 0.000832] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)301test # [ 0.000837] pid_max: default: 32768 minimum: 301302test # [ 0.000905] LSM: initializing lsm=capability,landlock,yama,bpf,ima303test # [ 0.001027] landlock: Up and running.304test # [ 0.001029] Yama: becoming mindful.305test # [ 0.001394] LSM support for eBPF active306test # [ 0.001549] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)307test # [ 0.001569] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)308test # [ 0.004181] rcu: Hierarchical SRCU implementation.309test # [ 0.004187] rcu: Max phase no-delay instances is 1000.310test # [ 0.005118] fsl-mc MSI: its@8080000 domain created311test # [ 0.005308] EFI services will not be available.312test # [ 0.005391] smp: Bringing up secondary CPUs ...313test # [ 0.005421] smp: Brought up 1 node, 1 CPU314test # [ 0.005424] SMP: Total of 1 processors activated.315test # [ 0.005426] CPU: All CPU(s) started at EL1316test # [ 0.005437] CPU features: detected: 32-bit EL0 Support317test # [ 0.005440] CPU features: detected: Data cache clean to the PoU not required for I/D coherence318test # [ 0.005443] CPU features: detected: Common not Private translations319test # [ 0.005445] CPU features: detected: CRC32 instructions320test # [ 0.005447] CPU features: detected: Data cache clean to Point of Persistence321test # [ 0.005450] CPU features: detected: Enhanced Virtualization Traps322test # [ 0.005459] CPU features: detected: RCpc load-acquire (LDAPR)323test # [ 0.005462] CPU features: detected: LSE atomic instructions324test # [ 0.005463] CPU features: detected: Privileged Access Never325test # [ 0.005465] CPU features: detected: PMUv3326test # [ 0.005467] CPU features: detected: RAS Extension Support327second # [ 0.123041] VFS: Disk quotas dquot_6.6.0328test # [ 0.005471] CPU features: detected: Speculative Store Bypassing Safe (SSBS)329second # [ 0.123067] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)330test # [ 0.005491] alternatives: applying system-wide alternatives331second # [ 0.124441] netfs: FS-Cache loaded332second # [ 0.124530] pnp: PnP ACPI: disabled333test # [ 0.006873] CPU features: detected: Hardware dirty bit management on CPU0334second # [ 0.126293] NET: Registered PF_INET protocol family335second # [ 0.126474] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)336test # [ 0.007089] Memory: 892888K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114368K reserved, 32768K cma-reserved)337test # [ 0.007549] devtmpfs: initialized338test # [ 0.008943] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)339test # [ 0.008965] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).340test # [ 0.009095] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL341test # [ 0.009099] 0 pages in range for non-PLT usage342test # [ 0.009100] 508272 pages in range for PLT usage343test # [ 0.009217] pinctrl core: initialized pinctrl subsystem344test # [ 0.010036] DMI not present or invalid.345test # [ 0.013256] NET: Registered PF_NETLINK/PF_ROUTE protocol family346test # [ 0.015723] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations347test # [ 0.015880] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations348test # [ 0.016052] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations349test # [ 0.016076] audit: initializing netlink subsys (disabled)350test # [ 0.016703] thermal_sys: Registered thermal governor 'fair_share'351test # [ 0.016705] thermal_sys: Registered thermal governor 'bang_bang'352test # [ 0.016709] thermal_sys: Registered thermal governor 'step_wise'353test # [ 0.016711] thermal_sys: Registered thermal governor 'user_space'354test # [ 0.016713] thermal_sys: Registered thermal governor 'power_allocator'355test # [ 0.016751] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1356test # [ 0.016765] cpuidle: using governor ladder357test # [ 0.016770] cpuidle: using governor menu358test # [ 0.016893] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.359test # [ 0.016914] ASID allocator initialised with 32768 entries360test # [ 0.017549] Serial: AMBA PL011 UART driver361test # [ 0.021074] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1362test # [ 0.021246] printk: console [ttyAMA0] enabled363test # [ 0.094382] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages364test # [ 0.094396] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page365test # [ 0.094399] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages366test # [ 0.094403] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page367test # [ 0.094405] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages368test # [ 0.094407] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page369test # [ 0.094409] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages370test # [ 0.094411] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page371test # [ 0.095463] fbcon: Taking over console372test # [ 0.095474] ACPI: Interpreter disabled.373second # [ 0.151813] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)374test # [ 0.096138] iommu: Default domain type: Translated375second # [ 0.151838] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)376test # [ 0.096142] iommu: DMA domain TLB invalidation policy: strict mode377test # [ 0.098341] SCSI subsystem initialized378second # [ 0.151851] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)379second # [ 0.151887] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)380second # [ 0.151954] TCP: Hash tables configured (established 8192 bind 8192)381second # [ 0.152045] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)382second # [ 0.152073] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)383test # [ 0.104486] usbcore: registered new interface driver usbfs384second # [ 0.152126] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)385test # [ 0.104520] usbcore: registered new interface driver hub386second # [ 0.152251] NET: Registered PF_UNIX/PF_LOCAL protocol family387test # [ 0.104537] usbcore: registered new device driver usb388second # [ 0.152309] NET: Registered PF_XDP protocol family389test # [ 0.104780] pps_core: LinuxPPS API ver. 1 registered390second # [ 0.152332] PCI: CLS 0 bytes, default 64391second # [ 0.152668] Trying to unpack rootfs image as initramfs...392test # [ 0.104783] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>393test # [ 0.104788] PTP clock support registered394test # [ 0.104815] EDAC MC: Ver: 3.0.0395test # [ 0.105010] scmi_core: SCMI protocol bus registered396test # [ 0.105296] FPGA manager framework397test # [ 0.110046] vgaarb: loaded398second # [ 0.160947] kvm [1]: HYP mode not available399test # [ 0.110293] clocksource: Switched to clocksource arch_sys_counter400test # [ 0.122601] VFS: Disk quotas dquot_6.6.0401test # [ 0.122629] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)402test # [ 0.124095] netfs: FS-Cache loaded403test # [ 0.124208] pnp: PnP ACPI: disabled404test # [ 0.126021] NET: Registered PF_INET protocol family405test # [ 0.126200] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)406test # [ 0.151661] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)407test # [ 0.151686] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)408test # [ 0.151700] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.151738] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.151804] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.151911] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.151972] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.152026] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.152147] NET: Registered PF_UNIX/PF_LOCAL protocol family415test # [ 0.152226] NET: Registered PF_XDP protocol family416test # [ 0.152248] PCI: CLS 0 bytes, default 64417test # [ 0.152583] Trying to unpack rootfs image as initramfs...418test # [ 0.160486] kvm [1]: HYP mode not available419second # [ 0.225452] Initialise system trusted keyrings420second # [ 0.225570] workingset: timestamp_bits=42 max_order=18 bucket_order=0421second # [ 0.225945] squashfs: version 4.0 (2009/01/31) Phillip Lougher422second # [ 0.226907] 9p: Installing v9fs 9p2000 file system support423second # [ 0.245755] Key type asymmetric registered424second # [ 0.245774] Asymmetric key parser 'x509' registered425second # [ 0.245836] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)426second # [ 0.258937] io scheduler mq-deadline registered427second # [ 0.258948] io scheduler kyber registered428second # [ 0.261286] pl061_gpio 9030000.pl061: PL061 GPIO chip registered429second # [ 0.261608] ledtrig-cpu: registered to indicate activity on CPUs430second # [ 0.261903] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:431second # [ 0.261918] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000432second # [ 0.261932] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000433second # [ 0.261936] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000434second # [ 0.261960] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits435second # [ 0.261981] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]436second # [ 0.262044] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00437second # [ 0.262060] pci_bus 0000:00: root bus resource [bus 00-ff]438second # [ 0.262072] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]439second # [ 0.262075] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]440second # [ 0.262078] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]441second # [ 0.262153] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint442second # [ 0.262571] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint443second # [ 0.262681] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]444second # [ 0.262690] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]445second # [ 0.262707] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]446second # [ 0.262717] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]447second # [ 0.274146] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint448second # [ 0.274261] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]449second # [ 0.274270] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]450second # [ 0.274287] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]451second # [ 0.274569] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint452second # [ 0.274677] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]453second # [ 0.274685] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]454second # [ 0.274702] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]455test # [ 0.234686] Initialise system trusted keyrings456test # [ 0.234837] workingset: timestamp_bits=42 max_order=18 bucket_order=0457test # [ 0.235222] squashfs: version 4.0 (2009/01/31) Phillip Lougher458test # [ 0.235288] 9p: Installing v9fs 9p2000 file system support459second # [ 0.287079] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint460second # [ 0.287199] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]461second # [ 0.287208] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]462second # [ 0.287225] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]463second # [ 0.287507] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint464second # [ 0.287628] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]465second # [ 0.287637] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]466second # [ 0.287655] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]467second # [ 0.287924] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint468second # [ 0.288030] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]469second # [ 0.288038] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]470second # [ 0.288056] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]471second # [ 0.288317] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint472second # [ 0.288425] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]473second # [ 0.288433] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]474second # [ 0.288451] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475second # [ 0.288463] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]476second # [ 0.288744] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint477second # [ 0.288853] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]478second # [ 0.288869] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]479second # [ 0.289130] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint480second # [ 0.289240] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]481second # [ 0.289256] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]482second # [ 0.289501] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint483second # [ 0.289606] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]484second # [ 0.289762] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint485second # [ 0.289943] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]486second # [ 0.289952] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]487second # [ 0.289969] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]488second # [ 0.290244] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint489second # [ 0.290352] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]490second # [ 0.290360] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]491second # [ 0.290377] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]492second # [ 0.290782] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned493test # [ 0.255899] Key type asymmetric registered494second # [ 0.290789] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned495test # [ 0.255917] Asymmetric key parser 'x509' registered496second # [ 0.290792] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned497test # [ 0.255987] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)498test # [ 0.256084] io scheduler mq-deadline registered499second # [ 0.290824] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned500test # [ 0.256088] io scheduler kyber registered501second # [ 0.290853] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned502second # [ 0.290903] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned503second # [ 0.290932] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned504second # [ 0.290960] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned505second # [ 0.290989] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned506second # [ 0.291018] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned507second # [ 0.291046] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned508second # [ 0.291074] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned509second # [ 0.291135] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned510second # [ 0.291163] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned511second # [ 0.291176] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned512second # [ 0.291188] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned513second # [ 0.291200] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned514second # [ 0.291212] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned515second # [ 0.291225] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned516second # [ 0.291237] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned517second # [ 0.291250] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned518second # [ 0.291262] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned519second # [ 0.291275] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned520second # [ 0.291287] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned521second # [ 0.291300] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned522second # [ 0.291312] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned523second # [ 0.291324] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned524second # [ 0.291337] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned525second # [ 0.291349] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned526second # [ 0.291367] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned527second # [ 0.291379] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned528test # [ 0.266565] pl061_gpio 9030000.pl061: PL061 GPIO chip registered529second # [ 0.291391] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned530test # [ 0.266941] ledtrig-cpu: registered to indicate activity on CPUs531second # [ 0.291403] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned532test # [ 0.267296] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:533second # [ 0.291415] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned534second # [ 0.291433] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]535test # [ 0.267313] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000536second # [ 0.291437] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]537test # [ 0.267326] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000538second # [ 0.291440] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]539second # [ 0.292143] pci 0000:00:0a.0: enabling device (0000 -> 0002)540test # [ 0.267331] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000541test # [ 0.267357] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits542test # [ 0.267377] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]543test # [ 0.267447] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00544test # [ 0.267463] pci_bus 0000:00: root bus resource [bus 00-ff]545test # [ 0.267467] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]546test # [ 0.267469] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]547test # [ 0.267472] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]548test # [ 0.267588] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint549test # [ 0.268020] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint550test # [ 0.268135] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]551test # [ 0.268144] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]552test # [ 0.268162] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]553test # [ 0.268172] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]554test # [ 0.268457] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555test # [ 0.268570] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]556test # [ 0.268579] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]557test # [ 0.268597] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]558test # [ 0.268874] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint559test # [ 0.268985] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]560test # [ 0.268994] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]561test # [ 0.269011] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]562test # [ 0.269284] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint563test # [ 0.269394] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]564test # [ 0.269403] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]565test # [ 0.269421] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]566test # [ 0.269704] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint567test # [ 0.269816] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]568test # [ 0.269824] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]569test # [ 0.269842] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]570test # [ 0.270129] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint571test # [ 0.270242] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]572test # [ 0.270251] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]573test # [ 0.270269] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]574second # [ 0.339457] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)575second # [ 0.341430] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)576test # [ 0.295340] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint577test # [ 0.295472] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]578test # [ 0.295482] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]579test # [ 0.295500] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]580test # [ 0.295514] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]581test # [ 0.295839] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint582test # [ 0.295951] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]583test # [ 0.295968] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]584test # [ 0.296238] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint585test # [ 0.296348] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]586test # [ 0.296366] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]587test # [ 0.296609] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint588test # [ 0.296717] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]589test # [ 0.296883] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint590test # [ 0.297059] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]591test # [ 0.297068] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]592test # [ 0.297086] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]593test # [ 0.297374] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint594second # [ 0.355066] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)595test # [ 0.297485] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]596test # [ 0.297494] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]597second # [ 0.357030] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)598second # [ 0.358754] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)599test # [ 0.297512] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]600test # [ 0.297916] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned601test # [ 0.297923] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned602test # [ 0.297926] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned603test # [ 0.297958] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned604second # [ 0.362282] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)605test # [ 0.297988] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned606test # [ 0.298017] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned607test # [ 0.298046] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned608test # [ 0.298076] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned609test # [ 0.298105] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned610test # [ 0.298133] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned611test # [ 0.298162] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned612test # [ 0.298191] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned613test # [ 0.298265] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned614second # [ 0.368674] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)615second # [ 0.370619] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)616test # [ 0.322369] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned617test # [ 0.322390] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned618test # [ 0.322404] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned619second # [ 0.376882] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)620test # [ 0.322418] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned621test # [ 0.322431] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned622test # [ 0.322445] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned623test # [ 0.322458] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned624test # [ 0.322471] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned625test # [ 0.322484] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned626test # [ 0.322497] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned627test # [ 0.322511] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned628test # [ 0.322524] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned629test # [ 0.322536] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned630test # [ 0.322548] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned631test # [ 0.322561] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned632test # [ 0.322572] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned633test # [ 0.322590] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned634test # [ 0.322602] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned635test # [ 0.322614] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned636test # [ 0.322626] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned637test # [ 0.322637] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned638test # [ 0.322661] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]639test # [ 0.322665] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]640test # [ 0.322667] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]641test # [ 0.323372] pci 0000:00:0a.0: enabling device (0000 -> 0002)642second # [ 0.387030] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)643second # [ 0.389167] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)644second # [ 0.399387] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled645test # [ 0.349864] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)646second # [ 0.400427] msm_serial: driver initialized647second # [ 0.400495] SuperH (H)SCI(F) driver initialized648second # [ 0.400533] STM32 USART driver initialized649test # [ 0.352389] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)650test # [ 0.354235] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)651test # [ 0.363488] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)652test # [ 0.365210] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)653second # [ 0.422394] loop: module loaded654second # [ 0.422521] virtio_blk virtio5: 1/0/0 default/read/poll queues655second # [ 0.423214] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)656test # [ 0.367958] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)657test # [ 0.369808] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)658test # [ 0.377616] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)659second # [ 0.427287] megasas: 07.734.00.00-rc1660second # [ 0.427853] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]661second # [ 0.430107] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000662second # [ 0.430130] Intel/Sharp Extended Query Table at 0x0031663test # [ 0.383380] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)664test # [ 0.385382] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)665second # [ 0.439900] Using buffer write method666second # [ 0.439957] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]667second # [ 0.442627] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000668second # [ 0.442641] Intel/Sharp Extended Query Table at 0x0031669test # [ 0.395636] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)670second # [ 0.451823] Using buffer write method671second # [ 0.451840] Concatenating MTD devices:672second # [ 0.451842] (0): "0.flash"673second # [ 0.451844] (1): "0.flash"674second # [ 0.451846] into device "0.flash"675test # [ 0.406934] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled676test # [ 0.407993] msm_serial: driver initialized677test # [ 0.408090] SuperH (H)SCI(F) driver initialized678test # [ 0.408131] STM32 USART driver initialized679test # [ 0.432414] loop: module loaded680test # [ 0.432546] virtio_blk virtio5: 1/0/0 default/read/poll queues681test # [ 0.433117] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682test # [ 0.438710] megasas: 07.734.00.00-rc1683test # [ 0.439192] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]684test # [ 0.444884] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000685test # [ 0.444907] Intel/Sharp Extended Query Table at 0x0031686test # [ 0.454328] Using buffer write method687test # [ 0.454383] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]688test # [ 0.456137] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689test # [ 0.456150] Intel/Sharp Extended Query Table at 0x0031690test # [ 0.457841] Using buffer write method691test # [ 0.457854] Concatenating MTD devices:692test # [ 0.457856] (0): "0.flash"693test # [ 0.457858] (1): "0.flash"694test # [ 0.457859] into device "0.flash"695second # [ 0.648503] Freeing initrd memory: 25500K696second # [ 0.655256] tun: Universal TUN/TAP device driver, 1.6697second # [ 0.657488] thunder_xcv, ver 1.0698second # [ 0.657502] thunder_bgx, ver 1.0699second # [ 0.657510] nicpf, ver 1.0700second # [ 0.657802] e1000: Intel(R) PRO/1000 Network Driver701second # [ 0.657806] e1000: Copyright (c) 1999-2006 Intel Corporation.702second # [ 0.657817] e1000e: Intel(R) PRO/1000 Network Driver703second # [ 0.657822] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.704second # [ 0.657833] igb: Intel(R) Gigabit Ethernet Network Driver705second # [ 0.657835] igb: Copyright (c) 2007-2014 Intel Corporation.706second # [ 0.657844] igbvf: Intel(R) Gigabit Virtual Function Network Driver707second # [ 0.657846] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.708second # [ 0.657907] sky2: driver version 1.30709second # [ 0.658720] usbcore: registered new interface driver usb-storage710second # [ 0.658793] usbcore: registered new interface driver usbserial_generic711second # [ 0.658810] usbserial: USB Serial support registered for generic712second # [ 0.665564] ehci-pci 0000:00:0a.0: EHCI Host Controller713second # [ 0.665589] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1714second # [ 0.665886] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000715second # [ 0.666220] hv_vmbus: registering driver hyperv_keyboard716second # [ 0.666787] rtc-pl031 9010000.pl031: registered as rtc0717second # [ 0.666814] rtc-pl031 9010000.pl031: setting system clock to 2026-10-02T05:36:48 UTC (1790919408)718second # [ 0.669802] i2c_dev: i2c /dev entries driver719second # [ 0.671813] sdhci: Secure Digital Host Controller Interface driver720second # [ 0.671817] sdhci: Copyright(c) Pierre Ossman721second # [ 0.671994] Synopsys Designware Multimedia Card Interface Driver722second # [ 0.672176] sdhci-pltfm: SDHCI platform and OF driver helper723second # [ 0.673039] hid: raw HID events driver (C) Jiri Kosina724second # [ 0.673195] usbcore: registered new interface driver usbhid725second # [ 0.673198] usbhid: USB HID core driver726second # [ 0.673856] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available727second # [ 0.674658] drop_monitor: Initializing network drop monitor service728second # [ 0.674815] NET: Registered PF_INET6 protocol family729second # [ 0.674928] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00730second # [ 0.675302] hub 1-0:1.0: USB hub found731second # [ 0.675329] hub 1-0:1.0: 6 ports detected732second # [ 0.681372] Segment Routing with IPv6733second # [ 0.681391] In-situ OAM (IOAM) with IPv6734second # [ 0.681435] NET: Registered PF_PACKET protocol family735second # [ 0.681503] 9pnet: Installing 9P2000 support736second # [ 0.684383] Key type dns_resolver registered737second # [ 0.687605] registered taskstats version 1738second # [ 0.687751] Loading compiled-in X.509 certificates739second # [ 0.693004] Demotion targets for Node 0: null740second # [ 0.693083] Key type .fscrypt registered741second # [ 0.693086] Key type fscrypt-provisioning registered742second # [ 0.693185] ima: No TPM chip found, activating TPM-bypass!743second # [ 0.693196] ima: Allocated hash algorithm: sha1744second # [ 0.693246] ima: No architecture policies found745second # [ 0.693745] input: gpio-keys as /devices/platform/gpio-keys/input/input0746second # [ 0.706254] clk: Disabling unused clocks747second # [ 0.706267] PM: genpd: Disabling unused power domains748test # [ 0.656908] Freeing initrd memory: 25504K749second # [ 0.709498] Freeing unused kernel memory: 4736K750second # [ 0.709594] Run /init as init process751test # [ 0.664935] tun: Universal TUN/TAP device driver, 1.6752test # [ 0.667640] thunder_xcv, ver 1.0753test # [ 0.667656] thunder_bgx, ver 1.0754test # [ 0.667664] nicpf, ver 1.0755test # [ 0.667971] e1000: Intel(R) PRO/1000 Network Driver756test # [ 0.667974] e1000: Copyright (c) 1999-2006 Intel Corporation.757test # [ 0.667987] e1000e: Intel(R) PRO/1000 Network Driver758test # [ 0.667991] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.759test # [ 0.668003] igb: Intel(R) Gigabit Ethernet Network Driver760test # [ 0.668005] igb: Copyright (c) 2007-2014 Intel Corporation.761test # [ 0.668015] igbvf: Intel(R) Gigabit Virtual Function Network Driver762test # [ 0.668017] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.763test # [ 0.668083] sky2: driver version 1.30764test # [ 0.668961] usbcore: registered new interface driver usb-storage765test # [ 0.669035] usbcore: registered new interface driver usbserial_generic766test # [ 0.669053] usbserial: USB Serial support registered for generic767test # [ 0.669360] hv_vmbus: registering driver hyperv_keyboard768second # [ 0.729427] systemd[1]: Successfully made /usr/ read-only.769test # [ 0.676789] ehci-pci 0000:00:0a.0: EHCI Host Controller770test # [ 0.676821] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1771test # [ 0.677068] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000772test # [ 0.677239] rtc-pl031 9010000.pl031: registered as rtc0773test # [ 0.677270] rtc-pl031 9010000.pl031: setting system clock to 2026-10-02T05:36:48 UTC (1790919408)774test # [ 0.677449] i2c_dev: i2c /dev entries driver775test # [ 0.679099] sdhci: Secure Digital Host Controller Interface driver776test # [ 0.679104] sdhci: Copyright(c) Pierre Ossman777test # [ 0.679278] Synopsys Designware Multimedia Card Interface Driver778test # [ 0.679466] sdhci-pltfm: SDHCI platform and OF driver helper779test # [ 0.680341] hid: raw HID events driver (C) Jiri Kosina780test # [ 0.680480] usbcore: registered new interface driver usbhid781test # [ 0.680483] usbhid: USB HID core driver782test # [ 0.686746] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00783test # [ 0.687135] hub 1-0:1.0: USB hub found784test # [ 0.687159] hub 1-0:1.0: 6 ports detected785test # [ 0.687498] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available786test # [ 0.688330] drop_monitor: Initializing network drop monitor service787test # [ 0.688478] NET: Registered PF_INET6 protocol family788test # [ 0.689097] Segment Routing with IPv6789test # [ 0.689125] In-situ OAM (IOAM) with IPv6790test # [ 0.689172] NET: Registered PF_PACKET protocol family791test # [ 0.689236] 9pnet: Installing 9P2000 support792test # [ 0.694718] Key type dns_resolver registered793test # [ 0.697545] registered taskstats version 1794test # [ 0.697687] Loading compiled-in X.509 certificates795test # [ 0.703624] Demotion targets for Node 0: null796test # [ 0.703703] Key type .fscrypt registered797test # [ 0.703706] Key type fscrypt-provisioning registered798test # [ 0.703807] ima: No TPM chip found, activating TPM-bypass!799test # [ 0.703817] ima: Allocated hash algorithm: sha1800test # [ 0.703867] ima: No architecture policies found801test # [ 0.704332] input: gpio-keys as /devices/platform/gpio-keys/input/input0802test # [ 0.716765] clk: Disabling unused clocks803test # [ 0.716774] PM: genpd: Disabling unused power domains804test # [ 0.719959] Freeing unused kernel memory: 4736K805test # [ 0.720044] Run /init as init process806test # [ 0.740601] systemd[1]: Successfully made /usr/ read-only.807second # [ 0.926946] usb 1-1: new high-speed USB device number 2 using ehci-pci808test # [ 0.938337] usb 1-1: new high-speed USB device number 2 using ehci-pci809second # [ 1.063314] 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.063346] systemd[1]: Detected virtualization qemu.811second # [ 1.063385] systemd[1]: Detected architecture arm64.812second # [ 1.063395] systemd[1]: Running in initrd.813second # [ 1.064438] systemd[1]: Initializing machine ID from random generator.814second # [ 1.064711] systemd[1]: Hostname set to <second>.815second # [ 1.086080] 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.074820] 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.074850] systemd[1]: Detected virtualization qemu.818test # [ 1.074922] systemd[1]: Detected architecture arm64.819test # [ 1.074931] systemd[1]: Running in initrd.820test # [ 1.076015] systemd[1]: Initializing machine ID from random generator.821test # [ 1.076338] systemd[1]: Hostname set to <test>.822second # [ 1.160159] systemd[1]: Queued start job for default target Initrd Default Target.823test # [ 1.106524] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1824second # [ 1.168364] systemd[1]: Created slice Slice /system/modprobe.825second # [ 1.168530] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.826second # [ 1.168553] systemd[1]: Expecting device /dev/disk/by-label/nixos...827second # [ 1.168573] systemd[1]: Reached target Path Units.828second # [ 1.168587] systemd[1]: Reached target Slice Units.829second # [ 1.168600] systemd[1]: Reached target Swaps.830second # [ 1.168613] systemd[1]: Reached target Timer Units.831second # [ 1.168759] systemd[1]: Listening on D-Bus System Message Bus Socket.832second # [ 1.168847] systemd[1]: Listening on Journal Socket (/dev/log).833second # [ 1.168998] systemd[1]: Listening on Journal Sockets.834second # [ 1.169076] systemd[1]: Listening on udev Control Socket.835second # [ 1.169127] systemd[1]: Listening on udev Kernel Socket.836second # [ 1.169143] systemd[1]: Reached target Socket Units.837second # [ 1.170170] systemd[1]: Starting Create List of Static Device Nodes...838second # [ 1.178639] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0839second # [ 1.186068] systemd[1]: Starting Load Kernel Module 9pnet_virtio...840second # [ 1.186121] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs841second # [ 1.189255] systemd[1]: Mounting Kernel Configuration File System...842second # [ 1.198834] systemd[1]: Starting Journal Service...843second # [ 1.211475] systemd[1]: Starting Load Kernel Modules...844second # [ 1.211519] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki845second # [ 1.227132] systemd[1]: Starting Coldplug All udev Devices...846second # [ 1.231504] systemd[1]: Finished Create List of Static Device Nodes.847second # [ 1.233042] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.848second # [ 1.233227] systemd[1]: Finished Load Kernel Module 9pnet_virtio.849test # [ 1.194279] systemd[1]: Queued start job for default target Initrd Default Target.850test # [ 1.194474] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0851second # [ 1.248473] systemd-journald[73]: Collecting audit messages is disabled.852test # [ 1.203881] systemd[1]: Created slice Slice /system/modprobe.853test # [ 1.204094] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.854test # [ 1.204119] systemd[1]: Expecting device /dev/disk/by-label/nixos...855test # [ 1.204142] systemd[1]: Reached target Path Units.856test # [ 1.204155] systemd[1]: Reached target Slice Units.857test # [ 1.204170] systemd[1]: Reached target Swaps.858test # [ 1.204185] systemd[1]: Reached target Timer Units.859test # [ 1.204349] systemd[1]: Listening on D-Bus System Message Bus Socket.860second # [ 1.259020] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...861test # [ 1.204480] systemd[1]: Listening on Journal Socket (/dev/log).862second # [ 1.259261] systemd[1]: Mounted Kernel Configuration File System.863test # [ 1.204600] systemd[1]: Listening on Journal Sockets.864test # [ 1.204681] systemd[1]: Listening on udev Control Socket.865test # [ 1.204776] systemd[1]: Listening on udev Kernel Socket.866test # [ 1.204797] systemd[1]: Reached target Socket Units.867test # [ 1.206030] systemd[1]: Starting Create List of Static Device Nodes...868test # [ 1.221198] systemd[1]: Starting Load Kernel Module 9pnet_virtio...869test # [ 1.221255] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs870test # [ 1.222262] systemd[1]: Mounting Kernel Configuration File System...871second # [ 1.287400] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.872second # [ 1.293044] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.873second # [ 1.294116] systemd[1]: Starting Create Static Device Nodes in /dev...874test # [ 1.242591] systemd[1]: Starting Journal Service...875second # [ 1.296045] usb 1-2: new high-speed USB device number 3 using ehci-pci876test # [ 1.257708] systemd[1]: Starting Load Kernel Modules...877second # [ 1.306956] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev878test # [ 1.257768] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki879test # [ 1.262976] systemd[1]: Starting Coldplug All udev Devices...880test # [ 1.267050] systemd[1]: Finished Create List of Static Device Nodes.881test # [ 1.268192] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.882second # [ 1.319974] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0883second # [ 1.320202] [drm] features: -virgl +edid -resource_blob -host_visible884second # [ 1.320204] [drm] features: -context_init885second # [ 1.320684] [drm] number of scanouts: 1886second # [ 1.320694] [drm] number of cap sets: 0887second # [ 1.321255] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic888second # [ 1.321261] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0889test # [ 1.274415] systemd[1]: Finished Load Kernel Module 9pnet_virtio.890test # [ 1.274880] systemd[1]: Mounted Kernel Configuration File System.891test # [ 1.284019] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...892second # [ 1.345050] systemd[1]: Finished Create Static Device Nodes in /dev.893second # [ 1.345188] systemd[1]: Reached target Preparation for Local File Systems.894second # [ 1.345209] systemd[1]: Reached target Local File Systems.895second # [ 1.346362] systemd[1]: Starting Rule-based Manager for Device Events and Files...896second # [ 1.349390] Console: switching to colour frame buffer device 160x50897second # [ 1.357090] systemd[1]: Started Journal Service.898second # [ 1.370504] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device899test # [ 1.314346] usb 1-2: new high-speed USB device number 3 using ehci-pci900test # [ 1.316825] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.901test # [ 1.317902] systemd[1]: Starting Create Static Device Nodes in /dev...902second # [ 1.351592] systemd-modules-load[74]: Inserted module 'dm_mod'903second # [ 1.368277] systemd-modules-load[74]: Module 'virtio_balloon' is built in904second # [ 1.369187] systemd-modules-load[74]: Module 'virtio_console' is built in905second # [ 1.369844] systemd-modules-load[74]: Inserted module 'virtio_gpu'906second # [ 1.370473] systemd-modules-load[74]: Module 'virtio_rng' is built in907second # [ 1.371101] systemd[1]: Starting Create System Files and Directories...908test # [ 1.329673] systemd-journald[73]: Collecting audit messages is disabled.909test # [ 1.334443] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.910second # [ 1.381048] systemd[1]: Finished Load Kernel Modules.911test # [ 1.346411] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev912test # [ 1.362907] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0913test # [ 1.363111] [drm] features: -virgl +edid -resource_blob -host_visible914test # [ 1.363113] [drm] features: -context_init915test # [ 1.363597] [drm] number of scanouts: 1916test # [ 1.363606] [drm] number of cap sets: 0917second # [ 1.409257] systemd[1]: Starting Apply Kernel Variables...918test # [ 1.365913] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic919second # [ 1.409885] systemd[1]: Finished Create System Files and Directories.920test # [ 1.365919] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0921second # [ 1.418313] systemd-udevd[80]: Using default interface naming scheme 'v260'.922test # [ 1.374702] systemd[1]: Finished Create Static Device Nodes in /dev.923test # [ 1.374833] systemd[1]: Reached target Preparation for Local File Systems.924test # [ 1.374854] systemd[1]: Reached target Local File Systems.925test # [ 1.376027] systemd[1]: Starting Rule-based Manager for Device Events and Files...926second # [ 1.429955] systemd[1]: Finished Apply Kernel Variables.927test # [ 1.392479] Console: switching to colour frame buffer device 160x50928second # [ 1.448559] 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/input2929second # [ 1.448728] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0930second # [ 1.452117] systemd[1]: Started Rule-based Manager for Device Events and Files.931test # [ 1.414845] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device932test # [ 1.415695] systemd-modules-load[74]: Inserted module 'dm_mod'933test # [ 1.423331] systemd[1]: Finished Load Kernel Modules.934test # [ 1.427724] systemd[1]: Starting Apply Kernel Variables...935test # [ 1.427945] systemd[1]: Started Journal Service.936test # [ 1.428418] systemd-modules-load[74]: Module 'virtio_balloon' is built in937test # [ 1.429212] systemd-modules-load[74]: Module 'virtio_console' is built in938test # [ 1.429880] systemd-modules-load[74]: Inserted module 'virtio_gpu'939test # [ 1.430629] systemd-modules-load[74]: Module 'virtio_rng' is built in940test # [ 1.452414] systemd-udevd[80]: Using default interface naming scheme 'v260'.941test # [ 1.456209] systemd[1]: Starting Create System Files and Directories...942test # [ 1.475204] 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.475387] 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.485021] systemd[1]: Finished Apply Kernel Variables.945second # [ 1.540743] systemd[1]: Starting Virtual Console Setup...946test # [ 1.497019] systemd[1]: Started Rule-based Manager for Device Events and Files.947test # [ 1.498306] systemd[1]: Finished Create System Files and Directories.948test # [ 1.542017] systemd[1]: Starting Virtual Console Setup...949second # [ 1.593595] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.950second # [ 1.594615] systemd[1]: Finished Virtual Console Setup.951test # [ 1.595648] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.952test # [ 1.600194] systemd[1]: Finished Virtual Console Setup.953second # [ 1.843281] systemd[1]: Finished Coldplug All udev Devices.954second # [ 1.843850] systemd[1]: Reached target System Initialization.955second # [ 1.844432] systemd[1]: Reached target Basic System.956test # [ 1.869810] systemd[1]: Finished Coldplug All udev Devices.957test # [ 1.870394] systemd[1]: Reached target System Initialization.958test # [ 1.870870] systemd[1]: Reached target Basic System.959second # [ 1.955802] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.960second # [ 1.973337] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.961second # [ 2.029652] systemd[1]: Found device /dev/disk/by-label/nixos.962test # [ 1.982592] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.963second # [ 2.036831] systemd[1]: Reached target Initrd Root Device.964second # [ 2.040136] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...965test # [ 1.999388] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.966second # [ 2.079424] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks967second # [ 2.098410] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.968test # [ 2.047444] systemd[1]: Found device /dev/disk/by-label/nixos.969test # [ 2.049856] systemd[1]: Reached target Initrd Root Device.970test # [ 2.052165] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...971test # [ 2.097928] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks972test # [ 2.105514] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.973second # [ 2.220114] systemd[1]: Mounting /sysroot...974second # [ 2.247232] systemd[1]: Mounted /sysroot.975second # [ 2.255677] EXT4-fs (vda): mounted filesystem 310cb11f-273b-4fff-9e5b-eabf9989aa9a r/w with ordered data mode. Quota mode: none.976second # [ 2.250898] systemd[1]: Reached target Initrd Root File System.977second # [ 2.259228] systemd[1]: Starting Mountpoints Configured in the Real Root...978second # [ 2.274442] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.979second # [ 2.280058] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...980second # [ 2.281782] systemd[1]: Reloading...981test # [ 2.255329] systemd[1]: Mounting /sysroot...982test # [ 2.279913] systemd[1]: Mounted /sysroot.[ 2.287614] EXT4-fs (vda): mounted filesystem a7d97bec-f338-4b31-bc3c-b01d549e5c8e r/w with ordered data mode. Quota mode: none.983test # 984test # [ 2.282247] systemd[1]: Reached target Initrd Root File System.985test # [ 2.283643] systemd[1]: Starting Mountpoints Configured in the Real Root...986test # [ 2.302132] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.987test # [ 2.306257] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...988test # [ 2.309777] systemd[1]: Reloading...989second # [ 2.468836] systemd[1]: Reloading finished in 188 ms.990second # [ 2.479814] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...991second # [ 2.482551] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...992second # [ 2.485471] systemd[1]: initrd-parse-etc.service: Deactivated successfully.993second # [ 2.488132] systemd[1]: Finished Mountpoints Configured in the Real Root.994second # [ 2.489674] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.995second # [ 2.493218] systemd[1]: Starting Load Kernel Module 9pnet_virtio...996second # [ 2.512124] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.997second # [ 2.513106] systemd[1]: Finished Load Kernel Module 9pnet_virtio.998test # [ 2.492621] systemd[1]: Reloading finished in 183 ms.999test # [ 2.499840] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1000test # [ 2.502199] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1001test # [ 2.505781] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1002test # [ 2.507545] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1003test # [ 2.514689] systemd[1]: Finished Mountpoints Configured in the Real Root.1004test # [ 2.515384] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1005test # [ 2.532275] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1006test # [ 2.532987] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1007second # [ 2.857166] (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 directory1008second # [ 2.860167] (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 directory1009second # [ 2.873115] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1010second # [ 2.875059] systemd[1]: Stopped Virtual Console Setup.1011second # [ 2.875886] systemd[1]: Stopping Virtual Console Setup...1012second # [ 2.877835] systemd[1]: Starting Virtual Console Setup...1013second # [ 2.891669] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1014second # [ 2.893547] systemd[1]: Stopped Virtual Console Setup.1015second # [ 2.896130] systemd[1]: Starting Virtual Console Setup...1016second # [ 2.914970] systemd-vconsole-setup[145]: Configuration of first virtual console was skipped, ignoring remaining ones.1017second # [ 2.917372] systemd[1]: Finished Virtual Console Setup.1018test # [ 2.899193] (udev-worker)[100]: mtd0ro: Failed to find and pin callout binary "/nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/lib/udev/mtd_probe": No such file or directory1019test # [ 2.903290] (udev-worker)[100]: 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 directory1020test # [ 2.917956] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1021test # [ 2.920098] systemd[1]: Stopped Virtual Console Setup.1022test # [ 2.921164] systemd[1]: Stopping Virtual Console Setup...1023test # [ 2.923771] systemd[1]: Starting Virtual Console Setup...1024test # [ 2.940577] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1025test # [ 2.941530] systemd[1]: Stopped Virtual Console Setup.1026test # [ 2.942982] systemd[1]: Starting Virtual Console Setup...1027test # [ 2.957755] systemd-vconsole-setup[144]: Configuration of first virtual console was skipped, ignoring remaining ones.1028test # [ 2.959992] systemd[1]: Finished Virtual Console Setup.1029second # [ 3.222160] systemd[1]: Mounting /sysroot/nix/.ro-store...1030second # [ 3.233587] systemd[1]: Mounting /sysroot/nix/.rw-store...1031second # [ 3.235376] systemd[1]: Mounting /sysroot/run...1032second # [ 3.248731] systemd[1]: Mounting /sysroot/tmp/shared...1033second # [ 3.261600] systemd[1]: Mounting /sysroot/tmp/xchg...1034second # [ 3.295607] systemd[1]: Mounted /sysroot/nix/.rw-store.1035second # [ 3.302236] systemd[1]: Mounted /sysroot/nix/.ro-store.1036second # [ 3.306464] systemd[1]: Mounted /sysroot/run.1037second # [ 3.309774] systemd[1]: Mounted /sysroot/tmp/shared.1038test # [ 3.258908] systemd[1]: Mounting /sysroot/nix/.ro-store...1039second # [ 3.317463] systemd[1]: Starting rw-sysroot-nix-store.service...1040second # [ 3.319850] systemd[1]: Mounted /sysroot/tmp/xchg.1041test # [ 3.268312] systemd[1]: Mounting /sysroot/nix/.rw-store...1042test # [ 3.275034] systemd[1]: Mounting /sysroot/run...1043second # [ 3.333507] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1044second # [ 3.334618] systemd[1]: Finished rw-sysroot-nix-store.service.1045test # [ 3.290117] systemd[1]: Mounting /sysroot/tmp/shared...1046test # [ 3.310941] systemd[1]: Mounting /sysroot/tmp/xchg...1047test # [ 3.324784] systemd[1]: Mounted /sysroot/nix/.rw-store.1048test # [ 3.334525] systemd[1]: Starting rw-sysroot-nix-store.service...1049test # [ 3.343886] systemd[1]: Mounted /sysroot/nix/.ro-store.1050test # [ 3.347911] systemd[1]: Mounted /sysroot/run.1051test # [ 3.349598] systemd[1]: Mounted /sysroot/tmp/shared.1052test # [ 3.363982] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1053test # [ 3.364909] systemd[1]: Finished rw-sysroot-nix-store.service.1054test # [ 3.368276] systemd[1]: Mounting /sysroot/nix/store...1055test # [ 3.369801] systemd[1]: Mounted /sysroot/tmp/xchg.1056test # [ 3.397782] systemd[1]: Mounted /sysroot/nix/store.1057test # [ 3.398674] systemd[1]: Reached target Initrd File Systems.1058test # [ 3.400352] systemd[1]: Starting Find NixOS closure...1059test # [ 3.407856] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1060test # [ 3.433864] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1061test # [ 3.444335] systemd[1]: Finished Find NixOS closure.1062test # [ 3.446451] systemd[1]: Reached target Initrd Default Target.1063test # [ 3.448221] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1064test # [ 3.474855] systemd[1]: initrd-cleanup.service: Deactivated successfully.1065test # [ 3.476055] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1066test # [ 3.478780] systemd[1]: Stopped target Initrd Default Target.1067test # [ 3.479847] systemd[1]: Stopped target Basic System.1068test # [ 3.482518] systemd[1]: Stopped target Initrd Root Device.1069test # [ 3.483144] systemd[1]: Stopped target Path Units.1070test # [ 3.483692] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1071test # [ 3.485364] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1072test # [ 3.487083] systemd[1]: Stopped target Slice Units.1073test # [ 3.491784] systemd[1]: Stopped target Socket Units.1074test # [ 3.492437] systemd[1]: Stopped target System Initialization.1075test # [ 3.493320] systemd[1]: Stopped target Swaps.1076test # [ 3.493803] systemd[1]: Stopped target Timer Units.1077test # [ 3.494296] systemd[1]: dbus.socket: Deactivated successfully.1078test # [ 3.494872] systemd[1]: Closed D-Bus System Message Bus Socket.1079test # [ 3.495458] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1080test # [ 3.504174] systemd[1]: Stopped Find NixOS closure.1081test # [ 3.504652] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1082test # [ 3.505320] systemd[1]: Starting rw-sysroot-nix-store.service...1083test # [ 3.505871] systemd[1]: systemd-sysctl.service: Deactivated successfully.1084test # [ 3.506477] systemd[1]: Stopped Apply Kernel Variables.1085test # [ 3.506960] systemd[1]: systemd-modules-load.service: Deactivated successfully.1086test # [ 3.507594] systemd[1]: Stopped Load Kernel Modules.1087test # [ 3.510742] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1088test # [ 3.511466] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1089test # [ 3.512284] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1090test # [ 3.513083] systemd[1]: Stopped Create System Files and Directories.1091test # [ 3.513652] systemd[1]: Stopped target Local File Systems.1092test # [ 3.514127] systemd[1]: Stopped target Preparation for Local File Systems.1093test # [ 3.514693] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1094test # [ 3.515296] systemd[1]: Stopped Coldplug All udev Devices.1095test # [ 3.515764] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1096test # [ 3.528243] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1097test # [ 3.529011] systemd[1]: Stopped Virtual Console Setup.1098test # [ 3.529572] systemd[1]: systemd-udevd.service: Deactivated successfully.1099test # [ 3.530214] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1100test # [ 3.532310] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1101test # [ 3.532951] systemd[1]: Closed udev Control Socket.1102test # [ 3.533899] systemd[1]: Starting Cleanup udev Database...1103test # [ 3.534862] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1104test # [ 3.536269] systemd[1]: Stopped Create Static Device Nodes in /dev.1105test # [ 3.537172] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1106test # [ 3.538561] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1107test # [ 3.539186] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1108test # [ 3.539754] systemd[1]: Stopped Create List of Static Device Nodes.1109test # [ 3.540386] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1110test # [ 3.541034] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1111test # [ 3.541544] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1112test # [ 3.542123] systemd[1]: Finished rw-sysroot-nix-store.service.1113test # [ 3.559484] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1114test # [ 3.561907] systemd[1]: Finished Cleanup udev Database.1115test # [ 3.562378] systemd[1]: Reached target Switch Root.1116test # [ 3.563075] systemd[1]: Starting NixOS Activation...1117test # [ 3.760780] initrd-nixos-activation-start[181]: booting system configuration /nix/store/ahf9gzwzi9csh09wax04dzqd5jng77s7-nixos-system-test-test1118test # [ 3.833371] initrd-nixos-activation-start[181]: running activation script...1119second # [ 4.219280] systemd[1]: Mounting /sysroot/nix/store...1120second # [ 4.266657] systemd[1]: Mounted /sysroot/nix/store.1121second # [ 4.268928] systemd[1]: Reached target Initrd File Systems.1122second # [ 4.272987] systemd[1]: Starting Find NixOS closure...1123second # [ 4.284621] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1124second # [ 4.320119] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1125second # [ 4.321951] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1126second # [ 4.337762] systemd[1]: Finished Find NixOS closure.1127second # [ 4.339869] systemd[1]: Reached target Initrd Default Target.1128second # [ 4.344270] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1129second # [ 4.365499] systemd[1]: Stopped target Initrd Default Target.1130second # [ 4.366371] systemd[1]: Stopped target Basic System.1131second # [ 4.367021] systemd[1]: Stopped target Initrd Root Device.1132second # [ 4.368216] systemd[1]: Stopped target Path Units.1133second # [ 4.370544] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1134second # [ 4.371198] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1135second # [ 4.371821] systemd[1]: Stopped target Slice Units.1136second # [ 4.373384] systemd[1]: Stopped target Socket Units.1137second # [ 4.373830] systemd[1]: Stopped target System Initialization.1138second # [ 4.376090] systemd[1]: Stopped target Swaps.1139second # [ 4.376526] systemd[1]: Stopped target Timer Units.1140second # [ 4.376969] systemd[1]: dbus.socket: Deactivated successfully.1141second # [ 4.380098] systemd[1]: Closed D-Bus System Message Bus Socket.1142second # [ 4.380649] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1143second # [ 4.381275] systemd[1]: Stopped Find NixOS closure.1144second # [ 4.381701] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1145test # [ 4.330314] initrd-nixos-activation-start[204]: setting up /etc...1146second # [ 4.382493] systemd[1]: Starting rw-sysroot-nix-store.service...1147second # [ 4.383171] systemd[1]: systemd-sysctl.service: Deactivated successfully.1148second # [ 4.385944] systemd[1]: Stopped Apply Kernel Variables.1149second # [ 4.386414] systemd[1]: systemd-modules-load.service: Deactivated successfully.1150second # [ 4.386994] systemd[1]: Stopped Load Kernel Modules.1151second # [ 4.387705] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1152second # [ 4.389901] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1153second # [ 4.393051] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1154second # [ 4.393982] systemd[1]: Stopped Create System Files and Directories.1155second # [ 4.395777] systemd[1]: Stopped target Local File Systems.1156second # [ 4.397887] systemd[1]: Stopped target Preparation for Local File Systems.1157second # [ 4.402021] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1158second # [ 4.402676] systemd[1]: Stopped Coldplug All udev Devices.1159second # [ 4.403622] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1160second # [ 4.409175] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1161second # [ 4.410562] systemd[1]: Stopped Virtual Console Setup.1162second # [ 4.413876] systemd[1]: initrd-cleanup.service: Deactivated successfully.1163second # [ 4.414565] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1164second # [ 4.416274] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1165second # [ 4.418003] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1166second # [ 4.418540] systemd[1]: systemd-udevd.service: Deactivated successfully.1167second # [ 4.419075] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1168second # [ 4.419649] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1169second # [ 4.422174] systemd[1]: Finished rw-sysroot-nix-store.service.1170second # [ 4.424335] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1171second # [ 4.424974] systemd[1]: Closed udev Control Socket.1172second # [ 4.425926] systemd[1]: Starting Cleanup udev Database...1173second # [ 4.428181] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1174second # [ 4.428850] systemd[1]: Stopped Create Static Device Nodes in /dev.1175second # [ 4.429368] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1176second # [ 4.430386] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1177second # [ 4.431393] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1178second # [ 4.432092] systemd[1]: Stopped Create List of Static Device Nodes.1179second # [ 4.451454] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1180second # [ 4.453812] systemd[1]: Finished Cleanup udev Database.1181second # [ 4.454285] systemd[1]: Reached target Switch Root.1182second # [ 4.456944] systemd[1]: Starting NixOS Activation...1183second # [ 4.638036] initrd-nixos-activation-start[182]: booting system configuration /nix/store/pqx07i8m96vqazxjzqkz0x63zvr28zlh-nixos-system-second-test1184test # [ 4.597729] initrd-nixos-activation-start[204]: setting up age secrets...1185second # [ 4.711565] initrd-nixos-activation-start[182]: running activation script...1186test # [ 4.926299] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1187test # [ 4.928143] systemd[1]: Finished NixOS Activation.1188test # [ 4.929068] systemd[1]: Starting Switch Root...1189test # [ 4.945881] systemd[1]: Switching root.1190test # [ 5.020528] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1191second # [ 5.225611] initrd-nixos-activation-start[205]: setting up /etc...1192second # [ 5.519274] initrd-nixos-activation-start[205]: setting up age secrets...1193test # [ 5.628273] 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)1194test # [ 5.628364] systemd[1]: Detected virtualization qemu.1195test # [ 5.628417] systemd[1]: Detected architecture arm64.1196test # [ 5.628523] systemd[1]: Detected first boot.1197test # [ 5.644246] systemd[1]: Initializing machine ID from random generator.1198second # [ 5.765279] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1199second # [ 5.767029] systemd[1]: Finished NixOS Activation.1200second # [ 5.767785] systemd[1]: Starting Switch Root...1201second # [ 5.780521] systemd[1]: Switching root.1202second # [ 5.840036] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1203test # [ 5.939095] systemd[1]: bpf-restrict-fs: LSM BPF program attached1204test # [ 6.130984] systemd[1]: Applying preset policy.1205second # [ 6.418677] 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)1206second # [ 6.418767] systemd[1]: Detected virtualization qemu.1207second # [ 6.418815] systemd[1]: Detected architecture arm64.1208second # [ 6.428172] systemd[1]: Detected first boot.1209second # [ 6.434508] systemd[1]: Initializing machine ID from random generator.1210second # [ 6.728091] systemd[1]: bpf-restrict-fs: LSM BPF program attached1211test # [ 6.728842] systemd[1]: Populated /etc with preset unit settings.1212second # [ 6.919390] systemd[1]: Applying preset policy.1213test # [ 7.292524] systemd[1]: initrd-switch-root.service: Deactivated successfully.1214test # [ 7.292823] systemd[1]: Stopped initrd-switch-root.service.1215test # [ 7.293855] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1216test # [ 7.297366] systemd[1]: Created slice Slice /system/getty.1217test # [ 7.297923] systemd[1]: Created slice User and Session Slice.1218test # [ 7.298114] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1219test # [ 7.300720] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1220test # [ 7.301244] systemd[1]: Expecting device /dev/hvc0...1221test # [ 7.301809] systemd[1]: Expecting device /dev/ttyAMA0...1222test # [ 7.304566] systemd[1]: Reached target Local Encrypted Volumes.1223test # [ 7.305077] systemd[1]: Stopped target initrd-fs.target.1224test # [ 7.305629] systemd[1]: Stopped target initrd-root-fs.target.1225test # [ 7.306187] systemd[1]: Stopped target initrd-switch-root.target.1226test # [ 7.309635] systemd[1]: Reached target Virtual Machines and Containers.1227test # [ 7.310151] systemd[1]: Reached target Path Units.1228test # [ 7.312197] systemd[1]: Reached target Remote File Systems.1229test # [ 7.312680] systemd[1]: Reached target Slice Units.1230test # [ 7.313223] systemd[1]: Reached target Swaps.1231test # [ 7.318605] systemd[1]: Listening on Process Core Dump Socket.1232test # [ 7.321886] systemd[1]: Listening on Credential Encryption/Decryption.1233test # [ 7.327212] systemd[1]: Starting Journal Log Access Socket...1234test # [ 7.328331] systemd[1]: Listening on Journal Audit Socket.1235test # [ 7.328984] systemd[1]: Listening on Network Management Metrics Varlink Socket.1236test # [ 7.329633] systemd[1]: Listening on Network Management Netlink Socket.1237test # [ 7.332628] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1238test # [ 7.333120] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1239test # [ 7.333767] systemd[1]: Listening on udev Control Socket.1240test # [ 7.339729] systemd[1]: Mounting Huge Pages File System...1241test # [ 7.343369] systemd[1]: Mounting POSIX Message Queue File System...1242test # [ 7.346201] systemd[1]: Mounting Kernel Debug File System...1243test # [ 7.354860] systemd[1]: Mounting Kernel Trace File System...1244test # [ 7.363034] systemd[1]: Starting Create List of Static Device Nodes...1245test # [ 7.371958] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1246test # [ 7.374887] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1247test # [ 7.385165] systemd[1]: Mounting Kernel Configuration File System...1248test # [ 7.387257] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1249test # [ 7.389626] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1250test # [ 7.405237] systemd[1]: Starting Load Kernel Module fuse...1251test # [ 7.407906] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671252test # [ 7.446912] systemd[1]: Starting Journal Service...1253second # [ 7.508985] systemd[1]: Populated /etc with preset unit settings.1254test # [ 7.476873] systemd[1]: Starting Load Kernel Modules...1255test # [ 7.502450] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1256test # [ 7.513492] systemd[1]: Starting Remount Root and Kernel File Systems...1257test # [ 7.515631] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1258test # [ 7.541595] systemd[1]: Starting Coldplug All udev Devices...1259test # [ 7.574815] systemd-journald[325]: Collecting audit messages is enabled.1260test # [ 7.576044] systemd[1]: Listening on Journal Log Access Socket.1261test # [ 7.580690] systemd[1]: Mounted Huge Pages File System.1262test # [ 7.581233] systemd[1]: Mounted POSIX Message Queue File System.1263test # [ 7.581626] systemd[1]: Mounted Kernel Debug File System.1264test # [ 7.581994] systemd[1]: Mounted Kernel Trace File System.1265test # [ 7.581485] systemd[1]: Queued start job for default target Multi-User System.1266test # [ 7.589526] fuse: init (API version 7.45)1267test # [ 7.586460] systemd[1]: systemd-journald.service: Deactivated successfully.1268test # [ 7.594393] systemd[1]: Finished Create List of Static Device Nodes.1269test # [ 7.595247] systemd[1]: Started Journal Service.1270test # [ 7.591056] systemd-modules-load[326]: Module 'atkbd' is built in1271test # [ 7.598160] systemd-modules-load[326]: Module 'ctr' is built in1272test # [ 7.603478] systemd-modules-load[326]: Module 'loop' is built in1273test # [ 7.612938] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1274test # [ 7.617821] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1275test # [ 7.624634] systemd[1]: Mounted Kernel Configuration File System.1276test # [ 7.627714] systemd[1]: Finished Load Kernel Modules.1277test # [ 7.632734] systemd[1]: modprobe@fuse.service: Deactivated successfully.1278test # [ 7.637892] systemd[1]: Finished Load Kernel Module fuse.1279test # [ 7.640402] systemd[1]: Mounting FUSE Control File System...1280test # [ 7.643465] systemd[1]: Starting Firewall...1281test # [ 7.664080] systemd[1]: Starting Apply Kernel Variables...1282test # [ 7.671877] EXT4-fs (vda): re-mounted a7d97bec-f338-4b31-bc3c-b01d549e5c8e.1283test # [ 7.680869] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1284test # [ 7.703590] systemd[1]: Finished Remount Root and Kernel File Systems.1285test # [ 7.716194] systemd-oomd[327]: No swap; memory pressure usage will be degraded1286test # [ 7.725547] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1287test # [ 7.751799] systemd[1]: Starting Flush Journal to Persistent Storage...1288test # [ 7.758515] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1289test # [ 7.768394] systemd[1]: Starting Load/Save OS Random Seed...1290test # [ 7.776785] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1291test # [ 7.823972] systemd[1]: Mounted FUSE Control File System.1292test # [ 7.860471] systemd[1]: Finished Apply Kernel Variables.1293test # [ 7.879193] systemd[1]: Starting Network Name Resolution...1294test # [ 7.893147] systemd-journald[325]: Received client request to flush runtime journal.1295test # [ 7.956509] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1296test # [ 7.962654] systemd[1]: Finished Load/Save OS Random Seed.1297test # [ 7.965901] systemd[1]: Reached target First Boot Complete.1298test # [ 7.973092] systemd[1]: Starting Create Static Device Nodes in /dev...1299test # [ 7.979598] systemd[1]: Finished Flush Journal to Persistent Storage.1300second # [ 8.075955] systemd[1]: initrd-switch-root.service: Deactivated successfully.1301second # [ 8.076316] systemd[1]: Stopped initrd-switch-root.service.1302second # [ 8.077359] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1303second # [ 8.078004] systemd[1]: Created slice Slice /system/getty.1304second # [ 8.078468] systemd[1]: Created slice User and Session Slice.1305second # [ 8.078570] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1306second # [ 8.078648] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1307second # [ 8.078684] systemd[1]: Expecting device /dev/hvc0...1308second # [ 8.078695] systemd[1]: Expecting device /dev/ttyAMA0...1309second # [ 8.084780] systemd[1]: Reached target Local Encrypted Volumes.1310second # [ 8.085297] systemd[1]: Stopped target initrd-fs.target.1311second # [ 8.085835] systemd[1]: Stopped target initrd-root-fs.target.1312second # [ 8.086376] systemd[1]: Stopped target initrd-switch-root.target.1313second # [ 8.089204] systemd[1]: Reached target Virtual Machines and Containers.1314second # [ 8.089700] systemd[1]: Reached target Path Units.1315second # [ 8.090409] systemd[1]: Reached target Remote File Systems.1316second # [ 8.092805] systemd[1]: Reached target Slice Units.1317second # [ 8.093281] systemd[1]: Reached target Swaps.1318second # [ 8.098066] systemd[1]: Listening on Process Core Dump Socket.1319second # [ 8.101869] systemd[1]: Listening on Credential Encryption/Decryption.1320second # [ 8.106568] systemd[1]: Starting Journal Log Access Socket...1321second # [ 8.108234] systemd[1]: Listening on Journal Audit Socket.1322second # [ 8.108875] systemd[1]: Listening on Network Management Metrics Varlink Socket.1323second # [ 8.109499] systemd[1]: Listening on Network Management Netlink Socket.1324second # [ 8.110184] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1325second # [ 8.110682] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1326second # [ 8.115286] systemd[1]: Listening on udev Control Socket.1327second # [ 8.119687] systemd[1]: Mounting Huge Pages File System...1328test # [ 8.061514] systemd-resolved[354]: Positive Trust Anchors:1329second # [ 8.122721] systemd[1]: Mounting POSIX Message Queue File System...1330test # [ 8.062562] systemd-resolved[354]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1331second # [ 8.127860] systemd[1]: Mounting Kernel Debug File System...1332test # [ 8.068596] systemd-resolved[354]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161333second # [ 8.135987] systemd[1]: Mounting Kernel Trace File System...1334second # [ 8.141071] systemd[1]: Starting Create List of Static Device Nodes...1335test # [ 8.072918] systemd-resolved[354]: 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 test1336second # [ 8.150740] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1337second # [ 8.152036] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1338second # [ 8.164824] systemd[1]: Mounting Kernel Configuration File System...1339test # [ 8.106301] systemd[1]: Finished Create Static Device Nodes in /dev.1340test # [ 8.106994] systemd[1]: Reached target Preparation for Local File Systems.1341second # [ 8.168065] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1342test # [ 8.109398] systemd[1]: Starting Rule-based Manager for Device Events and Files...1343second # [ 8.169283] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1344second # [ 8.186580] systemd[1]: Starting Load Kernel Module fuse...1345second # [ 8.188574] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671346second # [ 8.217959] systemd[1]: Starting Journal Service...1347second # [ 8.228298] systemd[1]: Starting Load Kernel Modules...1348second # [ 8.260941] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1349second # [ 8.278036] systemd[1]: Starting Remount Root and Kernel File Systems...1350test # [ 8.219327] systemd-udevd[369]: Using default interface naming scheme 'v260'.1351second # [ 8.284104] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1352second # [ 8.315987] systemd[1]: Starting Coldplug All udev Devices...1353second # [ 8.344068] systemd[1]: Listening on Journal Log Access Socket.1354second # [ 8.352301] fuse: init (API version 7.45)1355second # [ 8.353115] systemd-journald[305]: Collecting audit messages is enabled.1356test # [ 8.294469] systemd[1]: Mounting /run/wrappers...1357second # [ 8.356939] systemd[1]: Mounted Huge Pages File System.1358second # [ 8.357666] systemd[1]: Mounted POSIX Message Queue File System.1359second # [ 8.361520] systemd[1]: Mounted Kernel Debug File System.1360second # [ 8.366361] systemd[1]: Mounted Kernel Trace File System.1361second # [ 8.358841] systemd[1]: Queued start job for default target Multi-User System.1362second # [ 8.361276] systemd[1]: systemd-journald.service: Deactivated successfully.1363second # [ 8.362171] systemd-modules-load[306]: Module 'atkbd' is built in1364second # [ 8.362837] systemd-modules-load[306]: Module 'ctr' is built in1365second # [ 8.363464] systemd-modules-load[306]: Module 'loop' is built in1366second # [ 8.371567] systemd[1]: Started Journal Service.1367second # [ 8.375029] systemd[1]: Finished Create List of Static Device Nodes.1368second # [ 8.376194] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1369second # [ 8.378863] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1370second # [ 8.380952] systemd[1]: Mounted Kernel Configuration File System.1371second # [ 8.384990] systemd[1]: modprobe@fuse.service: Deactivated successfully.1372second # [ 8.387906] systemd[1]: Finished Load Kernel Module fuse.1373second # [ 8.393542] systemd[1]: Finished Load Kernel Modules.1374second # [ 8.403159] systemd[1]: Mounting FUSE Control File System...1375test # [ 8.352410] systemd-resolved[354]: Using system hostname 'test'.1376test # [ 8.358258] systemd[1]: Started Network Name Resolution.1377second # [ 8.410470] systemd[1]: Starting Firewall...1378test # [ 8.370479] systemd[1]: Mounted /run/wrappers.1379test # [ 8.372846] systemd[1]: Reached target Local File Systems.1380second # [ 8.425104] systemd[1]: Starting Apply Kernel Variables...1381test # [ 8.377081] systemd[1]: Listening on Boot Loader Control Service Socket.1382second # [ 8.439036] EXT4-fs (vda): re-mounted 310cb11f-273b-4fff-9e5b-eabf9989aa9a.1383test # [ 8.382896] systemd[1]: Starting register-nix-paths.service...1384test # [ 8.389858] systemd[1]: Starting Create SUID/SGID Wrappers...1385test # [ 8.390556] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1386test # [ 8.393682] systemd[1]: Starting Save Transient machine-id to Disk...1387second # [ 8.447377] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1388second # [ 8.464212] systemd[1]: Finished Remount Root and Kernel File Systems.1389test # [ 8.413375] systemd[1]: Starting Create System Files and Directories...1390second # [ 8.469868] systemd-oomd[307]: No swap; memory pressure usage will be degraded1391second # [ 8.479257] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1392second # [ 8.501668] systemd[1]: Starting Flush Journal to Persistent Storage...1393second # [ 8.505896] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1394second # [ 8.517506] systemd[1]: Starting Load/Save OS Random Seed...1395second # [ 8.527098] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1396second # [ 8.568911] systemd[1]: Mounted FUSE Control File System.1397second # [ 8.614109] systemd[1]: Finished Apply Kernel Variables.1398second # [ 8.628423] systemd-journald[305]: Received client request to flush runtime journal.1399test # [ 8.571479] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1400test # [ 8.574657] systemd[1]: Finished Save Transient machine-id to Disk.1401test # [ 8.632219] systemd[1]: Finished Create System Files and Directories.1402second # [ 8.689318] systemd[1]: Starting Network Name Resolution...1403test # [ 8.638138] systemd[1]: Started Rule-based Manager for Device Events and Files.1404second # [ 8.694369] systemd[1]: Finished Load/Save OS Random Seed.1405second # [ 8.697674] systemd[1]: Reached target First Boot Complete.1406test # [ 8.651001] systemd[1]: Starting Rebuild Journal Catalog...1407test # [ 8.655154] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1408second # [ 8.708296] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1409second # [ 8.715688] systemd[1]: Starting Create Static Device Nodes in /dev...1410second # [ 8.717591] systemd[1]: Finished Flush Journal to Persistent Storage.1411second # [ 8.808120] systemd-resolved[334]: Positive Trust Anchors:1412second # [ 8.810150] systemd-resolved[334]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1413second # [ 8.815922] systemd-resolved[334]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161414second # [ 8.820618] systemd-resolved[334]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1415test # [ 8.792246] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1416second # [ 8.853293] systemd[1]: Finished Create Static Device Nodes in /dev.1417second # [ 8.856527] systemd[1]: Reached target Preparation for Local File Systems.1418second # [ 8.857705] systemd[1]: Starting Rule-based Manager for Device Events and Files...1419test # [ 8.883299] systemd[1]: Finished Rebuild Journal Catalog.1420test # [ 8.895372] systemd[1]: Starting Update is Completed...1421second # [ 8.972107] systemd-udevd[349]: Using default interface naming scheme 'v260'.1422test # [ 8.965088] systemd[1]: Finished Coldplug All udev Devices.1423test # [ 8.978404] systemd[1]: Finished Update is Completed.1424second # [ 9.063170] systemd-resolved[334]: Using system hostname 'second'.1425second # [ 9.073619] systemd[1]: Mounting /run/wrappers...1426second # [ 9.076495] systemd[1]: Started Network Name Resolution.1427second # [ 9.143678] systemd[1]: Mounted /run/wrappers.1428second # [ 9.145335] systemd[1]: Reached target Local File Systems.1429second # [ 9.152233] systemd[1]: Listening on Boot Loader Control Service Socket.1430second # [ 9.159546] systemd[1]: Starting register-nix-paths.service...1431second # [ 9.164169] systemd[1]: Starting Create SUID/SGID Wrappers...1432second # [ 9.168267] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1433second # [ 9.172425] systemd[1]: Starting Save Transient machine-id to Disk...1434second # [ 9.209052] systemd[1]: Starting Create System Files and Directories...1435test # [ 9.213672] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1436second # [ 9.320897] systemd[1]: Started Rule-based Manager for Device Events and Files.1437second # [ 9.338231] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1438second # [ 9.348392] systemd[1]: Finished Save Transient machine-id to Disk.1439second # [ 9.390610] systemd[1]: Finished Create System Files and Directories.1440second # [ 9.407045] systemd[1]: Starting Rebuild Journal Catalog...1441second # [ 9.411316] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1442second # [ 9.540145] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1443test # [ 9.517744] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1444test # [ 9.535728] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1445test # [ 9.541810] systemd[1]: Finished Create SUID/SGID Wrappers.1446second # [ 9.628144] systemd[1]: Finished Rebuild Journal Catalog.1447second # [ 9.632805] systemd[1]: Starting Update is Completed...1448second # [ 9.635307] systemd[1]: Finished Coldplug All udev Devices.1449test # [ 9.608659] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1450second # [ 9.703663] systemd[1]: Finished Update is Completed.1451test # [ 9.772248] systemd[1]: Finished register-nix-paths.service.1452test # [ 9.772928] systemd[1]: Reached target System Initialization.1453test # [ 9.774837] systemd[1]: Started Discard unused filesystem blocks once a week.1454test # [ 9.778066] systemd[1]: Started Daily Cleanup of Temporary Directories.1455test # [ 9.782853] systemd[1]: Reached target Timer Units.1456test # [ 9.784174] systemd[1]: Listening on D-Bus System Message Bus Socket.1457second # [ 9.837365] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1458test # [ 9.787680] systemd[1]: Listening on Nix Daemon Socket.1459test # [ 9.790279] systemd[1]: Listening on Authorization Manager Agent Helper.1460test # [ 9.791875] systemd[1]: Listening on Hostname Service Socket.1461test # [ 9.795046] systemd[1]: Reached target Socket Units.1462test # [ 9.797658] systemd[1]: Starting D-Bus System Message Bus...1463test # [ 9.822378] systemd[1]: Finished Firewall.1464test # [ 9.822897] systemd[1]: Reached target Preparation for Network.1465test # [ 9.827014] systemd[1]: Starting Network Management...1466test # [ 9.908914] (udev-worker)[477]: Network interface NamePolicy= disabled on kernel command line.1467test # [ 9.923057] (udev-worker)[481]: Network interface NamePolicy= disabled on kernel command line.1468test # [ 10.004407] dbus-broker-launch[557]: Looking up NSS user entry for 'systemd-timesync'...1469test # [ 10.032279] dbus-broker-launch[557]: NSS returned no entry for 'systemd-timesync'1470test # [ 10.033050] dbus-broker-launch[557]: Invalid user-name in /nix/store/236xm2x98m17dcjqw8j9c8sni56gk6gg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1471second # [ 10.122526] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1472test # [ 10.082958] cfg80211: Loading compiled-in X.509 certificates for regulatory database1473test # [ 10.102327] dbus-broker-launch[557]: 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'1474test # [ 10.107530] dbus-broker-launch[557]: 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'1475test # [ 10.113082] dbus-broker-launch[557]: 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'1476test # [ 10.121861] dbus-broker-launch[557]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1477test # [ 10.130360] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1478test # [ 10.130849] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1479test # [ 10.133433] systemd[1]: Started D-Bus System Message Bus.1480second # [ 10.192409] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1481test # [ 10.138868] systemd[1]: Reached target Basic System.1482test # [ 10.143516] systemd[1]: Starting Network Manager Script Dispatcher Service...1483test # [ 10.147129] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1484test # [ 10.152179] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1485test # [ 10.176267] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1486second # [ 10.262518] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1487test # [ 10.207631] dbus-broker-launch[557]: Ready1488second # [ 10.264493] systemd[1]: Finished Create SUID/SGID Wrappers.1489test # [ 10.219554] systemd-networkd[559]: /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.1490test # [ 10.232719] systemd-networkd[559]: /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.1491test # [ 10.239540] systemd-networkd[559]: lo: Link UP1492test # [ 10.249083] systemd-networkd[559]: lo: Gained carrier1493test # [ 10.249683] systemd[1]: Starting Network Manager...1494test # [ 10.250168] systemd-networkd[559]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1495test # [ 10.251437] systemd-networkd[559]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1496test # [ 10.269215] systemd-networkd[559]: eth1: Link UP1497test # [ 10.277129] systemd-networkd[559]: eth1: Gained carrier1498test # [ 10.279296] systemd-networkd[559]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1499test # [ 10.286315] systemd[1]: Started backdoor.service.1500test # [ 10.300325] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1501test # [ 10.312039] mousedev: PS/2 mouse device common for all mice1502test # [ 10.317557] systemd[1]: Starting Import lastlog data into lastlog2 database...1503test # [ 10.329454] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1504test # [ 10.371263] 4bb5snallvknp7ll9gml95rlfxqybb0y-wifi-secrets[571]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1505test # [ 10.384251] systemd[1]: Starting Post-Boot Actions...1506test # [ 10.412502] 9zw00hrl9ri87shidqszb96sxar6g9fp-wifi-secrets[572]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1507test # [ 10.420796] systemd[1]: Started Reset console on configuration changes.1508test # [ 10.426097] systemd[1]: Started Network Management.1509second # [ 10.490360] systemd[1]: Finished Firewall.1510second # [ 10.490889] systemd[1]: Reached target Preparation for Network.1511second # [ 10.495381] systemd[1]: Starting Network Management...1512test # [ 10.464778] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1513second # [ 10.517172] (udev-worker)[440]: Network interface NamePolicy= disabled on kernel command line.1514second # [ 10.520832] (udev-worker)[439]: Network interface NamePolicy= disabled on kernel command line.1515test # [ 10.467604] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1516second # [ 10.536161] systemd[1]: Finished register-nix-paths.service.1517second # [ 10.536900] systemd[1]: Reached target System Initialization.1518test # [ 10.475202] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1519test # [ 10.486343] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1520second # [ 10.539923] systemd[1]: Started Discard unused filesystem blocks once a week.1521second # [ 10.542955] systemd[1]: Started Daily Cleanup of Temporary Directories.1522test # connecting to host...1523second # [ 10.545276] systemd[1]: Reached target Timer Units.1524second # [ 10.546686] systemd[1]: Listening on D-Bus System Message Bus Socket.1525second # [ 10.548724] systemd[1]: Listening on Nix Daemon Socket.1526test # [ 10.498351] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1527test # [ 10.499247] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1528second # [ 10.552903] systemd[1]: Listening on Authorization Manager Agent Helper.1529second # [ 10.555325] systemd[1]: Listening on Hostname Service Socket.1530second # [ 10.558343] systemd[1]: Reached target Socket Units.1531second # [ 10.562035] systemd[1]: Starting D-Bus System Message Bus...1532test # [ 10.554707] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1533test: Guest shell says: b'Spawning backdoor root shell...\n'1534test: connected to guest root shell1535test: (connecting took 10.86 seconds)1536test: (finished: waiting for the VM to finish booting, in 10.86 seconds)1537test # [ 10.563555] systemd[1]: Finished Post-Boot Actions.1538test # [ 10.644993] systemd[1]: Started Network Manager Script Dispatcher Service.1539test # [ 10.654916] systemd[1]: Started Name Service Cache Daemon (nsncd).1540test # [ 10.661518] nsncd[580]: Oct 02 05:36:58.489 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1541test # [ 10.662758] systemd[1]: Reached target Host and Network Name Lookups.1542test # [ 10.663291] systemd[1]: Reached target User and Group Name Lookups.1543test # [ 10.680168] systemd[1]: Starting User Login Management...1544second # [ 10.749376] cfg80211: Loading compiled-in X.509 certificates for regulatory database1545second # [ 10.764300] dbus-broker-launch[542]: Looking up NSS user entry for 'systemd-timesync'...1546test # [ 10.722192] systemd[1]: Finished Import lastlog data into lastlog2 database.1547second # [ 10.790027] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1548second # [ 10.790517] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1549test # [ 10.731083] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1550second # [ 10.786516] dbus-broker-launch[542]: NSS returned no entry for 'systemd-timesync'1551second # [ 10.787687] dbus-broker-launch[542]: Invalid user-name in /nix/store/236xm2x98m17dcjqw8j9c8sni56gk6gg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1552second # [ 10.805624] mousedev: PS/2 mouse device common for all mice1553second # [ 10.848514] systemd-networkd[537]: /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.1554second # [ 10.853343] dbus-broker-launch[542]: 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'1555test # [ 10.807197] systemd[1]: Starting Hostname Service...1556second # [ 10.861350] dbus-broker-launch[542]: 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'1557second # [ 10.868903] systemd-networkd[537]: /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.1558second # [ 10.882336] systemd-networkd[537]: lo: Link UP1559second # [ 10.886235] systemd-networkd[537]: lo: Gained carrier1560second # [ 10.890504] dbus-broker-launch[542]: 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'1561second # [ 10.899820] systemd[1]: Started Network Management.1562second # [ 10.901410] dbus-broker-launch[542]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1563test # [ 10.853934] systemd-logind[623]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1564test # [ 10.855514] systemd-logind[623]: Watching system buttons on /dev/input/event0 (gpio-keys)1565second # [ 10.912243] systemd-networkd[537]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1566test # [ 10.862307] systemd-logind[623]: New seat seat0.1567test # [ 10.862786] systemd[1]: Started User Login Management.1568second # [ 10.916986] systemd-networkd[537]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1569test # [ 10.867920] systemd[1]: Starting linger-users.service...1570second # [ 10.921173] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1571second # [ 10.921894] systemd[1]: Started D-Bus System Message Bus.1572second # [ 10.922410] systemd[1]: Reached target Basic System.1573second # [ 10.924259] systemd-networkd[537]: eth1: Link UP1574second # [ 10.930425] systemd-networkd[537]: eth1: Gained carrier1575second # [ 10.930930] systemd-networkd[537]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1576second # [ 10.939500] systemd[1]: Starting Network Manager Script Dispatcher Service...1577second # [ 10.940231] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1578second # [ 10.940887] systemd[1]: Starting Network Manager...1579second # [ 10.952096] systemd[1]: Started backdoor.service.1580second # [ 10.956900] dbus-broker-launch[542]: Ready1581second # [ 10.983493] systemd[1]: Starting Import lastlog data into lastlog2 database...1582test # [ 10.945043] systemd[1]: linger-users.service: Deactivated successfully.1583test # [ 10.950464] systemd[1]: Finished linger-users.service.1584second # [ 11.002560] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1585test # [ 10.954935] systemd[1]: Started Hostname Service.1586second # [ 11.037123] systemd[1]: Starting Post-Boot Actions...1587second # [ 11.076626] systemd[1]: Started Reset console on configuration changes.1588test # [ 11.061125] systemd-networkd[559]: eth0: Link UP1589test # [ 11.061642] systemd-networkd[559]: eth0: Gained carrier1590second # [ 11.121858] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1591test # [ 11.084561] systemd[1]: Started Network Manager.1592test # [ 11.087058] systemd[1]: Reached target Network.1593test # [ 11.092974] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1594test # [ 11.101993] systemd[1]: Starting Permit User Sessions...1595second # [ 11.144677] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[551]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1596second # connecting to host...1597second # [ 11.223492] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1598second # [ 11.237370] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1599second # [ 11.261940] systemd[1]: Finished Post-Boot Actions.1600second # [ 11.285353] nsncd[556]: Oct 02 05:36:59.128 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1601second # [ 11.294087] systemd[1]: Started Name Service Cache Daemon (nsncd).1602second # [ 11.294665] systemd[1]: Reached target Host and Network Name Lookups.1603second # [ 11.295192] systemd[1]: Reached target User and Group Name Lookups.1604second # [ 11.310869] systemd[1]: Starting User Login Management...1605test # [ 11.269057] systemd[1]: Finished Permit User Sessions.1606test # [ 11.284847] systemd[1]: Started Getty on tty1.1607test # [ 11.287606] systemd[1]: Reached target Login Prompts.1608second # [ 11.356317] systemd[1]: Finished Import lastlog data into lastlog2 database.1609test # [ 11.316302] systemd-resolved[354]: eth0: Bus client set default route setting: yes1610test # [ 11.319967] systemd-resolved[354]: eth0: Bus client set DNS server list to: 10.0.2.31611second # [ 11.377658] systemd[1]: Started Network Manager Script Dispatcher Service.1612test # [ 11.333001] NetworkManager[573]: <warn> [1790919419.1597] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1613test # [ 11.335710] NetworkManager[573]: <warn> [1790919419.1679] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1614test # [ 11.401611] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1615test # [ 11.404318] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1616second # [ 11.467448] systemd-logind[585]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1617second # [ 11.470861] systemd-logind[585]: Watching system buttons on /dev/input/event0 (gpio-keys)1618second # [ 11.478116] systemd-logind[585]: New seat seat0.1619second # [ 11.478545] systemd[1]: Started User Login Management.1620second # [ 11.483321] systemd[1]: Starting linger-users.service...1621second # [ 11.502292] systemd[1]: Starting Hostname Service...1622second # [ 11.574305] systemd[1]: linger-users.service: Deactivated successfully.1623second # [ 11.574981] systemd[1]: Finished linger-users.service.1624test # [ 11.547320] systemd[1]: Reached target Multi-User System.1625test # [ 11.551555] systemd[1]: Startup finished in 716ms (kernel) + 4.397s (initrd) + 6.434s (userspace) = 11.548s.1626second # [ 11.623762] systemd[1]: Started Hostname Service.1627second # [ 11.719884] systemd-networkd[537]: eth0: Link UP1628second # [ 11.720483] systemd-networkd[537]: eth0: Gained carrier1629second # [ 11.740311] systemd[1]: Started Network Manager.1630second # [ 11.744758] systemd[1]: Reached target Network.1631second # [ 11.748592] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1632second # [ 11.756426] systemd[1]: Starting Permit User Sessions...1633second # [ 11.921434] systemd[1]: Finished Permit User Sessions.1634test: (finished: waiting for unit NetworkManager.service, in 12.16 seconds)1635test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1636second # [ 11.934156] systemd[1]: Started Getty on tty1.1637second # [ 11.937801] systemd[1]: Reached target Login Prompts.1638second # [ 11.977245] systemd-resolved[334]: eth0: Bus client set default route setting: yes1639second # [ 11.980545] systemd-resolved[334]: eth0: Bus client set DNS server list to: 10.0.2.31640test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.05 seconds)1641test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1642test # [ 11.969396] systemd-networkd[559]: eth1: Gained IPv6LL1643test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds)1644test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1645second # [ 12.056354] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1646second # [ 12.060254] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1647test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1648(finished: run the VM test script, in 12.75 seconds)1649test script finished in 12.82s1650cleanup1651kill QemuMachine (pid 14)1652second # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1653kill QemuMachine (pid 15)1654test # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1655(finished: cleanup, in 0.23 seconds)