vm-test-run-wifi
checks.aarch64-linux.wifi
· build #1029
· raw
1build01: building 69ifn3iy2nyk23yllnrsynl3mw5vir53-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 vm14test # Disk image does not exist, creating the virtualisation disk image...15test # Formatting '/build/vm-state-test/tmp.C1e6B1ldo0', fmt=raw size=107374182416test # mke2fs 1.47.4 (6-Mar-2025)17test # Discarding device blocks: 0/262144 done18test # Creating filesystem with 262144 4k blocks and 65536 inodes19test # Filesystem UUID: f3a4c2a7-4bd5-464d-9122-66284d32948920test # Superblock backups stored on blocks:21test # 32768, 98304, 163840, 22937622test # 23test # Allocating group tables: 0/8 done24test # Writing inode tables: 0/8 done25test # Creating journal (8192 blocks): done26test # Writing superblocks and filesystem accounting information: 0/8 done27test # 28test # Virtualisation disk image created.29test: QEMU running (pid 15)30second # Disk image does not exist, creating the virtualisation disk image...31second: QEMU running (pid 14)32second # Formatting '/build/vm-state-second/tmp.tlrPHjG0uo', fmt=raw size=107374182433second # mke2fs 1.47.4 (6-Mar-2025)34second # Discarding device blocks: 0/262144 done35second # Creating filesystem with 262144 4k blocks and 65536 inodes36second # Filesystem UUID: f4e5fad9-492c-4056-ac77-e5fab3b2a89c37second # Superblock backups stored on blocks:38second # 32768, 98304, 163840, 22937639second # 40second # Allocating group tables: 0/8 done41second # Writing inode tables: 0/8 done42second # Creating journal (8192 blocks): done43second # Writing superblocks and filesystem accounting information: 0/8 done44second # 45second # Virtualisation disk image created.46(finished: start all VMs, in 0.54 seconds)47test: waiting for unit NetworkManager.service48test: waiting for the VM to finish booting49second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]50second # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Thu Oct 15 09:58:20 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 0x7fc08740-0x7fc0bebf]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 s186968 r8192 d116136 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/pmfi7pdchwy6lpb4lpvlzvr4djmjc0y4-nixos-system-second-test/init regInfo=/nix/store/viaw56rn22ycxx85i4qf9rh8z3sh4q09-closure-info/registration console=ttyAMA0,115200n8 console=tty086second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/viaw56rn22ycxx85i4qf9rh8z3sh4q09-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 74981 entries in 294 pages100second # [ 0.000000] ftrace: allocated 294 pages with 4 groups101second # [ 0.000000] rcu: Hierarchical RCU implementation.102second # [ 0.000000] rcu: RCU event tracing is enabled.103second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.104second # [ 0.000000] Trampoline variant of Tasks RCU enabled.105second # [ 0.000000] Rude variant of Tasks RCU enabled.106second # [ 0.000000] Tracing variant of Tasks RCU enabled.107second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.108second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1109second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.110second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.111second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.112second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0113second # [ 0.000000] GICv3: 256 SPIs implemented114second # [ 0.000000] GICv3: 0 Extended SPIs implemented115second # [ 0.000000] Root IRQ handler: gic_handle_irq116second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI117second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0118second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000119second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]120second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)121second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)122second # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000123second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000124second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.125second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns126second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040127second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).128second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns129second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns130second # [ 0.000060] arm-pv: using stolen time PV131second # [ 0.000370] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)132second # [ 0.000653] Console: colour dummy device 80x25133test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]134second # [ 0.000665] printk: legacy console [tty0] enabled135second # [ 0.000881] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)136test # [ 0.000000] Linux version 6.18.57 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Thu Oct 15 09:58:20 UTC 2026137second # [ 0.000886] pid_max: default: 32768 minimum: 301138test # [ 0.000000] KASLR enabled139test # [ 0.000000] random: crng init done140second # [ 0.000978] LSM: initializing lsm=capability,landlock,yama,bpf,ima141test # [ 0.000000] Machine model: linux,dummy-virt142second # [ 0.001145] landlock: Up and running.143test # [ 0.000000] efi: UEFI not found.144second # [ 0.001148] Yama: becoming mindful.145second # [ 0.001516] LSM support for eBPF active146test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT147second # [ 0.001678] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)148test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]149test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc08740-0x7fc0bebf]150second # [ 0.001696] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151test # [ 0.000000] Zone ranges:152second # [ 0.004371] rcu: Hierarchical SRCU implementation.153test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]154second # [ 0.004378] rcu: Max phase no-delay instances is 1000.155test # [ 0.000000] DMA32 empty156test # [ 0.000000] Normal empty157second # [ 0.005331] fsl-mc MSI: its@8080000 domain created158test # [ 0.000000] Device empty159second # [ 0.005514] EFI services will not be available.160test # [ 0.000000] Movable zone start for each node161second # [ 0.005592] smp: Bringing up secondary CPUs ...162test # [ 0.000000] Early memory node ranges163second # [ 0.005631] smp: Brought up 1 node, 1 CPU164test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]165second # [ 0.005634] SMP: Total of 1 processors activated.166second # [ 0.005635] CPU: All CPU(s) started at EL1167test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]168test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000169second # [ 0.005647] CPU features: detected: 32-bit EL0 Support170test # [ 0.000000] psci: probing for conduit method from DT.171second # [ 0.005650] CPU features: detected: Data cache clean to the PoU not required for I/D coherence172test # [ 0.000000] psci: PSCIv1.3 detected in firmware.173test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs174second # [ 0.005652] CPU features: detected: Common not Private translations175test # [ 0.000000] psci: Trusted OS migration not required176second # [ 0.005655] CPU features: detected: CRC32 instructions177test # [ 0.000000] psci: SMC Calling Convention v1.1178second # [ 0.005656] CPU features: detected: Data cache clean to Point of Persistence179test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)180second # [ 0.005659] CPU features: detected: Enhanced Virtualization Traps181test # [ 0.000000] percpu: Embedded 76 pages/cpu s186968 r8192 d116136 u311296182second # [ 0.005670] CPU features: detected: RCpc load-acquire (LDAPR)183test # [ 0.000000] Detected PIPT I-cache on CPU0184second # [ 0.005672] CPU features: detected: LSE atomic instructions185test # [ 0.000000] CPU features: detected: GICv3 CPU interface186second # [ 0.005674] CPU features: detected: Privileged Access Never187test # [ 0.000000] CPU features: detected: Spectre-v4188second # [ 0.005676] CPU features: detected: PMUv3189test # [ 0.000000] CPU features: detected: Spectre-BHB190second # [ 0.005677] CPU features: detected: RAS Extension Support191test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR192second # [ 0.005681] CPU features: detected: Speculative Store Bypassing Safe (SSBS)193test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)194second # [ 0.005701] alternatives: applying system-wide alternatives195test # [ 0.000000] CPU features: detected: ARM erratum 1418040196second # [ 0.007104] CPU features: detected: Hardware dirty bit management on CPU0197test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion198test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing199test # [ 0.000000] alternatives: applying boot alternatives200second # [ 0.007290] Memory: 892876K/1048576K available (24448K kernel code, 7094K rwdata, 26604K rodata, 4736K init, 1103K bss, 114388K reserved, 32768K cma-reserved)201second # [ 0.007746] devtmpfs: initialized202second # [ 0.009240] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)203second # [ 0.009262] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).204second # [ 0.009387] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL205test # [ 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/3aavcjjw365fqgq1fs2738h5d5f1c0in-nixos-system-test-test/init regInfo=/nix/store/6sljxxk6dqgzpfpbngwlx0bcxhpq1jlx-closure-info/registration console=ttyAMA0,115200n8 console=tty0206second # [ 0.009391] 0 pages in range for non-PLT usage207second # [ 0.009392] 508224 pages in range for PLT usage208second # [ 0.009516] pinctrl core: initialized pinctrl subsystem209test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/6sljxxk6dqgzpfpbngwlx0bcxhpq1jlx-closure-info/registration", will be passed to user space.210second # [ 0.010282] DMI not present or invalid.211test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes212second # [ 0.013711] NET: Registered PF_NETLINK/PF_ROUTE protocol family213test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)214second # [ 0.016004] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations215test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)216second # [ 0.016174] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations217test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB218second # [ 0.016350] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations219test # [ 0.000000] software IO TLB: area num 1.220second # [ 0.016365] audit: initializing netlink subsys (disabled)221test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)222second # [ 0.016969] thermal_sys: Registered thermal governor 'fair_share'223test # [ 0.000000] Fallback order for Node 0: 0224second # [ 0.016971] thermal_sys: Registered thermal governor 'bang_bang'225test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144226test # [ 0.000000] Policy zone: DMA227second # [ 0.016974] thermal_sys: Registered thermal governor 'step_wise'228test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off229second # [ 0.016976] thermal_sys: Registered thermal governor 'user_space'230test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1231second # [ 0.016978] thermal_sys: Registered thermal governor 'power_allocator'232test # [ 0.000000] allocated 2097152 bytes of page_ext233test # [ 0.000000] ftrace: allocating 74981 entries in 294 pages234second # [ 0.017002] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1235second # [ 0.017017] cpuidle: using governor ladder236test # [ 0.000000] ftrace: allocated 294 pages with 4 groups237second # [ 0.017022] cpuidle: using governor menu238test # [ 0.000000] rcu: Hierarchical RCU implementation.239test # [ 0.000000] rcu: RCU event tracing is enabled.240second # [ 0.017134] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.241test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.242second # [ 0.017156] ASID allocator initialised with 32768 entries243second # [ 0.017813] Serial: AMBA PL011 UART driver244test # [ 0.000000] Trampoline variant of Tasks RCU enabled.245test # [ 0.000000] Rude variant of Tasks RCU enabled.246second # [ 0.021201] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1247test # [ 0.000000] Tracing variant of Tasks RCU enabled.248second # [ 0.021328] printk: console [ttyAMA0] enabled249test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.250test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1251test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.252test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.253test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.254test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0255test # [ 0.000000] GICv3: 256 SPIs implemented256test # [ 0.000000] GICv3: 0 Extended SPIs implemented257test # [ 0.000000] Root IRQ handler: gic_handle_irq258test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI259test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0260test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000261test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]262test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)263test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)264test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000265test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000266test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.267test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns268test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040269test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).270second # [ 0.094200] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages271test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns272second # [ 0.094208] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page273test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns274second # [ 0.094211] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages275test # [ 0.000050] arm-pv: using stolen time PV276second # [ 0.094215] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page277test # [ 0.000332] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)278second # [ 0.094217] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages279test # [ 0.000595] Console: colour dummy device 80x25280second # [ 0.094219] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page281test # [ 0.000607] printk: legacy console [tty0] enabled282second # [ 0.094222] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages283test # [ 0.000812] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)284second # [ 0.094223] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page285test # [ 0.000817] pid_max: default: 32768 minimum: 301286second # [ 0.095176] fbcon: Taking over console287test # [ 0.000893] LSM: initializing lsm=capability,landlock,yama,bpf,ima288second # [ 0.095187] ACPI: Interpreter disabled.289test # [ 0.001008] landlock: Up and running.290second # [ 0.095817] iommu: Default domain type: Translated291test # [ 0.001010] Yama: becoming mindful.292test # [ 0.001367] LSM support for eBPF active293second # [ 0.095821] iommu: DMA domain TLB invalidation policy: strict mode294second # [ 0.096115] SCSI subsystem initialized295second # [ 0.098063] usbcore: registered new interface driver usbfs296test # [ 0.001523] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)297second # [ 0.098097] usbcore: registered new interface driver hub298second # [ 0.098110] usbcore: registered new device driver usb299test # [ 0.001542] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)300test # [ 0.003967] rcu: Hierarchical SRCU implementation.301test # [ 0.003973] rcu: Max phase no-delay instances is 1000.302second # [ 0.098313] pps_core: LinuxPPS API ver. 1 registered303second # [ 0.098316] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>304test # [ 0.005017] fsl-mc MSI: its@8080000 domain created305second # [ 0.098321] PTP clock support registered306test # [ 0.005202] EFI services will not be available.307second # [ 0.098347] EDAC MC: Ver: 3.0.0308test # [ 0.005343] smp: Bringing up secondary CPUs ...309test # [ 0.005381] smp: Brought up 1 node, 1 CPU310test # [ 0.005384] SMP: Total of 1 processors activated.311test # [ 0.005386] CPU: All CPU(s) started at EL1312test # [ 0.005397] CPU features: detected: 32-bit EL0 Support313test # [ 0.005400] CPU features: detected: Data cache clean to the PoU not required for I/D coherence314test # [ 0.005403] CPU features: detected: Common not Private translations315test # [ 0.005405] CPU features: detected: CRC32 instructions316test # [ 0.005407] CPU features: detected: Data cache clean to Point of Persistence317second # [ 0.107295] scmi_core: SCMI protocol bus registered318test # [ 0.005410] CPU features: detected: Enhanced Virtualization Traps319second # [ 0.107610] FPGA manager framework320test # [ 0.005419] CPU features: detected: RCpc load-acquire (LDAPR)321second # [ 0.110683] vgaarb: loaded322test # [ 0.005422] CPU features: detected: LSE atomic instructions323test # [ 0.005424] CPU features: detected: Privileged Access Never324test # [ 0.005426] CPU features: detected: PMUv3325test # [ 0.005428] CPU features: detected: RAS Extension Support326test # [ 0.005431] CPU features: detected: Speculative Store Bypassing Safe (SSBS)327test # [ 0.005452] alternatives: applying system-wide alternatives328test # [ 0.006832] CPU features: detected: Hardware dirty bit management on CPU0329second # [ 0.111791] clocksource: Switched to clocksource arch_sys_counter330test # [ 0.007010] Memory: 892868K/1048576K available (24448K kernel code, 7094K rwdata, 26604K rodata, 4736K init, 1103K bss, 114392K reserved, 32768K cma-reserved)331test # [ 0.007443] devtmpfs: initialized332test # [ 0.008927] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)333test # [ 0.008953] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).334test # [ 0.009092] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL335test # [ 0.009097] 0 pages in range for non-PLT usage336test # [ 0.009098] 508224 pages in range for PLT usage337test # [ 0.009220] pinctrl core: initialized pinctrl subsystem338test # [ 0.010002] DMI not present or invalid.339test # [ 0.013057] NET: Registered PF_NETLINK/PF_ROUTE protocol family340test # [ 0.015366] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations341test # [ 0.015511] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations342test # [ 0.015683] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations343test # [ 0.015699] audit: initializing netlink subsys (disabled)344test # [ 0.016108] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1345test # [ 0.016266] thermal_sys: Registered thermal governor 'fair_share'346test # [ 0.016267] thermal_sys: Registered thermal governor 'bang_bang'347test # [ 0.016270] thermal_sys: Registered thermal governor 'step_wise'348test # [ 0.016272] thermal_sys: Registered thermal governor 'user_space'349second # [ 0.122198] VFS: Disk quotas dquot_6.6.0350test # [ 0.016274] thermal_sys: Registered thermal governor 'power_allocator'351test # [ 0.016302] cpuidle: using governor ladder352second # [ 0.122223] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)353test # [ 0.016308] cpuidle: using governor menu354second # [ 0.123668] netfs: FS-Cache loaded355second # [ 0.123777] pnp: PnP ACPI: disabled356test # [ 0.016419] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.357test # [ 0.016439] ASID allocator initialised with 32768 entries358test # [ 0.017124] Serial: AMBA PL011 UART driver359test # [ 0.020568] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1360test # [ 0.020692] printk: console [ttyAMA0] enabled361second # [ 0.127020] NET: Registered PF_INET protocol family362second # [ 0.127197] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)363test # [ 0.093485] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages364test # [ 0.093493] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page365test # [ 0.093496] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages366test # [ 0.093500] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page367test # [ 0.093502] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages368test # [ 0.093504] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page369test # [ 0.093506] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages370test # [ 0.093508] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page371test # [ 0.094433] fbcon: Taking over console372test # [ 0.094442] ACPI: Interpreter disabled.373test # [ 0.095083] iommu: Default domain type: Translated374test # [ 0.095087] iommu: DMA domain TLB invalidation policy: strict mode375test # [ 0.095381] SCSI subsystem initialized376test # [ 0.095588] usbcore: registered new interface driver usbfs377test # [ 0.095617] usbcore: registered new interface driver hub378test # [ 0.095624] usbcore: registered new device driver usb379test # [ 0.095835] pps_core: LinuxPPS API ver. 1 registered380test # [ 0.095838] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>381test # [ 0.095843] PTP clock support registered382test # [ 0.095869] EDAC MC: Ver: 3.0.0383test # [ 0.105428] scmi_core: SCMI protocol bus registered384test # [ 0.106131] FPGA manager framework385test # [ 0.109357] vgaarb: loaded386test # [ 0.110038] clocksource: Switched to clocksource arch_sys_counter387second # [ 0.150836] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)388second # [ 0.150856] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389second # [ 0.150867] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)390second # [ 0.150902] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)391second # [ 0.150968] TCP: Hash tables configured (established 8192 bind 8192)392test # [ 0.119098] VFS: Disk quotas dquot_6.6.0393second # [ 0.151046] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)394test # [ 0.119123] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)395test # [ 0.120804] netfs: FS-Cache loaded396second # [ 0.151077] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)397test # [ 0.120923] pnp: PnP ACPI: disabled398second # [ 0.151098] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)399second # [ 0.151211] NET: Registered PF_UNIX/PF_LOCAL protocol family400second # [ 0.151242] NET: Registered PF_XDP protocol family401second # [ 0.151262] PCI: CLS 0 bytes, default 64402second # [ 0.151560] Trying to unpack rootfs image as initramfs...403test # [ 0.124189] NET: Registered PF_INET protocol family404test # [ 0.124379] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)405second # [ 0.166107] kvm [1]: HYP mode not available406test # [ 0.147858] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)407test # [ 0.147880] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)408test # [ 0.147891] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.147926] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.147992] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.148074] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.148134] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.148157] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.148270] NET: Registered PF_UNIX/PF_LOCAL protocol family415test # [ 0.148300] NET: Registered PF_XDP protocol family416test # [ 0.148320] PCI: CLS 0 bytes, default 64417test # [ 0.148524] Trying to unpack rootfs image as initramfs...418test # [ 0.156231] kvm [1]: HYP mode not available419second # [ 0.228144] Initialise system trusted keyrings420second # [ 0.228246] workingset: timestamp_bits=42 max_order=18 bucket_order=0421second # [ 0.228638] squashfs: version 4.0 (2009/01/31) Phillip Lougher422second # [ 0.228671] 9p: Installing v9fs 9p2000 file system support423second # [ 0.247493] Key type asymmetric registered424second # [ 0.247510] Asymmetric key parser 'x509' registered425second # [ 0.247565] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)426second # [ 0.255870] io scheduler mq-deadline registered427second # [ 0.255878] io scheduler kyber registered428second # [ 0.258161] pl061_gpio 9030000.pl061: PL061 GPIO chip registered429second # [ 0.261026] ledtrig-cpu: registered to indicate activity on CPUs430second # [ 0.261363] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:431second # [ 0.261380] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000432second # [ 0.261397] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000433test # [ 0.226378] Initialise system trusted keyrings434second # [ 0.261402] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000435test # [ 0.226488] workingset: timestamp_bits=42 max_order=18 bucket_order=0436second # [ 0.261427] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits437test # [ 0.226952] squashfs: version 4.0 (2009/01/31) Phillip Lougher438test # [ 0.226986] 9p: Installing v9fs 9p2000 file system support439second # [ 0.261446] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]440second # [ 0.261507] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00441second # [ 0.261528] pci_bus 0000:00: root bus resource [bus 00-ff]442second # [ 0.261532] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]443second # [ 0.261535] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]444second # [ 0.261537] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]445second # [ 0.261615] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint446second # [ 0.262020] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint447second # [ 0.262130] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]448second # [ 0.262139] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]449second # [ 0.262156] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]450second # [ 0.262166] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]451second # [ 0.262443] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint452second # [ 0.262549] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]453second # [ 0.262558] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]454second # [ 0.262575] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]455second # [ 0.262835] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint456second # [ 0.262942] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]457second # [ 0.262950] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]458second # [ 0.262967] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]459second # [ 0.263228] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint460second # [ 0.263333] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]461second # [ 0.263342] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]462second # [ 0.263359] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]463second # [ 0.263625] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint464second # [ 0.263731] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]465second # [ 0.263739] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]466second # [ 0.263756] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]467test # [ 0.245778] Key type asymmetric registered468test # [ 0.245794] Asymmetric key parser 'x509' registered469test # [ 0.245839] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)470second # [ 0.287289] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint471second # [ 0.287404] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]472second # [ 0.287413] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]473second # [ 0.287431] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]474second # [ 0.287704] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint475second # [ 0.290614] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]476second # [ 0.290625] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]477second # [ 0.290642] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]478second # [ 0.290658] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]479second # [ 0.290958] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint480second # [ 0.291068] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]481second # [ 0.291085] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]482second # [ 0.291350] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint483test # [ 0.254092] io scheduler mq-deadline registered484test # [ 0.254098] io scheduler kyber registered485test # [ 0.256359] pl061_gpio 9030000.pl061: PL061 GPIO chip registered486test # [ 0.256680] ledtrig-cpu: registered to indicate activity on CPUs487second # [ 0.291457] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]488test # [ 0.256974] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:489second # [ 0.291475] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]490test # [ 0.256990] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000491second # [ 0.291712] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint492second # [ 0.296197] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]493test # [ 0.257009] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000494second # [ 0.296392] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint495test # [ 0.257013] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000496second # [ 0.296581] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]497test # [ 0.257039] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits498second # [ 0.296590] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]499test # [ 0.257059] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]500second # [ 0.296607] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]501test # [ 0.257125] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00502second # [ 0.296882] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint503test # [ 0.257141] pci_bus 0000:00: root bus resource [bus 00-ff]504second # [ 0.296989] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]505test # [ 0.257145] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]506second # [ 0.296997] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]507test # [ 0.257147] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]508second # [ 0.297015] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]509test # [ 0.257150] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]510second # [ 0.297407] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned511test # [ 0.257230] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint512second # [ 0.297413] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned513test # [ 0.257642] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint514second # [ 0.297416] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned515test # [ 0.257755] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]516second # [ 0.297446] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned517test # [ 0.257763] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]518test # [ 0.257781] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]519second # [ 0.297474] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned520test # [ 0.257791] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]521second # [ 0.297501] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned522second # [ 0.297528] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned523second # [ 0.297555] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned524second # [ 0.297582] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned525second # [ 0.297611] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned526second # [ 0.297639] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned527second # [ 0.297665] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned528second # [ 0.297740] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned529second # [ 0.297783] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned530second # [ 0.297795] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned531second # [ 0.297808] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned532second # [ 0.297820] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned533second # [ 0.297833] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned534second # [ 0.297845] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned535second # [ 0.297857] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned536second # [ 0.297869] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned537test # [ 0.274115] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint538second # [ 0.297882] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned539test # [ 0.274237] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]540test # [ 0.274246] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]541second # [ 0.297894] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned542test # [ 0.274265] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]543second # [ 0.297906] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned544second # [ 0.297924] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned545test # [ 0.274562] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint546test # [ 0.274672] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]547second # [ 0.297937] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned548test # [ 0.274680] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]549second # [ 0.297949] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned550test # [ 0.274698] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]551second # [ 0.297961] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned552second # [ 0.297972] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned553test # [ 0.274972] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint554second # [ 0.297990] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned555test # [ 0.275081] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]556test # [ 0.275106] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]557second # [ 0.298002] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned558test # [ 0.275123] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559second # [ 0.298014] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned560second # [ 0.298026] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned561test # [ 0.275400] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint562test # [ 0.275511] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]563second # [ 0.298038] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned564test # [ 0.275519] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]565second # [ 0.298054] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]566test # [ 0.275538] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]567second # [ 0.298058] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]568second # [ 0.298061] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]569test # [ 0.275818] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint570second # [ 0.298733] pci 0000:00:0a.0: enabling device (0000 -> 0002)571test # [ 0.275928] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]572test # [ 0.275936] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]573test # [ 0.275954] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]574test # [ 0.276239] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint575test # [ 0.276350] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]576test # [ 0.276358] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]577test # [ 0.276376] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]578test # [ 0.276388] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]579test # [ 0.276664] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint580test # [ 0.276776] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]581test # [ 0.276793] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]582test # [ 0.277057] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint583test # [ 0.277167] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]584test # [ 0.277184] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]585test # [ 0.277453] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint586test # [ 0.277560] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]587test # [ 0.277718] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint588test # [ 0.277919] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]589test # [ 0.277928] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]590test # [ 0.277947] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]591second # [ 0.341105] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)592second # [ 0.343148] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)593test # [ 0.302287] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint594test # [ 0.302399] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]595test # [ 0.302408] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]596test # [ 0.302426] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]597test # [ 0.302826] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned598test # [ 0.302832] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned599test # [ 0.302835] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned600test # [ 0.302865] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned601test # [ 0.302892] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned602test # [ 0.302919] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned603test # [ 0.302946] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned604test # [ 0.302973] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned605test # [ 0.303001] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned606test # [ 0.303030] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned607test # [ 0.303057] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned608test # [ 0.303084] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned609second # [ 0.353151] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)610test # [ 0.303142] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned611second # [ 0.354837] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)612test # [ 0.303210] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned613test # [ 0.303223] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned614test # [ 0.303235] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned615test # [ 0.303247] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned616test # [ 0.303259] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned617test # [ 0.303271] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned618test # [ 0.303283] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned619test # [ 0.303296] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned620test # [ 0.303308] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned621test # [ 0.303320] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned622test # [ 0.303333] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned623test # [ 0.303345] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned624test # [ 0.303357] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned625test # [ 0.303369] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned626test # [ 0.303381] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned627test # [ 0.303393] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned628test # [ 0.303410] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned629test # [ 0.303422] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned630test # [ 0.303434] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned631test # [ 0.303446] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned632test # [ 0.303458] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned633test # [ 0.303475] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]634test # [ 0.303479] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]635test # [ 0.303481] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]636test # [ 0.304155] pci 0000:00:0a.0: enabling device (0000 -> 0002)637second # [ 0.364536] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)638second # [ 0.366401] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)639second # [ 0.368219] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)640second # [ 0.370161] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)641test # [ 0.332300] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)642second # [ 0.379919] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)643second # [ 0.382171] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)644test # [ 0.342354] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)645test # [ 0.345109] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)646second # [ 0.385268] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)647test # [ 0.350821] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)648second # [ 0.393316] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled649second # [ 0.394318] msm_serial: driver initialized650test # [ 0.352511] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)651second # [ 0.394447] SuperH (H)SCI(F) driver initialized652second # [ 0.394485] STM32 USART driver initialized653test # [ 0.362153] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)654test # [ 0.363984] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)655test # [ 0.365777] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)656test # [ 0.375308] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)657test # [ 0.377237] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)658second # [ 0.419088] loop: module loaded659second # [ 0.419196] virtio_blk virtio5: 1/0/0 default/read/poll queues660second # [ 0.419716] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)661test # [ 0.380259] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)662second # [ 0.424167] megasas: 07.734.00.00-rc1663second # [ 0.424626] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]664second # [ 0.427558] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000665second # [ 0.427578] Intel/Sharp Extended Query Table at 0x0031666test # [ 0.387604] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled667test # [ 0.391291] msm_serial: driver initialized668test # [ 0.391360] SuperH (H)SCI(F) driver initialized669test # [ 0.391398] STM32 USART driver initialized670second # [ 0.436843] Using buffer write method671second # [ 0.436866] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]672second # [ 0.439505] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000673second # [ 0.439551] Intel/Sharp Extended Query Table at 0x0031674second # [ 0.448622] Using buffer write method675second # [ 0.448633] Concatenating MTD devices:676second # [ 0.448634] (0): "0.flash"677second # [ 0.448636] (1): "0.flash"678second # [ 0.448638] into device "0.flash"679test # [ 0.415153] loop: module loaded680test # [ 0.415273] virtio_blk virtio5: 1/0/0 default/read/poll queues681test # [ 0.415803] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682test # [ 0.419797] megasas: 07.734.00.00-rc1683test # [ 0.420232] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]684test # [ 0.436008] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000685test # [ 0.436030] Intel/Sharp Extended Query Table at 0x0031686test # [ 0.437685] Using buffer write method687test # [ 0.437708] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]688test # [ 0.441581] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689test # [ 0.441592] Intel/Sharp Extended Query Table at 0x0031690test # [ 0.447039] Using buffer write method691test # [ 0.447051] Concatenating MTD devices:692test # [ 0.447053] (0): "0.flash"693test # [ 0.447054] (1): "0.flash"694test # [ 0.447056] into device "0.flash"695second # [ 0.638210] Freeing initrd memory: 25336K696second # [ 0.644958] tun: Universal TUN/TAP device driver, 1.6697second # [ 0.647163] thunder_xcv, ver 1.0698second # [ 0.647177] thunder_bgx, ver 1.0699second # [ 0.647186] nicpf, ver 1.0700second # [ 0.647478] e1000: Intel(R) PRO/1000 Network Driver701second # [ 0.647481] e1000: Copyright (c) 1999-2006 Intel Corporation.702second # [ 0.647499] e1000e: Intel(R) PRO/1000 Network Driver703second # [ 0.647502] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.704second # [ 0.647515] igb: Intel(R) Gigabit Ethernet Network Driver705second # [ 0.647516] igb: Copyright (c) 2007-2014 Intel Corporation.706second # [ 0.647526] igbvf: Intel(R) Gigabit Virtual Function Network Driver707second # [ 0.647528] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.708second # [ 0.647590] sky2: driver version 1.30709second # [ 0.653423] usbcore: registered new interface driver usb-storage710second # [ 0.653519] usbcore: registered new interface driver usbserial_generic711second # [ 0.653526] usbserial: USB Serial support registered for generic712second # [ 0.653837] hv_vmbus: registering driver hyperv_keyboard713second # [ 0.654843] ehci-pci 0000:00:0a.0: EHCI Host Controller714second # [ 0.654868] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1715second # [ 0.655141] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000716second # [ 0.655314] rtc-pl031 9010000.pl031: registered as rtc0717second # [ 0.655335] rtc-pl031 9010000.pl031: setting system clock to 2026-10-19T05:19:55 UTC (1792387195)718second # [ 0.655495] i2c_dev: i2c /dev entries driver719second # [ 0.662083] sdhci: Secure Digital Host Controller Interface driver720second # [ 0.662088] sdhci: Copyright(c) Pierre Ossman721second # [ 0.662236] Synopsys Designware Multimedia Card Interface Driver722second # [ 0.662410] sdhci-pltfm: SDHCI platform and OF driver helper723second # [ 0.663277] hid: raw HID events driver (C) Jiri Kosina724second # [ 0.663424] usbcore: registered new interface driver usbhid725second # [ 0.663427] usbhid: USB HID core driver726second # [ 0.663835] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00727second # [ 0.664171] hub 1-0:1.0: USB hub found728second # [ 0.664194] hub 1-0:1.0: 6 ports detected729test # [ 0.628306] Freeing initrd memory: 25340K730test # [ 0.635091] tun: Universal TUN/TAP device driver, 1.6731test # [ 0.637193] thunder_xcv, ver 1.0732test # [ 0.637207] thunder_bgx, ver 1.0733test # [ 0.637215] nicpf, ver 1.0734test # [ 0.637537] e1000: Intel(R) PRO/1000 Network Driver735test # [ 0.637541] e1000: Copyright (c) 1999-2006 Intel Corporation.736test # [ 0.637557] e1000e: Intel(R) PRO/1000 Network Driver737test # [ 0.637561] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.738test # [ 0.637573] igb: Intel(R) Gigabit Ethernet Network Driver739test # [ 0.637575] igb: Copyright (c) 2007-2014 Intel Corporation.740test # [ 0.637585] igbvf: Intel(R) Gigabit Virtual Function Network Driver741test # [ 0.637587] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.742test # [ 0.637650] sky2: driver version 1.30743test # [ 0.643337] usbcore: registered new interface driver usb-storage744test # [ 0.643417] usbcore: registered new interface driver usbserial_generic745test # [ 0.643423] usbserial: USB Serial support registered for generic746test # [ 0.643725] hv_vmbus: registering driver hyperv_keyboard747test # [ 0.644725] ehci-pci 0000:00:0a.0: EHCI Host Controller748test # [ 0.644754] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1749test # [ 0.644991] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000750test # [ 0.645159] rtc-pl031 9010000.pl031: registered as rtc0751test # [ 0.645182] rtc-pl031 9010000.pl031: setting system clock to 2026-10-19T05:19:55 UTC (1792387195)752test # [ 0.645358] i2c_dev: i2c /dev entries driver753test # [ 0.651662] sdhci: Secure Digital Host Controller Interface driver754test # [ 0.651667] sdhci: Copyright(c) Pierre Ossman755test # [ 0.651818] Synopsys Designware Multimedia Card Interface Driver756test # [ 0.651995] sdhci-pltfm: SDHCI platform and OF driver helper757second # [ 0.698278] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available758test # [ 0.652861] hid: raw HID events driver (C) Jiri Kosina759second # [ 0.699105] drop_monitor: Initializing network drop monitor service760test # [ 0.652985] usbcore: registered new interface driver usbhid761second # [ 0.699258] NET: Registered PF_INET6 protocol family762test # [ 0.652987] usbhid: USB HID core driver763test # [ 0.657431] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00764test # [ 0.657810] hub 1-0:1.0: USB hub found765test # [ 0.657833] hub 1-0:1.0: 6 ports detected766test # [ 0.661920] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available767second # [ 0.701441] Segment Routing with IPv6768second # [ 0.701471] In-situ OAM (IOAM) with IPv6769second # [ 0.701523] NET: Registered PF_PACKET protocol family770second # [ 0.701635] 9pnet: Installing 9P2000 support771second # [ 0.703173] Key type dns_resolver registered772test # [ 0.663532] drop_monitor: Initializing network drop monitor service773test # [ 0.663693] NET: Registered PF_INET6 protocol family774test # [ 0.664277] Segment Routing with IPv6775test # [ 0.664306] In-situ OAM (IOAM) with IPv6776second # [ 0.707607] registered taskstats version 1777test # [ 0.664357] NET: Registered PF_PACKET protocol family778second # [ 0.707767] Loading compiled-in X.509 certificates779test # [ 0.664422] 9pnet: Installing 9P2000 support780test # [ 0.665885] Key type dns_resolver registered781test # [ 0.671136] registered taskstats version 1782test # [ 0.671281] Loading compiled-in X.509 certificates783second # [ 0.713121] Demotion targets for Node 0: null784second # [ 0.713186] Key type .fscrypt registered785second # [ 0.713189] Key type fscrypt-provisioning registered786second # [ 0.713291] ima: No TPM chip found, activating TPM-bypass!787second # [ 0.713301] ima: Allocated hash algorithm: sha1788second # [ 0.713348] ima: No architecture policies found789second # [ 0.713792] input: gpio-keys as /devices/platform/gpio-keys/input/input0790test # [ 0.676454] Demotion targets for Node 0: null791test # [ 0.676517] Key type .fscrypt registered792test # [ 0.676520] Key type fscrypt-provisioning registered793test # [ 0.676621] ima: No TPM chip found, activating TPM-bypass!794test # [ 0.676631] ima: Allocated hash algorithm: sha1795test # [ 0.676676] ima: No architecture policies found796test # [ 0.677108] input: gpio-keys as /devices/platform/gpio-keys/input/input0797second # [ 0.726182] clk: Disabling unused clocks798second # [ 0.726190] PM: genpd: Disabling unused power domains799test # [ 0.689608] clk: Disabling unused clocks800test # [ 0.689615] PM: genpd: Disabling unused power domains801second # [ 0.729203] Freeing unused kernel memory: 4736K802second # [ 0.729273] Run /init as init process803test # [ 0.692628] Freeing unused kernel memory: 4736K804test # [ 0.692702] Run /init as init process805second # [ 0.750078] systemd[1]: Successfully made /usr/ read-only.806test # [ 0.712273] systemd[1]: Successfully made /usr/ read-only.807second # [ 0.919857] usb 1-1: new high-speed USB device number 2 using ehci-pci808test # [ 0.902102] usb 1-1: new high-speed USB device number 2 using ehci-pci809second # [ 1.069874] 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/input1810second # [ 1.084090] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)811second # [ 1.084118] systemd[1]: Detected virtualization qemu.812test # [ 1.046582] systemd[1]: systemd 260.5 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)813second # [ 1.084158] systemd[1]: Detected architecture arm64.814second # [ 1.084168] systemd[1]: Running in initrd.815test # [ 1.046614] systemd[1]: Detected virtualization qemu.816second # [ 1.085175] systemd[1]: Initializing machine ID from random generator.817test # [ 1.046656] systemd[1]: Detected architecture arm64.818second # [ 1.085455] systemd[1]: Hostname set to <second>.819test # [ 1.046665] systemd[1]: Running in initrd.820test # [ 1.048348] systemd[1]: Initializing machine ID from random generator.821test # [ 1.048633] systemd[1]: Hostname set to <test>.822test # [ 1.066012] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1823second # [ 1.156020] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0824test # [ 1.158225] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0825second # [ 1.204532] systemd[1]: Queued start job for default target Initrd Default Target.826test # [ 1.169669] systemd[1]: Queued start job for default target Initrd Default Target.827second # [ 1.213439] systemd[1]: Created slice Slice /system/modprobe.828second # [ 1.213626] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.829second # [ 1.213655] systemd[1]: Expecting device /dev/disk/by-label/nixos...830second # [ 1.213680] systemd[1]: Reached target Path Units.831second # [ 1.213697] systemd[1]: Reached target Slice Units.832second # [ 1.213713] systemd[1]: Reached target Swaps.833second # [ 1.213729] systemd[1]: Reached target Timer Units.834second # [ 1.213878] systemd[1]: Listening on D-Bus System Message Bus Socket.835second # [ 1.214067] systemd[1]: Listening on Journal Socket (/dev/log).836second # [ 1.214211] systemd[1]: Listening on Journal Sockets.837test # [ 1.179473] systemd[1]: Created slice Slice /system/modprobe.838second # [ 1.214346] systemd[1]: Listening on udev Control Socket.839second # [ 1.214411] systemd[1]: Listening on udev Kernel Socket.840test # [ 1.179631] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.841second # [ 1.214432] systemd[1]: Reached target Socket Units.842test # [ 1.179655] systemd[1]: Expecting device /dev/disk/by-label/nixos...843second # [ 1.215666] systemd[1]: Starting Create List of Static Device Nodes...844test # [ 1.179675] systemd[1]: Reached target Path Units.845test # [ 1.179688] systemd[1]: Reached target Slice Units.846test # [ 1.179702] systemd[1]: Reached target Swaps.847test # [ 1.179715] systemd[1]: Reached target Timer Units.848test # [ 1.179844] systemd[1]: Listening on D-Bus System Message Bus Socket.849test # [ 1.179986] systemd[1]: Listening on Journal Socket (/dev/log).850test # [ 1.180104] systemd[1]: Listening on Journal Sockets.851test # [ 1.180177] systemd[1]: Listening on udev Control Socket.852test # [ 1.180263] systemd[1]: Listening on udev Kernel Socket.853test # [ 1.180282] systemd[1]: Reached target Socket Units.854test # [ 1.181673] systemd[1]: Starting Create List of Static Device Nodes...855second # [ 1.231864] systemd[1]: Starting Load Kernel Module 9pnet_virtio...856second # [ 1.231926] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs857second # [ 1.237848] systemd[1]: Mounting Kernel Configuration File System...858test # [ 1.201933] systemd[1]: Starting Load Kernel Module 9pnet_virtio...859test # [ 1.201999] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs860test # [ 1.206017] systemd[1]: Mounting Kernel Configuration File System...861second # [ 1.254722] systemd[1]: Starting Journal Service...862test # [ 1.217868] systemd[1]: Starting Journal Service...863second # [ 1.267043] systemd[1]: Starting Load Kernel Modules...864second # [ 1.267096] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki865second # [ 1.269697] systemd[1]: Starting Coldplug All udev Devices...866test # [ 1.230361] systemd[1]: Starting Load Kernel Modules...867test # [ 1.230444] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki868second # [ 1.274525] systemd[1]: Finished Create List of Static Device Nodes.869second # [ 1.275473] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.870second # [ 1.275836] usb 1-2: new high-speed USB device number 3 using ehci-pci871second # [ 1.281240] systemd[1]: Finished Load Kernel Module 9pnet_virtio.872second # [ 1.281502] systemd[1]: Mounted Kernel Configuration File System.873test # [ 1.243827] systemd[1]: Starting Coldplug All udev Devices...874test # [ 1.246650] systemd[1]: Finished Create List of Static Device Nodes.875test # [ 1.247548] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.876test # [ 1.254256] systemd[1]: Finished Load Kernel Module 9pnet_virtio.877second # [ 1.296242] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...878test # [ 1.265639] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...879test # [ 1.265838] systemd[1]: Mounted Kernel Configuration File System.880test # [ 1.269063] systemd-journald[73]: Collecting audit messages is disabled.881test # [ 1.278383] usb 1-2: new high-speed USB device number 3 using ehci-pci882second # [ 1.325657] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.883test # [ 1.298504] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.884second # [ 1.344238] systemd-journald[73]: Collecting audit messages is disabled.885test # [ 1.302888] systemd[1]: Starting Create Static Device Nodes in /dev...886second # [ 1.348917] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.887second # [ 1.349808] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev888test # [ 1.310935] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.889second # [ 1.353356] systemd[1]: Starting Create Static Device Nodes in /dev...890second # [ 1.362439] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0891second # [ 1.362661] [drm] features: -virgl +edid -resource_blob -host_visible892second # [ 1.362663] [drm] features: -context_init893second # [ 1.363118] [drm] number of scanouts: 1894second # [ 1.363128] [drm] number of cap sets: 0895test # [ 1.322576] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev896test # [ 1.330711] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0897test # [ 1.330950] [drm] features: -virgl +edid -resource_blob -host_visible898test # [ 1.330952] [drm] features: -context_init899test # [ 1.331396] [drm] number of scanouts: 1900test # [ 1.331405] [drm] number of cap sets: 0901second # [ 1.376200] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic902second # [ 1.376209] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0903test # [ 1.346484] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic904test # [ 1.346493] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0905test # [ 1.351731] systemd[1]: Finished Create Static Device Nodes in /dev.906test # [ 1.351908] systemd[1]: Reached target Preparation for Local File Systems.907test # [ 1.351930] systemd[1]: Reached target Local File Systems.908test # [ 1.355856] systemd[1]: Starting Rule-based Manager for Device Events and Files...909second # [ 1.400355] Console: switching to colour frame buffer device 160x50910test # [ 1.364935] systemd-modules-load[74]: Inserted module 'dm_mod'911second # [ 1.406573] systemd[1]: Finished Create Static Device Nodes in /dev.912second # [ 1.406725] systemd[1]: Reached target Preparation for Local File Systems.913second # [ 1.406742] systemd[1]: Reached target Local File Systems.914second # [ 1.413676] systemd[1]: Starting Rule-based Manager for Device Events and Files...915test # [ 1.374439] Console: switching to colour frame buffer device 160x50916test # [ 1.375312] systemd-modules-load[74]: Module 'virtio_balloon' is built in917test # [ 1.380329] systemd[1]: Started Journal Service.918second # [ 1.421578] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device919test # [ 1.380343] systemd-modules-load[74]: Module 'virtio_console' is built in920test # [ 1.384254] systemd[1]: Starting Create System Files and Directories...921second # [ 1.433590] 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/input2922test # [ 1.396820] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device923second # [ 1.433790] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0924test # [ 1.397529] systemd-modules-load[74]: Inserted module 'virtio_gpu'925test # [ 1.398148] systemd-modules-load[74]: Module 'virtio_rng' is built in926second # [ 1.440294] systemd[1]: Finished Load Kernel Modules.927second # [ 1.441386] systemd[1]: Starting Apply Kernel Variables...928test # [ 1.401159] systemd[1]: Finished Load Kernel Modules.929second # [ 1.449189] systemd-modules-load[74]: Inserted module 'dm_mod'930second # [ 1.450246] systemd-modules-load[74]: Module 'virtio_balloon' is built in931second # [ 1.451135] systemd-modules-load[74]: Module 'virtio_console' is built in932second # [ 1.451804] systemd-modules-load[74]: Inserted module 'virtio_gpu'[ 1.456016] systemd[1]: Started Journal Service.933test # [ 1.420941] systemd[1]: Starting Apply Kernel Variables...934second # 935second # [ 1.464376] systemd-modules-load[74]: Module 'virtio_rng' is built in936second # [ 1.466325] systemd[1]: Starting Create System Files and Directories...937test # [ 1.439273] systemd-udevd[81]: Using default interface naming scheme 'v260'.938test # [ 1.444018] 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/input2939test # [ 1.444191] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0940second # [ 1.484277] systemd-udevd[80]: Using default interface naming scheme 'v260'.941test # [ 1.448529] systemd[1]: Finished Apply Kernel Variables.942test # [ 1.452762] systemd[1]: Finished Create System Files and Directories.943second # [ 1.500668] systemd[1]: Finished Apply Kernel Variables.944test # [ 1.470024] systemd[1]: Started Rule-based Manager for Device Events and Files.945second # [ 1.512749] systemd[1]: Finished Create System Files and Directories.946second # [ 1.514963] systemd[1]: Started Rule-based Manager for Device Events and Files.947test # [ 1.524102] systemd[1]: Starting Virtual Console Setup...948second # [ 1.572984] systemd[1]: Starting Virtual Console Setup...949test # [ 1.568344] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.950test # [ 1.570465] systemd[1]: Finished Virtual Console Setup.951second # [ 1.621368] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.952second # [ 1.624149] systemd[1]: Finished Virtual Console Setup.953test # [ 1.833184] systemd[1]: Finished Coldplug All udev Devices.954test # [ 1.833759] systemd[1]: Reached target System Initialization.955test # [ 1.834240] systemd[1]: Reached target Basic System.956second # [ 1.879200] systemd[1]: Finished Coldplug All udev Devices.957second # [ 1.879814] systemd[1]: Reached target System Initialization.958second # [ 1.884160] systemd[1]: Reached target Basic System.959test # [ 1.944742] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.960test # [ 1.948571] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.961second # [ 1.990212] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.962second # [ 2.004988] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.963test # [ 2.000632] systemd[1]: Found device /dev/disk/by-label/nixos.964test # [ 2.003880] systemd[1]: Reached target Initrd Root Device.965test # [ 2.006668] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...966second # [ 2.047880] systemd[1]: Found device /dev/disk/by-label/nixos.967second # [ 2.049318] systemd[1]: Reached target Initrd Root Device.968second # [ 2.050832] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969test # [ 2.053389] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks970second # [ 2.094615] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks971test # [ 2.056791] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.972second # [ 2.100982] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.973second # [ 2.264684] systemd[1]: Mounting /sysroot...974test # [ 2.239975] systemd[1]: Mounting /sysroot...975second # [ 2.295305] systemd[1]: Mounted /sysroot.976second # [ 2.295774] systemd[1]: Reached target Initrd Root File System.[ 2.300025] EXT4-fs (vda): mounted filesystem f4e5fad9-492c-4056-ac77-e5fab3b2a89c r/w with ordered data mode. Quota mode: none.977second # 978second # [ 2.300097] systemd[1]: Starting Mountpoints Configured in the Real Root...979test # [ 2.269872] EXT4-fs (vda): mounted filesystem f3a4c2a7-4bd5-464d-9122-66284d329489 r/w with ordered data mode. Quota mode: none.980test # [ 2.268231] systemd[1]: Mounted /sysroot.981test # [ 2.269806] systemd[1]: Reached target Initrd Root File System.982second # [ 2.309932] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.983second # [ 2.313232] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...984test # [ 2.275386] systemd[1]: Mounting /sysroot/nix/.ro-store...985second # [ 2.316896] systemd[1]: Reloading...986test # [ 2.285667] systemd[1]: Mounting /sysroot/nix/.rw-store...987test # [ 2.294281] systemd[1]: Mounting /sysroot/run...988test # [ 2.305282] systemd[1]: Mounting /sysroot/tmp/shared...989test # [ 2.324855] systemd[1]: Mounting /sysroot/tmp/xchg...990test # [ 2.334275] systemd[1]: Starting Mountpoints Configured in the Real Root...991test # [ 2.344701] systemd[1]: Mounted /sysroot/nix/.rw-store.992test # [ 2.346716] systemd[1]: Mounted /sysroot/nix/.ro-store.993test # [ 2.353300] systemd[1]: Mounted /sysroot/run.994test # [ 2.374964] systemd[1]: Starting rw-sysroot-nix-store.service...995test # [ 2.377110] systemd-sysroot-fstab-check[126]: /sysroot should be mounted in the initrd, will request daemon-reload.996test # [ 2.381117] systemd[1]: Mounted /sysroot/tmp/shared.997test # [ 2.384963] systemd[1]: Mounted /sysroot/tmp/xchg.998test # [ 2.388629] systemd[1]: Reload requested from client PID 126 ('systemd-sysroot') (unit initrd-parse-etc.service)...999test # [ 2.391790] systemd[1]: Reloading...1000second # [ 2.493708] systemd[1]: Reloading finished in 178 ms.1001second # [ 2.503873] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1002second # [ 2.506744] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1003second # [ 2.511077] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1004second # [ 2.515217] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1005second # [ 2.519180] systemd[1]: Finished Mountpoints Configured in the Real Root.1006second # [ 2.519860] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1007second # [ 2.535738] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1008second # [ 2.536789] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1009test # [ 2.568164] systemd[1]: Reloading finished in 179 ms.1010test # [ 2.580851] systemd-sysroot-fstab-check[126]: Requesting initrd-fs.target/start/replace...1011test # [ 2.583380] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1012test # [ 2.584618] systemd[1]: Finished rw-sysroot-nix-store.service.1013test # [ 2.587577] systemd-sysroot-fstab-check[126]: Requesting swap.target/start/replace...1014test # [ 2.594701] systemd[1]: Starting rw-sysroot-nix-store.service...1015test # [ 2.599524] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1016test # [ 2.603574] systemd[1]: Finished Mountpoints Configured in the Real Root.1017test # [ 2.605411] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1018test # [ 2.615868] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1019test # [ 2.616823] systemd[1]: Finished rw-sysroot-nix-store.service.1020second # [ 2.888996] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/udev/mtd_probe": No such file or directory1021second # [ 2.892778] (udev-worker)[101]: mtd0ro: /nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/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 directory1022second # [ 2.911445] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1023test # [ 2.872285] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/udev/mtd_probe": No such file or directory1024second # [ 2.913035] systemd[1]: Stopped Virtual Console Setup.1025second # [ 2.913960] systemd[1]: Stopping Virtual Console Setup...1026test # [ 2.873981] (udev-worker)[94]: mtd0ro: /nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/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 directory1027second # [ 2.916709] systemd[1]: Starting Virtual Console Setup...1028test # [ 2.881853] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1029test # [ 2.882586] systemd[1]: Stopped Virtual Console Setup.1030test # [ 2.884413] systemd[1]: Stopping Virtual Console Setup...1031test # [ 2.888145] systemd[1]: Starting Virtual Console Setup...1032second # [ 2.934186] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1033second # [ 2.936714] systemd[1]: Finished Virtual Console Setup.1034test # [ 2.910118] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.1035test # [ 2.912502] systemd[1]: Finished Virtual Console Setup.1036second # [ 3.267791] systemd[1]: Mounting /sysroot/nix/.ro-store...1037second # [ 3.276294] systemd[1]: Mounting /sysroot/nix/.rw-store...1038test # [ 3.241707] systemd[1]: Mounting /sysroot/nix/store...1039second # [ 3.284340] systemd[1]: Mounting /sysroot/run...1040second # [ 3.293941] systemd[1]: Mounting /sysroot/tmp/shared...1041second # [ 3.305778] systemd[1]: Mounting /sysroot/tmp/xchg...1042test # [ 3.283889] systemd[1]: Mounted /sysroot/nix/store.1043test # [ 3.286137] systemd[1]: Reached target Initrd File Systems.1044test # [ 3.289767] systemd[1]: Starting Find NixOS closure...1045test # [ 3.296816] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1046second # [ 3.342950] systemd[1]: Mounted /sysroot/nix/.ro-store.1047second # [ 3.345170] systemd[1]: Mounted /sysroot/nix/.rw-store.1048second # [ 3.346488] systemd[1]: Mounted /sysroot/run.1049second # [ 3.353506] systemd[1]: Mounted /sysroot/tmp/shared.1050second # [ 3.364350] systemd[1]: Starting rw-sysroot-nix-store.service...1051second # [ 3.368832] systemd[1]: Mounted /sysroot/tmp/xchg.1052test # [ 3.341011] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1053test # [ 3.344163] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1054second # [ 3.386716] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1055second # [ 3.388359] systemd[1]: Finished rw-sysroot-nix-store.service.1056test # [ 3.358311] systemd[1]: Finished Find NixOS closure.1057test # [ 3.360650] systemd[1]: Reached target Initrd Default Target.1058test # [ 3.363147] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1059test # [ 3.392227] systemd[1]: initrd-cleanup.service: Deactivated successfully.1060test # [ 3.393583] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1061test # [ 3.397062] systemd[1]: Stopped target Initrd Default Target.1062test # [ 3.399924] systemd[1]: Stopped target Basic System.1063test # [ 3.400884] systemd[1]: Stopped target Initrd Root Device.1064test # [ 3.401907] systemd[1]: Stopped target Path Units.1065test # [ 3.403877] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1066test # [ 3.405884] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1067test # [ 3.412148] systemd[1]: Stopped target Slice Units.1068test # [ 3.412788] systemd[1]: Stopped target Socket Units.1069test # [ 3.413375] systemd[1]: Stopped target System Initialization.1070test # [ 3.414033] systemd[1]: Stopped target Swaps.1071test # [ 3.414559] systemd[1]: Stopped target Timer Units.1072test # [ 3.415141] systemd[1]: dbus.socket: Deactivated successfully.1073test # [ 3.415921] systemd[1]: Closed D-Bus System Message Bus Socket.1074test # [ 3.424231] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1075test # [ 3.425108] systemd[1]: Stopped Find NixOS closure.1076test # [ 3.426794] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1077test # [ 3.429453] systemd[1]: Starting rw-sysroot-nix-store.service...1078test # [ 3.430777] systemd[1]: systemd-sysctl.service: Deactivated successfully.1079test # [ 3.435875] systemd[1]: Stopped Apply Kernel Variables.1080test # [ 3.436649] systemd[1]: systemd-modules-load.service: Deactivated successfully.1081test # [ 3.442723] systemd[1]: Stopped Load Kernel Modules.1082test # [ 3.443559] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1083test # [ 3.444711] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1084test # [ 3.446282] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1085test # [ 3.447849] systemd[1]: Stopped Create System Files and Directories.1086test # [ 3.449261] systemd[1]: Stopped target Local File Systems.1087test # [ 3.450630] systemd[1]: Stopped target Preparation for Local File Systems.1088test # [ 3.451499] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1089test # [ 3.460149] systemd[1]: Stopped Coldplug All udev Devices.1090test # [ 3.460647] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1091test # [ 3.461414] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1092test # [ 3.462047] systemd[1]: Stopped Virtual Console Setup.1093test # [ 3.462486] systemd[1]: systemd-udevd.service: Deactivated successfully.1094test # [ 3.463025] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1095test # [ 3.463715] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1096test # [ 3.468124] systemd[1]: Closed udev Control Socket.1097test # [ 3.468569] systemd[1]: Starting Cleanup udev Database...1098test # [ 3.469025] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1099test # [ 3.469645] systemd[1]: Stopped Create Static Device Nodes in /dev.1100test # [ 3.470158] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1101test # [ 3.470809] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1102test # [ 3.471405] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1103test # [ 3.471976] systemd[1]: Stopped Create List of Static Device Nodes.1104test # [ 3.480579] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1105test # [ 3.481245] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1106test # [ 3.482144] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1107test # [ 3.482816] systemd[1]: Finished rw-sysroot-nix-store.service.1108test # [ 3.483329] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1109test # [ 3.483955] systemd[1]: Finished Cleanup udev Database.1110test # [ 3.484547] systemd[1]: Reached target Switch Root.1111test # [ 3.485140] systemd[1]: Starting NixOS Activation...1112test # [ 3.674767] initrd-nixos-activation-start[179]: booting system configuration /nix/store/3aavcjjw365fqgq1fs2738h5d5f1c0in-nixos-system-test-test1113test # [ 3.744420] initrd-nixos-activation-start[179]: running activation script...1114test # [ 4.222343] initrd-nixos-activation-start[202]: setting up /etc...1115second # [ 4.265269] systemd[1]: Mounting /sysroot/nix/store...1116second # [ 4.308475] systemd[1]: Mounted /sysroot/nix/store.1117second # [ 4.311482] systemd[1]: Reached target Initrd File Systems.1118second # [ 4.314677] systemd[1]: Starting Find NixOS closure...1119second # [ 4.324280] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1120second # [ 4.364195] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1121second # [ 4.366994] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1122second # [ 4.382321] systemd[1]: Finished Find NixOS closure.1123second # [ 4.384217] systemd[1]: Reached target Initrd Default Target.1124second # [ 4.385722] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1125second # [ 4.412346] systemd[1]: Stopped target Initrd Default Target.1126second # [ 4.413190] systemd[1]: Stopped target Basic System.1127second # [ 4.413887] systemd[1]: Stopped target Initrd Root Device.1128second # [ 4.415482] systemd[1]: Stopped target Path Units.1129second # [ 4.417567] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1130second # [ 4.420141] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1131second # [ 4.421977] systemd[1]: Stopped target Slice Units.1132second # [ 4.422783] systemd[1]: Stopped target Socket Units.1133second # [ 4.424108] systemd[1]: Stopped target System Initialization.1134second # [ 4.428138] systemd[1]: Stopped target Swaps.1135second # [ 4.428691] systemd[1]: Stopped target Timer Units.1136second # [ 4.429258] systemd[1]: dbus.socket: Deactivated successfully.1137second # [ 4.429910] systemd[1]: Closed D-Bus System Message Bus Socket.1138second # [ 4.430760] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1139second # [ 4.431584] systemd[1]: Stopped Find NixOS closure.1140second # [ 4.435081] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1141second # [ 4.438656] systemd[1]: Starting rw-sysroot-nix-store.service...1142second # [ 4.439633] systemd[1]: systemd-sysctl.service: Deactivated successfully.1143second # [ 4.442609] systemd[1]: Stopped Apply Kernel Variables.1144second # [ 4.443956] systemd[1]: systemd-modules-load.service: Deactivated successfully.1145second # [ 4.448330] systemd[1]: Stopped Load Kernel Modules.1146second # [ 4.448837] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1147second # [ 4.449556] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1148second # [ 4.450432] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1149second # [ 4.451094] systemd[1]: Stopped Create System Files and Directories.1150second # [ 4.451665] systemd[1]: Stopped target Local File Systems.1151second # [ 4.456116] systemd[1]: Stopped target Preparation for Local File Systems.1152second # [ 4.456810] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1153second # [ 4.457480] systemd[1]: Stopped Coldplug All udev Devices.1154second # [ 4.457998] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1155second # [ 4.458763] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1156second # [ 4.459415] systemd[1]: Stopped Virtual Console Setup.1157second # [ 4.459881] systemd[1]: initrd-cleanup.service: Deactivated successfully.1158second # [ 4.467916] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1159second # [ 4.469200] systemd[1]: systemd-udevd.service: Deactivated successfully.1160second # [ 4.471641] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1161second # [ 4.472809] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1162second # [ 4.474461] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1163second # [ 4.476093] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1164second # [ 4.476757] systemd[1]: Finished rw-sysroot-nix-store.service.1165second # [ 4.477583] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1166second # [ 4.480113] systemd[1]: Closed udev Control Socket.1167second # [ 4.480578] systemd[1]: Starting Cleanup udev Database...1168second # [ 4.481034] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1169second # [ 4.482048] systemd[1]: Stopped Create Static Device Nodes in /dev.1170second # [ 4.482664] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1171second # [ 4.483338] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1172second # [ 4.483918] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1173second # [ 4.484647] systemd[1]: Stopped Create List of Static Device Nodes.1174second # [ 4.503145] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1175second # [ 4.505358] systemd[1]: Finished Cleanup udev Database.1176second # [ 4.506284] systemd[1]: Reached target Switch Root.1177second # [ 4.508130] systemd[1]: Starting NixOS Activation...1178test # [ 4.497939] initrd-nixos-activation-start[202]: setting up age secrets...1179second # [ 4.695546] initrd-nixos-activation-start[181]: booting system configuration /nix/store/pmfi7pdchwy6lpb4lpvlzvr4djmjc0y4-nixos-system-second-test1180second # [ 4.763169] initrd-nixos-activation-start[181]: running activation script...1181test # [ 4.807817] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1182test # [ 4.809659] systemd[1]: Finished NixOS Activation.1183test # [ 4.812060] systemd[1]: Starting Switch Root...1184test # [ 4.823520] systemd[1]: Switching root.1185test # [ 4.866622] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1186second # [ 5.231086] initrd-nixos-activation-start[204]: setting up /etc...1187test # [ 5.434552] systemd[1]: systemd 260.5 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)1188test # [ 5.434647] systemd[1]: Detected virtualization qemu.1189test # [ 5.434696] systemd[1]: Detected architecture arm64.1190test # [ 5.434805] systemd[1]: Detected first boot.1191test # [ 5.451138] systemd[1]: Initializing machine ID from random generator.1192second # [ 5.500869] initrd-nixos-activation-start[204]: setting up age secrets...1193second # [ 5.727229] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1194second # [ 5.728958] systemd[1]: Finished NixOS Activation.1195second # [ 5.729714] systemd[1]: Starting Switch Root...1196second # [ 5.743874] systemd[1]: Switching root.1197test # [ 5.742201] systemd[1]: bpf-restrict-fs: LSM BPF program attached1198second # [ 5.800284] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1199test # [ 5.921699] systemd[1]: Applying preset policy.1200second # [ 6.373427] systemd[1]: systemd 260.5 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)1201second # [ 6.373521] systemd[1]: Detected virtualization qemu.1202second # [ 6.373569] systemd[1]: Detected architecture arm64.1203second # [ 6.373676] systemd[1]: Detected first boot.1204second # [ 6.389614] systemd[1]: Initializing machine ID from random generator.1205test # [ 6.507995] systemd[1]: Populated /etc with preset unit settings.1206second # [ 6.679660] systemd[1]: bpf-restrict-fs: LSM BPF program attached1207second # [ 6.867471] systemd[1]: Applying preset policy.1208test # [ 7.050967] systemd[1]: initrd-switch-root.service: Deactivated successfully.1209test # [ 7.051238] systemd[1]: Stopped initrd-switch-root.service.1210test # [ 7.052120] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1211test # [ 7.052753] systemd[1]: Created slice Slice /system/getty.1212test # [ 7.053188] systemd[1]: Created slice User and Session Slice.1213test # [ 7.053325] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1214test # [ 7.053403] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1215test # [ 7.053437] systemd[1]: Expecting device /dev/hvc0...1216test # [ 7.053450] systemd[1]: Expecting device /dev/ttyAMA0...1217test # [ 7.053855] systemd[1]: Reached target Local Encrypted Volumes.1218test # [ 7.060226] systemd[1]: Stopped target initrd-fs.target.1219test # [ 7.060728] systemd[1]: Stopped target initrd-root-fs.target.1220test # [ 7.061279] systemd[1]: Stopped target initrd-switch-root.target.1221test # [ 7.061815] systemd[1]: Reached target Virtual Machines and Containers.1222test # [ 7.064797] systemd[1]: Reached target Path Units.1223test # [ 7.065300] systemd[1]: Reached target Remote File Systems.1224test # [ 7.065827] systemd[1]: Reached target Slice Units.1225test # [ 7.068274] systemd[1]: Reached target Swaps.1226test # [ 7.072467] systemd[1]: Listening on Process Core Dump Socket.1227test # [ 7.076078] systemd[1]: Listening on Credential Encryption/Decryption.1228test # [ 7.080405] systemd[1]: Starting Journal Log Access Socket...1229test # [ 7.081432] systemd[1]: Listening on Journal Audit Socket.1230test # [ 7.083330] systemd[1]: Listening on Network Management Metrics Varlink Socket.1231test # [ 7.083932] systemd[1]: Listening on Network Management Netlink Socket.1232test # [ 7.084583] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1233test # [ 7.085079] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1234test # [ 7.085683] systemd[1]: Listening on udev Control Socket.1235test # [ 7.093235] systemd[1]: Mounting Huge Pages File System...1236test # [ 7.096768] systemd[1]: Mounting POSIX Message Queue File System...1237test # [ 7.100087] systemd[1]: Mounting Kernel Debug File System...1238test # [ 7.107512] systemd[1]: Mounting Kernel Trace File System...1239test # [ 7.113171] systemd[1]: Starting Create List of Static Device Nodes...1240test # [ 7.127874] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1241test # [ 7.128343] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1242test # [ 7.133430] systemd[1]: Mounting Kernel Configuration File System...1243test # [ 7.135291] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1244test # [ 7.136080] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1245test # [ 7.145906] systemd[1]: Starting Load Kernel Module fuse...1246test # [ 7.149143] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671247test # [ 7.161680] systemd[1]: Starting Journal Service...1248test # [ 7.192530] systemd[1]: Starting Load Kernel Modules...1249test # [ 7.216106] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1250test # [ 7.235480] systemd[1]: Starting Remount Root and Kernel File Systems...1251test # [ 7.238804] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1252test # [ 7.246144] fuse: init (API version 7.45)1253test # [ 7.257365] systemd[1]: Starting Coldplug All udev Devices...1254test # [ 7.289108] systemd[1]: Listening on Journal Log Access Socket.1255test # [ 7.297588] systemd[1]: Mounted Huge Pages File System.1256test # [ 7.299793] systemd[1]: Mounted POSIX Message Queue File System.1257test # [ 7.301241] systemd[1]: Mounted Kernel Debug File System.1258test # [ 7.304534] systemd[1]: Mounted Kernel Trace File System.1259test # [ 7.312118] systemd[1]: Finished Create List of Static Device Nodes.1260test # [ 7.316577] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1261test # [ 7.320747] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1262test # [ 7.326490] systemd[1]: Mounted Kernel Configuration File System.1263test # [ 7.329601] systemd[1]: modprobe@fuse.service: Deactivated successfully.1264test # [ 7.334516] systemd[1]: Finished Load Kernel Module fuse.1265test # [ 7.340523] systemd-journald[323]: Collecting audit messages is enabled.1266test # [ 7.351912] systemd[1]: Mounting FUSE Control File System...1267test # [ 7.352751] systemd[1]: Queued start job for default target Multi-User System.1268test # [ 7.354388] systemd[1]: systemd-journald.service: Deactivated successfully.1269test # [ 7.358157] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1270test # [ 7.361379] systemd[1]: Started Journal Service.1271test # [ 7.362267] systemd-modules-load[324]: Module 'atkbd' is built in1272test # [ 7.362954] systemd-modules-load[324]: Module 'ctr' is built in1273test # [ 7.363598] systemd-modules-load[324]: Module 'loop' is built in1274test # [ 7.369441] systemd[1]: Finished Load Kernel Modules.1275test # [ 7.382454] EXT4-fs (vda): re-mounted f3a4c2a7-4bd5-464d-9122-66284d329489.1276test # [ 7.394796] systemd[1]: Finished Remount Root and Kernel File Systems.1277test # [ 7.396630] systemd-oomd[325]: No swap; memory pressure usage will be degraded1278second # [ 7.450866] systemd[1]: Populated /etc with preset unit settings.1279test # [ 7.409274] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1280test # [ 7.416942] systemd[1]: Starting Firewall...1281test # [ 7.426708] systemd[1]: Starting Flush Journal to Persistent Storage...1282test # [ 7.428319] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1283test # [ 7.431281] systemd[1]: Starting Load/Save OS Random Seed...1284test # [ 7.452672] systemd[1]: Starting Apply Kernel Variables...1285test # [ 7.456498] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1286test # [ 7.489068] systemd[1]: Mounted FUSE Control File System.1287test # [ 7.527914] systemd-journald[323]: Received client request to flush runtime journal.1288test # [ 7.574728] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1289test # [ 7.579230] systemd[1]: Starting Create Static Device Nodes in /dev...1290test # [ 7.583930] systemd[1]: Finished Load/Save OS Random Seed.1291test # [ 7.589704] systemd[1]: Reached target First Boot Complete.1292test # [ 7.592637] systemd[1]: Finished Flush Journal to Persistent Storage.1293test # [ 7.619063] systemd[1]: Finished Apply Kernel Variables.1294test # [ 7.622748] systemd[1]: Starting Network Name Resolution...1295test # [ 7.658836] systemd[1]: Finished Create Static Device Nodes in /dev.1296test # [ 7.660924] systemd[1]: Reached target Preparation for Local File Systems.1297test # [ 7.670180] systemd[1]: Starting Rule-based Manager for Device Events and Files...1298test # [ 7.772983] systemd-resolved[357]: Positive Trust Anchors:1299test # [ 7.773821] systemd-resolved[357]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1300test # [ 7.775692] systemd-resolved[357]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161301test # [ 7.781305] systemd-resolved[357]: 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 test1302test # [ 7.820683] systemd-udevd[361]: Using default interface naming scheme 'v260'.1303second # [ 7.948654] systemd[1]: initrd-switch-root.service: Deactivated successfully.1304second # [ 7.948925] systemd[1]: Stopped initrd-switch-root.service.1305second # [ 7.949839] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1306second # [ 7.950822] systemd[1]: Created slice Slice /system/getty.1307second # [ 7.951545] systemd[1]: Created slice User and Session Slice.1308second # [ 7.955340] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1309second # [ 7.957102] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1310second # [ 7.957618] systemd[1]: Expecting device /dev/hvc0...1311second # [ 7.958177] systemd[1]: Expecting device /dev/ttyAMA0...1312second # [ 7.958727] systemd[1]: Reached target Local Encrypted Volumes.1313second # [ 7.959268] systemd[1]: Stopped target initrd-fs.target.1314second # [ 7.962542] systemd[1]: Stopped target initrd-root-fs.target.1315second # [ 7.963019] systemd[1]: Stopped target initrd-switch-root.target.1316second # [ 7.963559] systemd[1]: Reached target Virtual Machines and Containers.1317second # [ 7.966014] systemd[1]: Reached target Path Units.1318second # [ 7.966482] systemd[1]: Reached target Remote File Systems.1319second # [ 7.966992] systemd[1]: Reached target Slice Units.1320second # [ 7.967501] systemd[1]: Reached target Swaps.1321second # [ 7.973115] systemd[1]: Listening on Process Core Dump Socket.1322second # [ 7.976708] systemd[1]: Listening on Credential Encryption/Decryption.1323second # [ 7.981088] systemd[1]: Starting Journal Log Access Socket...1324second # [ 7.982120] systemd[1]: Listening on Journal Audit Socket.1325second # [ 7.982756] systemd[1]: Listening on Network Management Metrics Varlink Socket.1326second # [ 7.983375] systemd[1]: Listening on Network Management Netlink Socket.1327second # [ 7.986511] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1328second # [ 7.986981] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1329second # [ 7.987562] systemd[1]: Listening on udev Control Socket.1330second # [ 7.993457] systemd[1]: Mounting Huge Pages File System...1331second # [ 7.996672] systemd[1]: Mounting POSIX Message Queue File System...1332second # [ 7.999543] systemd[1]: Mounting Kernel Debug File System...1333second # [ 8.008271] systemd[1]: Mounting Kernel Trace File System...1334second # [ 8.018194] systemd[1]: Starting Create List of Static Device Nodes...1335second # [ 8.029192] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1336second # [ 8.029938] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1337second # [ 8.036786] systemd[1]: Mounting Kernel Configuration File System...1338second # [ 8.037472] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1339second # [ 8.038154] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1340second # [ 8.046520] systemd[1]: Starting Load Kernel Module fuse...1341second # [ 8.047538] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671342test # [ 8.012687] systemd-resolved[357]: Using system hostname 'test'.1343test # [ 8.018880] systemd[1]: Started Network Name Resolution.1344second # [ 8.065727] systemd[1]: Starting Journal Service...1345test # [ 8.057997] systemd[1]: Mounting /run/wrappers...1346second # [ 8.105836] systemd[1]: Starting Load Kernel Modules...1347second # [ 8.143931] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1348test # [ 8.118602] systemd[1]: Mounted /run/wrappers.1349second # [ 8.169507] fuse: init (API version 7.45)1350test # [ 8.128536] systemd[1]: Started Rule-based Manager for Device Events and Files.1351test # [ 8.129257] systemd[1]: Reached target Local File Systems.1352second # [ 8.176925] systemd[1]: Starting Remount Root and Kernel File Systems...1353test # [ 8.133582] systemd[1]: Listening on Boot Loader Control Service Socket.1354second # [ 8.177864] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1355test # [ 8.140666] systemd[1]: Starting register-nix-paths.service...1356second # [ 8.194484] systemd[1]: Starting Coldplug All udev Devices...1357test # [ 8.153011] systemd[1]: Starting Create SUID/SGID Wrappers...1358test # [ 8.158434] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1359second # [ 8.206714] systemd[1]: Listening on Journal Log Access Socket.1360test # [ 8.170935] systemd[1]: Starting Save Transient machine-id to Disk...1361second # [ 8.217152] systemd[1]: Mounted Huge Pages File System.1362second # [ 8.219378] systemd[1]: Mounted POSIX Message Queue File System.1363second # [ 8.224894] systemd[1]: Mounted Kernel Debug File System.1364second # [ 8.230778] systemd[1]: Mounted Kernel Trace File System.1365second # [ 8.238525] systemd[1]: Finished Create List of Static Device Nodes.1366test # [ 8.195822] systemd[1]: Starting Create System Files and Directories...1367second # [ 8.241634] systemd-journald[304]: Collecting audit messages is enabled.1368second # [ 8.245489] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1369second # [ 8.247024] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1370second # [ 8.251188] systemd[1]: Mounted Kernel Configuration File System.1371second # [ 8.249945] systemd[1]: Queued start job for default target Multi-User System.1372second # [ 8.256109] systemd[1]: modprobe@fuse.service: Deactivated successfully.1373second # [ 8.258790] systemd[1]: Finished Load Kernel Module fuse.1374second # [ 8.255237] systemd[1]: systemd-journald.service: Deactivated successfully.[ 8.262417] systemd[1]: Started Journal Service.1375second # 1376second # [ 8.262257] systemd-modules-load[305]: Module 'atkbd' is built in1377second # [ 8.262893] systemd-modules-load[305]: Module 'ctr' is built in1378second # [ 8.263486] systemd-modules-load[305]: Module 'loop' is built in1379second # [ 8.265020] systemd[1]: Finished Load Kernel Modules.1380second # [ 8.269896] systemd[1]: Mounting FUSE Control File System...1381second # [ 8.276229] systemd[1]: Starting Firewall...1382second # [ 8.287188] systemd[1]: Starting Apply Kernel Variables...1383second # [ 8.299052] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1384second # [ 8.311951] EXT4-fs (vda): re-mounted f4e5fad9-492c-4056-ac77-e5fab3b2a89c.1385second # [ 8.326489] systemd-oomd[306]: No swap; memory pressure usage will be degraded1386second # [ 8.329718] systemd[1]: Finished Remount Root and Kernel File Systems.1387second # [ 8.332719] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1388second # [ 8.357528] systemd[1]: Starting Flush Journal to Persistent Storage...1389second # [ 8.358159] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1390second # [ 8.362666] systemd[1]: Starting Load/Save OS Random Seed...1391second # [ 8.365766] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1392test # [ 8.332720] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1393test # [ 8.348515] systemd[1]: Finished Save Transient machine-id to Disk.1394second # [ 8.419533] systemd[1]: Mounted FUSE Control File System.1395test # [ 8.395990] systemd[1]: Finished Create System Files and Directories.1396test # [ 8.407661] systemd[1]: Starting Rebuild Journal Catalog...1397second # [ 8.449494] systemd[1]: Finished Apply Kernel Variables.1398test # [ 8.412630] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1399test # [ 8.414559] systemd[1]: Finished Coldplug All udev Devices.1400second # [ 8.461672] systemd[1]: Starting Network Name Resolution...1401second # [ 8.472298] systemd-journald[304]: Received client request to flush runtime journal.1402second # [ 8.538773] systemd[1]: Finished Load/Save OS Random Seed.1403second # [ 8.542486] systemd[1]: Reached target First Boot Complete.1404second # [ 8.543064] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1405second # [ 8.543668] systemd[1]: Starting Create Static Device Nodes in /dev...1406second # [ 8.551518] systemd[1]: Finished Flush Journal to Persistent Storage.1407test # [ 8.515677] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1408test # [ 8.569092] systemd[1]: Finished Rebuild Journal Catalog.1409test # [ 8.576086] systemd[1]: Starting Update is Completed...1410second # [ 8.627427] systemd[1]: Finished Create Static Device Nodes in /dev.1411second # [ 8.628257] systemd[1]: Reached target Preparation for Local File Systems.1412second # [ 8.630367] systemd[1]: Starting Rule-based Manager for Device Events and Files...1413second # [ 8.638549] systemd-resolved[333]: Positive Trust Anchors:1414second # [ 8.640151] systemd-resolved[333]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1415second # [ 8.643312] systemd-resolved[333]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161416second # [ 8.648516] systemd-resolved[333]: 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 test1417test # [ 8.644926] systemd[1]: Finished Update is Completed.1418test # [ 8.664698] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1419second # [ 8.746973] systemd-udevd[346]: Using default interface naming scheme 'v260'.1420second # [ 8.872687] systemd-resolved[333]: Using system hostname 'second'.1421second # [ 8.883236] systemd[1]: Started Network Name Resolution.1422second # [ 8.944484] systemd[1]: Mounting /run/wrappers...1423test # [ 8.929739] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1424second # [ 9.008151] systemd[1]: Mounted /run/wrappers.1425second # [ 9.008849] systemd[1]: Reached target Local File Systems.1426second # [ 9.012537] systemd[1]: Listening on Boot Loader Control Service Socket.1427second # [ 9.017129] systemd[1]: Starting register-nix-paths.service...1428second # [ 9.029702] systemd[1]: Starting Create SUID/SGID Wrappers...1429second # [ 9.030263] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1430second # [ 9.035771] systemd[1]: Starting Save Transient machine-id to Disk...1431test # [ 9.000912] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1432second # [ 9.045449] systemd[1]: Starting Create System Files and Directories...1433second # [ 9.048189] systemd[1]: Started Rule-based Manager for Device Events and Files.1434second # [ 9.186515] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1435second # [ 9.195943] systemd[1]: Finished Save Transient machine-id to Disk.1436test # [ 9.157584] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1437test # [ 9.159852] systemd[1]: Finished Create SUID/SGID Wrappers.1438second # [ 9.265781] systemd[1]: Finished Create System Files and Directories.1439second # [ 9.274593] systemd[1]: Starting Rebuild Journal Catalog...1440second # [ 9.286307] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1441test # [ 9.318622] systemd[1]: Finished Firewall.1442test # [ 9.320382] systemd[1]: Reached target Preparation for Network.1443test # [ 9.323936] (udev-worker)[454]: Network interface NamePolicy= disabled on kernel command line.1444test # [ 9.328229] (udev-worker)[453]: Network interface NamePolicy= disabled on kernel command line.1445test # [ 9.331009] systemd[1]: Starting Network Management...1446second # [ 9.401177] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1447test # [ 9.381678] systemd[1]: Finished register-nix-paths.service.1448test # [ 9.382369] systemd[1]: Reached target System Initialization.1449test # [ 9.384802] systemd[1]: Started Discard unused filesystem blocks once a week.1450second # [ 9.427640] systemd[1]: Finished Coldplug All udev Devices.1451test # [ 9.389570] systemd[1]: Started Daily Cleanup of Temporary Directories.1452test # [ 9.390157] systemd[1]: Reached target Timer Units.1453test # [ 9.390605] systemd[1]: Listening on D-Bus System Message Bus Socket.1454test # [ 9.391183] systemd[1]: Listening on Nix Daemon Socket.1455test # [ 9.402552] systemd[1]: Listening on Authorization Manager Agent Helper.1456test # [ 9.405272] systemd[1]: Listening on Hostname Service Socket.1457test # [ 9.405825] systemd[1]: Reached target Socket Units.1458test # [ 9.408099] systemd[1]: Starting D-Bus System Message Bus...1459second # [ 9.470323] systemd[1]: Finished Rebuild Journal Catalog.1460second # [ 9.473955] systemd[1]: Starting Update is Completed...1461second # [ 9.543754] systemd[1]: Finished Update is Completed.1462second # [ 9.572150] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1463test # [ 9.554537] mousedev: PS/2 mouse device common for all mice1464test # [ 9.562344] cfg80211: Loading compiled-in X.509 certificates for regulatory database1465test # [ 9.600791] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1466test # [ 9.601314] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1467test # [ 9.600233] dbus-broker-launch[560]: Looking up NSS user entry for 'systemd-timesync'...1468test # [ 9.617076] dbus-broker-launch[560]: NSS returned no entry for 'systemd-timesync'1469test # [ 9.617890] dbus-broker-launch[560]: Invalid user-name in /nix/store/bdx9gkgfkmw4hj13f30c43s3nrx91bgx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1470test # [ 9.657130] systemd-networkd[556]: /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.1471test # [ 9.661411] systemd-networkd[556]: /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.1472test # [ 9.670410] systemd-networkd[556]: lo: Link UP1473test # [ 9.673726] systemd-networkd[556]: lo: Gained carrier1474test # [ 9.679120] systemd[1]: Started Network Management.1475test # [ 9.682407] systemd-networkd[556]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1476test # [ 9.686321] systemd-networkd[556]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1477test # [ 9.693409] systemd-networkd[556]: eth1: Link UP1478test # [ 9.693864] systemd-networkd[556]: eth1: Gained carrier1479test # [ 9.694340] systemd-networkd[556]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1480test # [ 9.695623] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1481test # [ 9.704404] dbus-broker-launch[560]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6lmph1rn0dzdzcdhcaxbrzr5l4rmgzq0-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1482test # [ 9.710312] dbus-broker-launch[560]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6lmph1rn0dzdzcdhcaxbrzr5l4rmgzq0-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1483test # [ 9.719042] dbus-broker-launch[560]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/29ymypflk6jb9d2n079ikwbba15isr3i-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1484test # [ 9.729692] dbus-broker-launch[560]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/qk0n05qwbhr7xcs41d4f41ndi9cy28y8-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1485test # [ 9.737342] systemd[1]: Started D-Bus System Message Bus.1486test # [ 9.745327] systemd[1]: Reached target Basic System.1487test # [ 9.745894] systemd[1]: Starting Network Manager Script Dispatcher Service...1488test # [ 9.746515] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1489test # [ 9.747126] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1490test # [ 9.785921] dbus-broker-launch[560]: Ready1491test # [ 9.787672] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1492test # [ 9.791690] systemd[1]: Starting Network Manager...1493second # [ 9.832256] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1494test # [ 9.817740] systemd[1]: Started backdoor.service.1495test # [ 9.843365] systemd[1]: Starting Import lastlog data into lastlog2 database...1496second # [ 9.888104] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1497test # [ 9.855748] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1498test # [ 9.875187] systemd[1]: Starting Post-Boot Actions...1499test # [ 9.880423] n25cm952iq0m8cl7wjkynss0g05assxn-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1500test # [ 9.898024] systemd[1]: Started Reset console on configuration changes.1501test # [ 9.910392] 55lza9x2jamf2vld6h2l9yh9vghqrzg4-wifi-secrets[571]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1502test # [ 9.932859] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1503test # [ 9.938492] 64w2igmnj1gk4d8c0r8vvnfligqhqa7w-wifi-secrets[572]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1504test # [ 9.949096] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1505test # [ 9.964568] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1506test # [ 9.968647] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1507test # [ 9.974502] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1508test # [ 9.981380] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1509second # [ 10.030503] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1510test # [ 9.992748] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1511second # [ 10.033691] systemd[1]: Finished Create SUID/SGID Wrappers.1512test # connecting to host...1513test # [ 10.072321] systemd[1]: Finished Post-Boot Actions.1514test: Guest shell says: b'Spawning backdoor root shell...\n'1515test: connected to guest root shell1516test: (connecting took 10.38 seconds)1517test: (finished: waiting for the VM to finish booting, in 10.38 seconds)1518test # [ 10.127988] systemd[1]: Started Name Service Cache Daemon (nsncd).1519test # [ 10.132444] systemd[1]: Reached target Host and Network Name Lookups.1520test # [ 10.138274] systemd[1]: Reached target User and Group Name Lookups.1521test # [ 10.141143] nsncd[576]: Oct 19 05:20:04.993 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1522test # [ 10.148580] systemd[1]: Starting User Login Management...1523test # [ 10.150899] systemd[1]: Started Network Manager Script Dispatcher Service.1524test # [ 10.154882] systemd[1]: Finished Import lastlog data into lastlog2 database.1525second # [ 10.204550] (udev-worker)[389]: Network interface NamePolicy= disabled on kernel command line.1526second # [ 10.217794] (udev-worker)[379]: Network interface NamePolicy= disabled on kernel command line.1527second # [ 10.231846] systemd[1]: Finished Firewall.1528second # [ 10.235661] systemd[1]: Reached target Preparation for Network.1529second # [ 10.238432] systemd[1]: Starting Network Management...1530second # [ 10.282928] systemd[1]: Finished register-nix-paths.service.1531second # [ 10.285340] systemd[1]: Reached target System Initialization.1532second # [ 10.287653] systemd[1]: Started Discard unused filesystem blocks once a week.1533second # [ 10.289731] systemd[1]: Started Daily Cleanup of Temporary Directories.1534second # [ 10.294176] systemd[1]: Reached target Timer Units.1535second # [ 10.296182] systemd[1]: Listening on D-Bus System Message Bus Socket.1536second # [ 10.297868] systemd[1]: Listening on Nix Daemon Socket.1537second # [ 10.305415] systemd[1]: Listening on Authorization Manager Agent Helper.1538second # [ 10.306056] systemd[1]: Listening on Hostname Service Socket.1539second # [ 10.306554] systemd[1]: Reached target Socket Units.1540second # [ 10.310388] systemd[1]: Starting D-Bus System Message Bus...1541test # [ 10.277095] systemd[1]: Starting Hostname Service...1542test # [ 10.305245] systemd-logind[620]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1543test # [ 10.309184] systemd-logind[620]: Watching system buttons on /dev/input/event0 (gpio-keys)1544test # [ 10.312656] systemd-logind[620]: New seat seat0.1545test # [ 10.313120] systemd[1]: Started User Login Management.1546test # [ 10.316228] systemd[1]: Starting linger-users.service...1547second # [ 10.427672] mousedev: PS/2 mouse device common for all mice1548test # [ 10.389924] systemd[1]: linger-users.service: Deactivated successfully.1549test # [ 10.390540] systemd[1]: Finished linger-users.service.1550test # [ 10.406417] systemd[1]: Started Hostname Service.1551second # [ 10.469073] cfg80211: Loading compiled-in X.509 certificates for regulatory database1552second # [ 10.507005] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1553second # [ 10.507520] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1554second # [ 10.503715] dbus-broker-launch[541]: Looking up NSS user entry for 'systemd-timesync'...1555second # [ 10.522446] dbus-broker-launch[541]: NSS returned no entry for 'systemd-timesync'1556second # [ 10.523322] dbus-broker-launch[541]: Invalid user-name in /nix/store/bdx9gkgfkmw4hj13f30c43s3nrx91bgx-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1557test # [ 10.498210] systemd-networkd[556]: eth0: Link UP1558test # [ 10.498692] systemd-networkd[556]: eth0: Gained carrier1559test # [ 10.518588] systemd[1]: Started Network Manager.1560test # [ 10.520526] systemd[1]: Reached target Network.1561test # [ 10.526135] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1562second # [ 10.564751] systemd-networkd[538]: /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.1563test # [ 10.531455] systemd[1]: Starting Permit User Sessions...1564second # [ 10.569229] systemd-networkd[538]: /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.1565second # [ 10.577023] systemd-networkd[538]: lo: Link UP1566second # [ 10.577495] systemd-networkd[538]: lo: Gained carrier1567second # [ 10.581712] systemd[1]: Started Network Management.1568second # [ 10.584891] systemd-networkd[538]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1569second # [ 10.592874] systemd-networkd[538]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1570second # [ 10.597239] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1571second # [ 10.599877] systemd-networkd[538]: eth1: Link UP1572second # [ 10.605370] systemd-networkd[538]: eth1: Gained carrier1573second # [ 10.608092] systemd-networkd[538]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1574second # [ 10.611862] dbus-broker-launch[541]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6lmph1rn0dzdzcdhcaxbrzr5l4rmgzq0-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1575second # [ 10.619947] dbus-broker-launch[541]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6lmph1rn0dzdzcdhcaxbrzr5l4rmgzq0-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1576second # [ 10.626148] dbus-broker-launch[541]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/29ymypflk6jb9d2n079ikwbba15isr3i-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1577second # [ 10.635932] dbus-broker-launch[541]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/qk0n05qwbhr7xcs41d4f41ndi9cy28y8-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1578second # [ 10.645712] systemd[1]: Started D-Bus System Message Bus.1579second # [ 10.652783] systemd[1]: Reached target Basic System.1580second # [ 10.653249] systemd[1]: Starting Network Manager Script Dispatcher Service...1581second # [ 10.653823] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1582second # [ 10.660998] systemd[1]: Starting Network Manager...1583second # [ 10.677919] systemd[1]: Started backdoor.service.1584second # [ 10.698339] dbus-broker-launch[541]: Ready1585second # [ 10.712192] systemd[1]: Starting Import lastlog data into lastlog2 database...1586second # [ 10.718917] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1587test # [ 10.680364] systemd[1]: Finished Permit User Sessions.1588second # [ 10.731196] systemd[1]: Starting Post-Boot Actions...1589test # [ 10.693842] systemd[1]: Started Getty on tty1.1590test # [ 10.697024] systemd[1]: Reached target Login Prompts.1591second # [ 10.754747] systemd[1]: Started Reset console on configuration changes.1592test # [ 10.725831] systemd-resolved[357]: eth0: Bus client set default route setting: yes1593second # [ 10.768234] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1594test # [ 10.733221] systemd-resolved[357]: eth0: Bus client set DNS server list to: 10.0.2.31595test # [ 10.739046] NetworkManager[573]: <warn> [1792387205.5965] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1596test # [ 10.745817] NetworkManager[573]: <warn> [1792387205.5992] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1597second # [ 10.785678] n25cm952iq0m8cl7wjkynss0g05assxn-wifi-secrets[551]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1598test # [ 10.784721] systemd-networkd[556]: eth1: Gained IPv6LL1599second # [ 10.826494] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1600second # connecting to host...1601second # [ 10.835440] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1602test # [ 10.829714] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1603test # [ 10.832386] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1604second # [ 10.908977] systemd[1]: Finished Post-Boot Actions.1605second # [ 10.955707] nsncd[555]: Oct 19 05:20:05.803 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1606second # [ 10.959611] systemd[1]: Started Name Service Cache Daemon (nsncd).1607second # [ 10.962690] systemd[1]: Reached target Host and Network Name Lookups.1608second # [ 10.963214] systemd[1]: Reached target User and Group Name Lookups.1609second # [ 10.966626] systemd[1]: Starting User Login Management...1610second # [ 10.985461] systemd[1]: Finished Import lastlog data into lastlog2 database.1611test # [ 10.971023] systemd[1]: Reached target Multi-User System.1612test # [ 10.974606] systemd[1]: Startup finished in 694ms (kernel) + 4.253s (initrd) + 6.025s (userspace) = 10.973s.1613second # [ 11.018534] systemd[1]: Started Network Manager Script Dispatcher Service.1614second # [ 11.107192] systemd-logind[575]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1615second # [ 11.111478] systemd-logind[575]: Watching system buttons on /dev/input/event0 (gpio-keys)1616second # [ 11.114520] systemd-logind[575]: New seat seat0.1617second # [ 11.115035] systemd[1]: Starting Hostname Service...1618second # [ 11.115447] systemd[1]: Started User Login Management.1619second # [ 11.119676] systemd[1]: Starting linger-users.service...1620second # [ 11.190546] systemd[1]: linger-users.service: Deactivated successfully.1621second # [ 11.191126] systemd[1]: Finished linger-users.service.1622second # [ 11.241127] systemd[1]: Started Hostname Service.1623second # [ 11.331527] systemd-networkd[538]: eth0: Link UP1624second # [ 11.331977] systemd-networkd[538]: eth0: Gained carrier1625second # [ 11.351532] systemd[1]: Started Network Manager.1626second # [ 11.354320] systemd[1]: Reached target Network.1627second # [ 11.358619] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1628second # [ 11.362114] systemd[1]: Starting Permit User Sessions...1629test # [ 11.328633] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31630test: (finished: waiting for unit NetworkManager.service, in 11.62 seconds)1631test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1632test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1633test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1634test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds)1635test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1636test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1637(finished: run the VM test script, in 12.28 seconds)1638second # [ 11.520493] systemd[1]: Finished Permit User Sessions.1639second # [ 11.539002] systemd[1]: Started Getty on tty1.1640second # [ 11.541493] systemd[1]: Reached target Login Prompts.1641second # [ 11.549754] systemd-resolved[333]: eth0: Bus client set default route setting: yes1642second # [ 11.552403] systemd-resolved[333]: eth0: Bus client set DNS server list to: 10.0.2.31643test script finished in 12.34s1644cleanup1645kill QemuMachine (pid 14)1646second # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/q1khrhbn506imjxx7kiqcbihycawa6kl-python3-3.13.15/bin/python3.13)1647test # [ 11.652489] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1648kill QemuMachine (pid 15)1649test # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/q1khrhbn506imjxx7kiqcbihycawa6kl-python3-3.13.15/bin/python3.13)1650(finished: cleanup, in 0.28 seconds)