vm-test-run-wifi
checks.aarch64-linux.wifi
· build #118
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 second, test,8 vlan1,9 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh10start all VMs11second: starting vm12test: starting vm13test: QEMU running (pid 48)14test # Disk image does not exist, creating the virtualisation disk image...15test # Formatting '/build/vm-state-test/tmp.O4XjWXNZj8', 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: 9ddadaa9-be1e-4dc5-abd8-4186022334fe20test # 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.29second # Disk image does not exist, creating the virtualisation disk image...30second # Formatting '/build/vm-state-second/tmp.Qam3A1OQdu', fmt=raw size=107374182431second # mke2fs 1.47.4 (6-Mar-2025)32second # Discarding device blocks: 0/262144 done33second # Creating filesystem with 262144 4k blocks and 65536 inodes34second # Filesystem UUID: 304d3212-49a0-4e3a-99fb-56cb7ddbe93035second # Superblock backups stored on blocks:36second # 32768, 98304, 163840, 22937637second # 38second # Allocating group tables: 0/8 done39second: QEMU running (pid 47)40second # Writing inode tables: 0/8 done41second # Creating journal (8192 blocks): done42second # Writing superblocks and filesystem accounting information: 0/8 done43second # 44second # Virtualisation disk image created.45(finished: start all VMs, in 0.47 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49second # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202650second # [ 0.000000] KASLR enabled51second # [ 0.000000] random: crng init done52second # [ 0.000000] Machine model: linux,dummy-virt53second # [ 0.000000] efi: UEFI not found.54second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT55second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]56second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]57second # [ 0.000000] Zone ranges:58second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]59second # [ 0.000000] DMA32 empty60second # [ 0.000000] Normal empty61second # [ 0.000000] Device empty62test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]63second # [ 0.000000] Movable zone start for each node64second # [ 0.000000] Early memory node ranges65second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]66test # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202667test # [ 0.000000] KASLR enabled68second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]69test # [ 0.000000] random: crng init done70second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000071test # [ 0.000000] Machine model: linux,dummy-virt72test # [ 0.000000] efi: UEFI not found.73second # [ 0.000000] psci: probing for conduit method from DT.74second # [ 0.000000] psci: PSCIv1.3 detected in firmware.75test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT76second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs77test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]78second # [ 0.000000] psci: Trusted OS migration not required79second # [ 0.000000] psci: SMC Calling Convention v1.180test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]81test # [ 0.000000] Zone ranges:82second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)83test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]84test # [ 0.000000] DMA32 empty85second # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129686test # [ 0.000000] Normal empty87second # [ 0.000000] Detected PIPT I-cache on CPU088test # [ 0.000000] Device empty89test # [ 0.000000] Movable zone start for each node90second # [ 0.000000] CPU features: detected: GICv3 CPU interface91test # [ 0.000000] Early memory node ranges92second # [ 0.000000] CPU features: detected: Spectre-v493second # [ 0.000000] CPU features: detected: Spectre-BHB94test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]95second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR96test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]97test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000098second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)99second # [ 0.000000] CPU features: detected: ARM erratum 1418040100test # [ 0.000000] psci: probing for conduit method from DT.101test # [ 0.000000] psci: PSCIv1.3 detected in firmware.102second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion103test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs104second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing105test # [ 0.000000] psci: Trusted OS migration not required106second # [ 0.000000] alternatives: applying boot alternatives107test # [ 0.000000] psci: SMC Calling Convention v1.1108test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)109test # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296110test # [ 0.000000] Detected PIPT I-cache on CPU0111test # [ 0.000000] CPU features: detected: GICv3 CPU interface112second # [ 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/32hmpxw50hbba1k5ghwa1slcg5i95hyc-nixos-system-second-test/init regInfo=/nix/store/3qm8z9p4kpcsylvg24lmj5cwabimlzgp-closure-info/registration console=ttyAMA0,115200n8 console=tty0113test # [ 0.000000] CPU features: detected: Spectre-v4114test # [ 0.000000] CPU features: detected: Spectre-BHB115test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR116second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/3qm8z9p4kpcsylvg24lmj5cwabimlzgp-closure-info/registration", will be passed to user space.117test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)118second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes119test # [ 0.000000] CPU features: detected: ARM erratum 1418040120second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)121test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion122second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)123test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing124test # [ 0.000000] alternatives: applying boot alternatives125second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB126second # [ 0.000000] software IO TLB: area num 1.127second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)128second # [ 0.000000] Fallback order for Node 0: 0129second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144130second # [ 0.000000] Policy zone: DMA131second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off132test # [ 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/hvcpwzp5aib802vmfx6k40i2rjdp62r2-nixos-system-test-test/init regInfo=/nix/store/qd45bqq2aa4v5x7qhfa5w5krxq5i2wgv-closure-info/registration console=ttyAMA0,115200n8 console=tty0133second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1134second # [ 0.000000] allocated 2097152 bytes of page_ext135test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/qd45bqq2aa4v5x7qhfa5w5krxq5i2wgv-closure-info/registration", will be passed to user space.136second # [ 0.000000] ftrace: allocating 74886 entries in 294 pages137second # [ 0.000000] ftrace: allocated 294 pages with 4 groups138test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes139second # [ 0.000000] rcu: Hierarchical RCU implementation.140second # [ 0.000000] rcu: RCU event tracing is enabled.141test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)142second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.143test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)144second # [ 0.000000] Trampoline variant of Tasks RCU enabled.145test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB146second # [ 0.000000] Rude variant of Tasks RCU enabled.147test # [ 0.000000] software IO TLB: area num 1.148second # [ 0.000000] Tracing variant of Tasks RCU enabled.149test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)150second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.151test # [ 0.000000] Fallback order for Node 0: 0152second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1153test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144154test # [ 0.000000] Policy zone: DMA155second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.156test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off157second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.158test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1159test # [ 0.000000] allocated 2097152 bytes of page_ext160second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.161test # [ 0.000000] ftrace: allocating 74886 entries in 294 pages162second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0163test # [ 0.000000] ftrace: allocated 294 pages with 4 groups164second # [ 0.000000] GICv3: 256 SPIs implemented165test # [ 0.000000] rcu: Hierarchical RCU implementation.166second # [ 0.000000] GICv3: 0 Extended SPIs implemented167test # [ 0.000000] rcu: RCU event tracing is enabled.168second # [ 0.000000] Root IRQ handler: gic_handle_irq169second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI170test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.171second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0172test # [ 0.000000] Trampoline variant of Tasks RCU enabled.173second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000174test # [ 0.000000] Rude variant of Tasks RCU enabled.175second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]176test # [ 0.000000] Tracing variant of Tasks RCU enabled.177second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)178test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.179test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1180second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)181test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.182second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000183second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000184test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.185second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.186test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.187test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0188second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns189test # [ 0.000000] GICv3: 256 SPIs implemented190second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040191test # [ 0.000000] GICv3: 0 Extended SPIs implemented192second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).193test # [ 0.000000] Root IRQ handler: gic_handle_irq194test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI195test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0196second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns197test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000198second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns199test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]200second # [ 0.000054] arm-pv: using stolen time PV201test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)202second # [ 0.000326] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)203second # [ 0.000599] Console: colour dummy device 80x25204test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)205second # [ 0.000610] printk: legacy console [tty0] enabled206test # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000207second # [ 0.000801] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)208test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000209second # [ 0.000806] pid_max: default: 32768 minimum: 301210second # [ 0.000885] LSM: initializing lsm=capability,landlock,yama,bpf,ima211test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.212second # [ 0.000987] landlock: Up and running.213second # [ 0.000989] Yama: becoming mindful.214test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns215second # [ 0.001304] LSM support for eBPF active216test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040217second # [ 0.001460] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)218test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).219second # [ 0.001480] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)220second # [ 0.003239] cacheinfo: Unable to detect cache hierarchy for CPU 0221test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns222second # [ 0.004117] rcu: Hierarchical SRCU implementation.223second # [ 0.004122] rcu: Max phase no-delay instances is 1000.224test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns225second # [ 0.005051] fsl-mc MSI: its@8080000 domain created226test # [ 0.000060] arm-pv: using stolen time PV227second # [ 0.005234] EFI services will not be available.228second # [ 0.005325] smp: Bringing up secondary CPUs ...229test # [ 0.000354] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)230second # [ 0.005353] smp: Brought up 1 node, 1 CPU231test # [ 0.000623] Console: colour dummy device 80x25232second # [ 0.005355] SMP: Total of 1 processors activated.233test # [ 0.000634] printk: legacy console [tty0] enabled234second # [ 0.005357] CPU: All CPU(s) started at EL1235second # [ 0.005368] CPU features: detected: 32-bit EL0 Support236test # [ 0.000830] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)237test # [ 0.000835] pid_max: default: 32768 minimum: 301238second # [ 0.005371] CPU features: detected: Data cache clean to the PoU not required for I/D coherence239test # [ 0.000908] LSM: initializing lsm=capability,landlock,yama,bpf,ima240second # [ 0.005374] CPU features: detected: Common not Private translations241test # [ 0.001063] landlock: Up and running.242second # [ 0.005376] CPU features: detected: CRC32 instructions243test # [ 0.001065] Yama: becoming mindful.244test # [ 0.001524] LSM support for eBPF active245second # [ 0.005378] CPU features: detected: Data cache clean to Point of Persistence246second # [ 0.005381] CPU features: detected: Enhanced Virtualization Traps247test # [ 0.001706] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)248second # [ 0.005390] CPU features: detected: RCpc load-acquire (LDAPR)249test # [ 0.001726] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)250second # [ 0.005393] CPU features: detected: LSE atomic instructions251test # [ 0.003578] cacheinfo: Unable to detect cache hierarchy for CPU 0252second # [ 0.005395] CPU features: detected: Privileged Access Never253test # [ 0.004478] rcu: Hierarchical SRCU implementation.254second # [ 0.005396] CPU features: detected: PMUv3255test # [ 0.004484] rcu: Max phase no-delay instances is 1000.256second # [ 0.005398] CPU features: detected: RAS Extension Support257test # [ 0.005411] fsl-mc MSI: its@8080000 domain created258second # [ 0.005402] CPU features: detected: Speculative Store Bypassing Safe (SSBS)259test # [ 0.005568] EFI services will not be available.260second # [ 0.005428] alternatives: applying system-wide alternatives261test # [ 0.005656] smp: Bringing up secondary CPUs ...262test # [ 0.005681] smp: Brought up 1 node, 1 CPU263second # [ 0.006771] CPU features: detected: Hardware dirty bit management on CPU0264test # [ 0.005684] SMP: Total of 1 processors activated.265test # [ 0.005686] CPU: All CPU(s) started at EL1266second # [ 0.007014] Memory: 892300K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114964K reserved, 32768K cma-reserved)267test # [ 0.005698] CPU features: detected: 32-bit EL0 Support268second # [ 0.007549] devtmpfs: initialized269test # [ 0.005700] CPU features: detected: Data cache clean to the PoU not required for I/D coherence270second # [ 0.009143] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)271test # [ 0.005703] CPU features: detected: Common not Private translations272second # [ 0.009166] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).273test # [ 0.005705] CPU features: detected: CRC32 instructions274second # [ 0.009302] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL275test # [ 0.005707] CPU features: detected: Data cache clean to Point of Persistence276second # [ 0.009305] 0 pages in range for non-PLT usage277test # [ 0.005710] CPU features: detected: Enhanced Virtualization Traps278second # [ 0.009306] 508288 pages in range for PLT usage279test # [ 0.005719] CPU features: detected: RCpc load-acquire (LDAPR)280second # [ 0.009423] pinctrl core: initialized pinctrl subsystem281second # [ 0.010172] DMI not present or invalid.282test # [ 0.005721] CPU features: detected: LSE atomic instructions283second # [ 0.013545] NET: Registered PF_NETLINK/PF_ROUTE protocol family284test # [ 0.005723] CPU features: detected: Privileged Access Never285test # [ 0.005725] CPU features: detected: PMUv3286second # [ 0.016229] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations287test # [ 0.005727] CPU features: detected: RAS Extension Support288second # [ 0.016363] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations289test # [ 0.005731] CPU features: detected: Speculative Store Bypassing Safe (SSBS)290second # [ 0.016514] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations291test # [ 0.005755] alternatives: applying system-wide alternatives292second # [ 0.016530] audit: initializing netlink subsys (disabled)293test # [ 0.007106] CPU features: detected: Hardware dirty bit management on CPU0294second # [ 0.017082] thermal_sys: Registered thermal governor 'fair_share'295second # [ 0.017084] thermal_sys: Registered thermal governor 'bang_bang'296test # [ 0.007333] Memory: 892344K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 114952K reserved, 32768K cma-reserved)297second # [ 0.017087] thermal_sys: Registered thermal governor 'step_wise'298test # [ 0.007764] devtmpfs: initialized299second # [ 0.017089] thermal_sys: Registered thermal governor 'user_space'300test # [ 0.009292] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)301second # [ 0.017091] thermal_sys: Registered thermal governor 'power_allocator'302test # [ 0.009314] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).303second # [ 0.017123] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1304second # [ 0.017136] cpuidle: using governor ladder305test # [ 0.009458] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL306second # [ 0.017142] cpuidle: using governor menu307test # [ 0.009462] 0 pages in range for non-PLT usage308second # [ 0.017270] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.309test # [ 0.009462] 508288 pages in range for PLT usage310test # [ 0.009562] pinctrl core: initialized pinctrl subsystem311second # [ 0.017289] ASID allocator initialised with 32768 entries312test # [ 0.010295] DMI not present or invalid.313second # [ 0.017947] Serial: AMBA PL011 UART driver314test # [ 0.013567] NET: Registered PF_NETLINK/PF_ROUTE protocol family315second # [ 0.021286] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1316test # [ 0.016254] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations317second # [ 0.021418] printk: console [ttyAMA0] enabled318test # [ 0.016387] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations319test # [ 0.016538] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations320test # [ 0.016555] audit: initializing netlink subsys (disabled)321test # [ 0.017179] thermal_sys: Registered thermal governor 'fair_share'322test # [ 0.017181] thermal_sys: Registered thermal governor 'bang_bang'323test # [ 0.017185] thermal_sys: Registered thermal governor 'step_wise'324test # [ 0.017186] thermal_sys: Registered thermal governor 'user_space'325test # [ 0.017188] thermal_sys: Registered thermal governor 'power_allocator'326test # [ 0.017220] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1327test # [ 0.017234] cpuidle: using governor ladder328test # [ 0.017239] cpuidle: using governor menu329test # [ 0.017363] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.330test # [ 0.017382] ASID allocator initialised with 32768 entries331test # [ 0.018041] Serial: AMBA PL011 UART driver332test # [ 0.021203] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1333test # [ 0.021335] printk: console [ttyAMA0] enabled334second # [ 0.093475] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages335second # [ 0.093488] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page336second # [ 0.093495] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages337second # [ 0.093498] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page338second # [ 0.093501] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages339second # [ 0.093504] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page340second # [ 0.093508] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages341second # [ 0.093511] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page342second # [ 0.098293] fbcon: Taking over console343second # [ 0.098315] ACPI: Interpreter disabled.344second # [ 0.099530] iommu: Default domain type: Translated345test # [ 0.094571] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages346second # [ 0.099541] iommu: DMA domain TLB invalidation policy: strict mode347test # [ 0.094583] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page348second # [ 0.100648] SCSI subsystem initialized349test # [ 0.094590] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages350test # [ 0.094593] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page351second # [ 0.101185] usbcore: registered new interface driver usbfs352second # [ 0.101224] usbcore: registered new interface driver hub353test # [ 0.094597] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages354second # [ 0.101234] usbcore: registered new device driver usb355test # [ 0.094600] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page356test # [ 0.094604] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages357test # [ 0.094607] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page358test # [ 0.099582] fbcon: Taking over console359test # [ 0.099604] ACPI: Interpreter disabled.360test # [ 0.100822] iommu: Default domain type: Translated361test # [ 0.100832] iommu: DMA domain TLB invalidation policy: strict mode362test # [ 0.101973] SCSI subsystem initialized363second # [ 0.109495] pps_core: LinuxPPS API ver. 1 registered364second # [ 0.109505] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>365second # [ 0.109512] PTP clock support registered366second # [ 0.109555] EDAC MC: Ver: 3.0.0367second # [ 0.111373] scmi_core: SCMI protocol bus registered368test # [ 0.106929] usbcore: registered new interface driver usbfs369second # [ 0.112079] FPGA manager framework370test # [ 0.106973] usbcore: registered new interface driver hub371second # [ 0.113034] vgaarb: loaded372test # [ 0.106984] usbcore: registered new device driver usb373second # [ 0.113483] clocksource: Switched to clocksource arch_sys_counter374test # [ 0.107173] pps_core: LinuxPPS API ver. 1 registered375test # [ 0.107179] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>376test # [ 0.107185] PTP clock support registered377test # [ 0.107214] EDAC MC: Ver: 3.0.0378test # [ 0.110203] scmi_core: SCMI protocol bus registered379test # [ 0.110951] FPGA manager framework380test # [ 0.111911] vgaarb: loaded381test # [ 0.112334] clocksource: Switched to clocksource arch_sys_counter382second # [ 0.120111] VFS: Disk quotas dquot_6.6.0383second # [ 0.120146] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)384second # [ 0.122415] netfs: FS-Cache loaded385second # [ 0.122510] pnp: PnP ACPI: disabled386second # [ 0.124924] NET: Registered PF_INET protocol family387second # [ 0.125124] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)388test # [ 0.122670] VFS: Disk quotas dquot_6.6.0389test # [ 0.122704] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390test # [ 0.124948] netfs: FS-Cache loaded391test # [ 0.125066] pnp: PnP ACPI: disabled392test # [ 0.127499] NET: Registered PF_INET protocol family393test # [ 0.127701] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)394test # [ 0.152223] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)395second # [ 0.149620] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)396test # [ 0.152248] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)397second # [ 0.149644] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)398second # [ 0.149658] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)399test # [ 0.152260] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)400second # [ 0.149693] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)401test # [ 0.152299] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)402second # [ 0.149762] TCP: Hash tables configured (established 8192 bind 8192)403second # [ 0.149855] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)404second # [ 0.149882] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)405second # [ 0.149938] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)406second # [ 0.150072] NET: Registered PF_UNIX/PF_LOCAL protocol family407second # [ 0.150141] NET: Registered PF_XDP protocol family408second # [ 0.150162] PCI: CLS 0 bytes, default 64409second # [ 0.150342] Trying to unpack rootfs image as initramfs...410test # [ 0.154870] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.154979] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.155008] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.155032] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.155149] NET: Registered PF_UNIX/PF_LOCAL protocol family415test # [ 0.155188] NET: Registered PF_XDP protocol family416test # [ 0.155209] PCI: CLS 0 bytes, default 64417test # [ 0.155404] Trying to unpack rootfs image as initramfs...418test # [ 0.163978] kvm [1]: HYP mode not available419second # [ 0.163383] kvm [1]: HYP mode not available420second # [ 0.228188] Initialise system trusted keyrings421second # [ 0.228682] workingset: timestamp_bits=42 max_order=18 bucket_order=0422second # [ 0.229639] squashfs: version 4.0 (2009/01/31) Phillip Lougher423second # [ 0.230130] 9p: Installing v9fs 9p2000 file system support424test # [ 0.229085] Initialise system trusted keyrings425test # [ 0.229582] workingset: timestamp_bits=42 max_order=18 bucket_order=0426test # [ 0.230537] squashfs: version 4.0 (2009/01/31) Phillip Lougher427test # [ 0.231059] 9p: Installing v9fs 9p2000 file system support428second # [ 0.245012] Key type asymmetric registered429second # [ 0.245033] Asymmetric key parser 'x509' registered430second # [ 0.245079] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)431second # [ 0.253562] io scheduler mq-deadline registered432second # [ 0.253575] io scheduler kyber registered433test # [ 0.250343] Key type asymmetric registered434test # [ 0.250365] Asymmetric key parser 'x509' registered435test # [ 0.250411] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)436test # [ 0.256381] io scheduler mq-deadline registered437test # [ 0.256396] io scheduler kyber registered438test # [ 0.259262] pl061_gpio 9030000.pl061: PL061 GPIO chip registered439test # [ 0.260069] ledtrig-cpu: registered to indicate activity on CPUs440second # [ 0.261588] pl061_gpio 9030000.pl061: PL061 GPIO chip registered441second # [ 0.261916] ledtrig-cpu: registered to indicate activity on CPUs442second # [ 0.262195] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:443second # [ 0.262215] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000444second # [ 0.262237] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000445second # [ 0.262243] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000446second # [ 0.262284] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits447test # [ 0.264452] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:448second # [ 0.262307] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]449test # [ 0.264476] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000450second # [ 0.262377] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00451second # [ 0.262395] pci_bus 0000:00: root bus resource [bus 00-ff]452test # [ 0.264497] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000453second # [ 0.262400] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]454test # [ 0.264504] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000455second # [ 0.262404] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]456test # [ 0.264537] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits457second # [ 0.262408] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]458second # [ 0.262538] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint459test # [ 0.264559] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]460second # [ 0.262981] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint461test # [ 0.264636] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00462second # [ 0.263122] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]463test # [ 0.264653] pci_bus 0000:00: root bus resource [bus 00-ff]464second # [ 0.263135] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]465test # [ 0.264658] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]466second # [ 0.263154] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]467test # [ 0.264662] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]468second # [ 0.263165] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]469test # [ 0.264666] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]470second # [ 0.263482] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint471test # [ 0.264751] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint472second # [ 0.263608] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]473test # [ 0.265204] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint474second # [ 0.263619] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]475test # [ 0.265336] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]476second # [ 0.263640] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]477test # [ 0.265348] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]478second # [ 0.263948] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint479test # [ 0.265368] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]480second # [ 0.264072] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]481test # [ 0.265379] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]482second # [ 0.264083] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]483test # [ 0.265704] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint484second # [ 0.264104] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]485test # [ 0.265833] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]486second # [ 0.264412] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint487test # [ 0.265846] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]488second # [ 0.264536] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]489test # [ 0.265866] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]490second # [ 0.264547] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]491second # [ 0.264567] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]492test # [ 0.266197] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint493test # [ 0.266326] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]494second # [ 0.264885] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint495test # [ 0.266338] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]496second # [ 0.265013] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]497second # [ 0.265025] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]498test # [ 0.266358] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]499second # [ 0.265045] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]500test # [ 0.266675] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint501test # [ 0.266803] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]502second # [ 0.265369] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint503second # [ 0.265516] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]504test # [ 0.266815] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]505second # [ 0.265529] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]506test # [ 0.266835] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]507second # [ 0.265550] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]508test # [ 0.267161] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint509test # [ 0.267289] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]510second # [ 0.265871] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint511second # [ 0.265999] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]512test # [ 0.267301] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]513second # [ 0.266010] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]514test # [ 0.267322] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]515second # [ 0.266034] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]516test # [ 0.267638] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint517second # [ 0.266045] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]518test # [ 0.267766] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]519test # [ 0.267778] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]520second # [ 0.266390] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint521second # [ 0.266525] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]522test # [ 0.267798] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]523second # [ 0.266546] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]524test # [ 0.268119] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint525test # [ 0.268249] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]526second # [ 0.266861] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint527test # [ 0.268261] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]528second # [ 0.266988] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]529test # [ 0.268286] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]530second # [ 0.267008] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]531test # [ 0.268297] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]532second # [ 0.267292] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint533second # [ 0.267415] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]534second # [ 0.267582] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint535second # [ 0.267781] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]536second # [ 0.267794] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]537second # [ 0.267814] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]538second # [ 0.268139] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint539second # [ 0.268263] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]540second # [ 0.268274] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]541second # [ 0.268295] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]542second # [ 0.268729] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned543second # [ 0.268740] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned544second # [ 0.268745] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned545second # [ 0.268778] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned546second # [ 0.268809] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned547second # [ 0.268840] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned548second # [ 0.268870] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned549second # [ 0.268901] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned550second # [ 0.268932] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned551second # [ 0.268965] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned552second # [ 0.268996] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned553second # [ 0.269027] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned554test # [ 0.296719] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint555second # [ 0.269112] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned556test # [ 0.296862] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]557second # [ 0.269146] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned558test # [ 0.296883] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559second # [ 0.269161] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned560test # [ 0.297217] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint561second # [ 0.269175] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned562test # [ 0.297350] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]563second # [ 0.269189] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned564test # [ 0.297372] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]565second # [ 0.269203] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned566second # [ 0.269217] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned567test # [ 0.297647] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint568second # [ 0.269231] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned569test # [ 0.297772] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]570second # [ 0.269246] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned571test # [ 0.297947] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint572second # [ 0.269260] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned573test # [ 0.298228] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]574second # [ 0.269274] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned575test # [ 0.298243] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]576second # [ 0.269288] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned577test # [ 0.298264] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]578second # [ 0.269302] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned579test # [ 0.298602] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint580second # [ 0.269316] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned581test # [ 0.298733] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]582second # [ 0.269330] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned583test # [ 0.298745] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]584second # [ 0.269343] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned585test # [ 0.298766] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]586second # [ 0.269356] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned587second # [ 0.269375] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned588test # [ 0.299194] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned589second # [ 0.269388] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned590test # [ 0.299205] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned591second # [ 0.269402] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned592test # [ 0.299210] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned593second # [ 0.269415] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned594test # [ 0.299244] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned595second # [ 0.269429] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned596second # [ 0.269447] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]597test # [ 0.299276] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned598second # [ 0.269453] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]599test # [ 0.299309] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned600second # [ 0.269457] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]601test # [ 0.299342] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned602test # [ 0.299374] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned603test # [ 0.299405] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned604test # [ 0.299437] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned605test # [ 0.299469] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned606test # [ 0.299500] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned607test # [ 0.299589] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned608test # [ 0.299623] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned609test # [ 0.299637] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned610test # [ 0.299652] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned611test # [ 0.299666] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned612test # [ 0.299680] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned613test # [ 0.299695] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned614test # [ 0.299709] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned615test # [ 0.299723] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned616second # [ 0.326297] pci 0000:00:0a.0: enabling device (0000 -> 0002)617test # [ 0.299737] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned618test # [ 0.299752] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned619test # [ 0.299766] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned620test # [ 0.299781] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned621test # [ 0.299795] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned622test # [ 0.299809] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned623test # [ 0.299823] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned624test # [ 0.299837] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned625test # [ 0.299856] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned626test # [ 0.299869] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned627test # [ 0.299883] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned628test # [ 0.299898] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned629test # [ 0.299912] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned630second # [ 0.332903] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)631test # [ 0.299929] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]632test # [ 0.299935] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]633test # [ 0.299939] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]634test # [ 0.300723] pci 0000:00:0a.0: enabling device (0000 -> 0002)635test # [ 0.335644] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)636second # [ 0.342667] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)637test # [ 0.345453] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)638second # [ 0.349610] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)639second # [ 0.351619] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)640second # [ 0.353420] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)641test # [ 0.352475] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)642test # [ 0.354298] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)643test # [ 0.356139] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)644second # [ 0.362940] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)645second # [ 0.364797] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)646test # [ 0.365468] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)647test # [ 0.367392] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)648second # [ 0.375395] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)649second # [ 0.377403] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)650second # [ 0.380030] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)651test # [ 0.378638] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)652second # [ 0.386327] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)653test # [ 0.384480] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)654test # [ 0.386130] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)655test # [ 0.388161] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)656second # [ 0.403347] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled657second # [ 0.404813] msm_serial: driver initialized658second # [ 0.404899] SuperH (H)SCI(F) driver initialized659second # [ 0.404938] STM32 USART driver initialized660test # [ 0.405062] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled661test # [ 0.406565] msm_serial: driver initialized662test # [ 0.406691] SuperH (H)SCI(F) driver initialized663test # [ 0.406727] STM32 USART driver initialized664second # [ 0.426181] loop: module loaded665second # [ 0.426312] virtio_blk virtio5: 1/0/0 default/read/poll queues666second # [ 0.426891] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)667test # [ 0.429041] loop: module loaded668test # [ 0.429180] virtio_blk virtio5: 1/0/0 default/read/poll queues669test # [ 0.429700] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)670second # [ 0.433850] megasas: 07.734.00.00-rc1671second # [ 0.434361] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]672second # [ 0.436827] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000673second # [ 0.436856] Intel/Sharp Extended Query Table at 0x0031674second # [ 0.438590] Using buffer write method675second # [ 0.438647] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]676second # [ 0.440497] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000677second # [ 0.440515] Intel/Sharp Extended Query Table at 0x0031678test # [ 0.436718] megasas: 07.734.00.00-rc1679test # [ 0.437197] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]680second # [ 0.450655] Using buffer write method681test # [ 0.439454] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000682second # [ 0.450677] Concatenating MTD devices:683second # [ 0.450680] (0): "0.flash"684test # [ 0.439484] Intel/Sharp Extended Query Table at 0x0031685second # [ 0.450683] (1): "0.flash"686test # [ 0.441282] Using buffer write method687second # [ 0.450685] into device "0.flash"688test # [ 0.441311] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689test # [ 0.443170] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690test # [ 0.443188] Intel/Sharp Extended Query Table at 0x0031691test # [ 0.449721] Using buffer write method692test # [ 0.449738] Concatenating MTD devices:693test # [ 0.449742] (0): "0.flash"694test # [ 0.449744] (1): "0.flash"695test # [ 0.449747] into device "0.flash"696second # [ 0.654982] Freeing initrd memory: 26160K697second # [ 0.661740] tun: Universal TUN/TAP device driver, 1.6698second # [ 0.664362] thunder_xcv, ver 1.0699test # [ 0.657486] Freeing initrd memory: 26148K700second # [ 0.664391] thunder_bgx, ver 1.0701second # [ 0.664404] nicpf, ver 1.0702second # [ 0.664717] e1000: Intel(R) PRO/1000 Network Driver703second # [ 0.664724] e1000: Copyright (c) 1999-2006 Intel Corporation.704second # [ 0.664739] e1000e: Intel(R) PRO/1000 Network Driver705second # [ 0.664745] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.706second # [ 0.664758] igb: Intel(R) Gigabit Ethernet Network Driver707second # [ 0.664762] igb: Copyright (c) 2007-2014 Intel Corporation.708second # [ 0.664772] igbvf: Intel(R) Gigabit Virtual Function Network Driver709second # [ 0.664776] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.710test # [ 0.664143] tun: Universal TUN/TAP device driver, 1.6711second # [ 0.664841] sky2: driver version 1.30712second # [ 0.670640] ehci-pci 0000:00:0a.0: EHCI Host Controller713second # [ 0.670683] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1714second # [ 0.670925] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000715second # [ 0.672657] usbcore: registered new interface driver usb-storage716second # [ 0.672779] usbcore: registered new interface driver usbserial_generic717test # [ 0.666729] thunder_xcv, ver 1.0718second # [ 0.672789] usbserial: USB Serial support registered for generic719test # [ 0.666756] thunder_bgx, ver 1.0720test # [ 0.666768] nicpf, ver 1.0721second # [ 0.673084] hv_vmbus: registering driver hyperv_keyboard722test # [ 0.667054] e1000: Intel(R) PRO/1000 Network Driver723test # [ 0.667062] e1000: Copyright (c) 1999-2006 Intel Corporation.724test # [ 0.667076] e1000e: Intel(R) PRO/1000 Network Driver725second # [ 0.675468] rtc-pl031 9010000.pl031: registered as rtc0726test # [ 0.667083] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.727test # [ 0.667095] igb: Intel(R) Gigabit Ethernet Network Driver728second # [ 0.675511] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T10:02:10 UTC (1788688930)729second # [ 0.675679] i2c_dev: i2c /dev entries driver730test # [ 0.667099] igb: Copyright (c) 2007-2014 Intel Corporation.731test # [ 0.667110] igbvf: Intel(R) Gigabit Virtual Function Network Driver732test # [ 0.667114] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.733test # [ 0.667176] sky2: driver version 1.30734test # [ 0.667941] usbcore: registered new interface driver usb-storage735test # [ 0.668024] usbcore: registered new interface driver usbserial_generic736test # [ 0.668032] usbserial: USB Serial support registered for generic737test # [ 0.668314] hv_vmbus: registering driver hyperv_keyboard738test # [ 0.668998] ehci-pci 0000:00:0a.0: EHCI Host Controller739test # [ 0.669040] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1740test # [ 0.669258] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000741test # [ 0.677547] rtc-pl031 9010000.pl031: registered as rtc0742test # [ 0.677589] rtc-pl031 9010000.pl031: setting system clock to 2026-09-06T10:02:10 UTC (1788688930)743test # [ 0.677746] i2c_dev: i2c /dev entries driver744second # [ 0.678452] sdhci: Secure Digital Host Controller Interface driver745test # [ 0.680590] sdhci: Secure Digital Host Controller Interface driver746second # [ 0.678467] sdhci: Copyright(c) Pierre Ossman747test # [ 0.680604] sdhci: Copyright(c) Pierre Ossman748second # [ 0.678608] Synopsys Designware Multimedia Card Interface Driver749test # [ 0.680738] Synopsys Designware Multimedia Card Interface Driver750second # [ 0.678783] sdhci-pltfm: SDHCI platform and OF driver helper751test # [ 0.680904] sdhci-pltfm: SDHCI platform and OF driver helper752second # [ 0.679738] hid: raw HID events driver (C) Jiri Kosina753test # [ 0.681766] hid: raw HID events driver (C) Jiri Kosina754second # [ 0.679898] usbcore: registered new interface driver usbhid755test # [ 0.681928] usbcore: registered new interface driver usbhid756second # [ 0.679903] usbhid: USB HID core driver757test # [ 0.681933] usbhid: USB HID core driver758second # [ 0.714148] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00759second # [ 0.714514] hub 1-0:1.0: USB hub found760second # [ 0.714548] hub 1-0:1.0: 6 ports detected761test # [ 0.709068] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00762test # [ 0.709479] hub 1-0:1.0: USB hub found763test # [ 0.709504] hub 1-0:1.0: 6 ports detected764second # [ 0.715893] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available765test # [ 0.709786] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available766second # [ 0.716673] drop_monitor: Initializing network drop monitor service767test # [ 0.710547] drop_monitor: Initializing network drop monitor service768second # [ 0.716834] NET: Registered PF_INET6 protocol family769test # [ 0.710715] NET: Registered PF_INET6 protocol family770second # [ 0.719151] Segment Routing with IPv6771test # [ 0.714067] Segment Routing with IPv6772second # [ 0.719171] In-situ OAM (IOAM) with IPv6773test # [ 0.714086] In-situ OAM (IOAM) with IPv6774second # [ 0.719223] NET: Registered PF_PACKET protocol family775test # [ 0.714159] NET: Registered PF_PACKET protocol family776test # [ 0.715246] 9pnet: Installing 9P2000 support777second # [ 0.720316] 9pnet: Installing 9P2000 support778second # [ 0.722186] Key type dns_resolver registered779test # [ 0.717170] Key type dns_resolver registered780second # [ 0.725329] registered taskstats version 1781second # [ 0.725476] Loading compiled-in X.509 certificates782test # [ 0.720368] registered taskstats version 1783test # [ 0.720535] Loading compiled-in X.509 certificates784second # [ 0.730783] Demotion targets for Node 0: null785test # [ 0.725875] Demotion targets for Node 0: null786second # [ 0.730855] Key type .fscrypt registered787test # [ 0.725948] Key type .fscrypt registered788second # [ 0.730861] Key type fscrypt-provisioning registered789test # [ 0.725953] Key type fscrypt-provisioning registered790second # [ 0.731008] ima: No TPM chip found, activating TPM-bypass!791test # [ 0.726076] ima: No TPM chip found, activating TPM-bypass!792second # [ 0.731021] ima: Allocated hash algorithm: sha1793test # [ 0.726089] ima: Allocated hash algorithm: sha1794second # [ 0.731073] ima: No architecture policies found795test # [ 0.726140] ima: No architecture policies found796test # [ 0.728810] input: gpio-keys as /devices/platform/gpio-keys/input/input0797second # [ 0.733765] input: gpio-keys as /devices/platform/gpio-keys/input/input0798test # [ 0.739485] clk: Disabling unused clocks799second # [ 0.744333] clk: Disabling unused clocks800test # [ 0.739503] PM: genpd: Disabling unused power domains801second # [ 0.744352] PM: genpd: Disabling unused power domains802second # [ 0.747522] Freeing unused kernel memory: 4736K803test # [ 0.742672] Freeing unused kernel memory: 4736K804second # [ 0.747617] Run /init as init process805test # [ 0.742756] Run /init as init process806test # [ 0.762965] systemd[1]: Successfully made /usr/ read-only.807second # [ 0.768137] systemd[1]: Successfully made /usr/ read-only.808second # [ 0.961586] usb 1-1: new high-speed USB device number 2 using ehci-pci809test # [ 0.956434] usb 1-1: new high-speed USB device number 2 using ehci-pci810test # [ 1.097421] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)811second # [ 1.102574] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)812second # [ 1.110023] systemd[1]: Detected virtualization qemu.813test # [ 1.104861] systemd[1]: Detected virtualization qemu.814test # [ 1.106449] systemd[1]: Detected architecture arm64.815second # [ 1.111552] systemd[1]: Detected architecture arm64.816test # [ 1.107975] systemd[1]: Running in initrd.817second # [ 1.113129] systemd[1]: Running in initrd.818test # [ 1.110125] systemd[1]: Initializing machine ID from random generator.819second # [ 1.115259] systemd[1]: Initializing machine ID from random generator.820second # [ 1.117447] systemd[1]: Hostname set to <second>.821test # [ 1.112313] systemd[1]: Hostname set to <test>.822test # [ 1.121241] 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.128496] 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/input1824test # [ 1.200506] 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.205685] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0826second # [ 1.325574] usb 1-2: new high-speed USB device number 3 using ehci-pci827test # [ 1.320454] usb 1-2: new high-speed USB device number 3 using ehci-pci828second # [ 1.399269] systemd[1]: bpf-restrict-fs: LSM BPF program attached829test # [ 1.394302] systemd[1]: bpf-restrict-fs: LSM BPF program attached830second # [ 1.476523] systemd[1]: Queued start job for default target Initrd Default Target.831second # [ 1.479420] 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/input2832second # [ 1.480779] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0833second # [ 1.487084] systemd[1]: Created slice Slice /system/modprobe.834test # [ 1.481239] 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/input2835second # [ 1.488032] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.836test # [ 1.483254] systemd[1]: Queued start job for default target Initrd Default Target.837second # [ 1.488846] systemd[1]: Expecting device /dev/disk/by-label/nixos...838second # [ 1.489473] systemd[1]: Reached target Path Units.839second # [ 1.490065] systemd[1]: Reached target Slice Units.840second # [ 1.490566] systemd[1]: Reached target Swaps.841test # [ 1.484501] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0842second # [ 1.491008] systemd[1]: Reached target Timer Units.843second # [ 1.491708] systemd[1]: Listening on D-Bus System Message Bus Socket.844second # [ 1.492481] systemd[1]: Listening on Journal Socket (/dev/log).845second # [ 1.493287] systemd[1]: Listening on Journal Sockets.846second # [ 1.493974] systemd[1]: Listening on udev Control Socket.847second # [ 1.494642] systemd[1]: Listening on udev Kernel Socket.848second # [ 1.495214] systemd[1]: Reached target Socket Units.849second # [ 1.496792] systemd[1]: Starting Create List of Static Device Nodes...850test # [ 1.494274] systemd[1]: Created slice Slice /system/modprobe.851test # [ 1.495241] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.852test # [ 1.496328] systemd[1]: Expecting device /dev/disk/by-label/nixos...853test # [ 1.497191] systemd[1]: Reached target Path Units.854test # [ 1.497848] systemd[1]: Reached target Slice Units.855test # [ 1.498532] systemd[1]: Reached target Swaps.856test # [ 1.499120] systemd[1]: Reached target Timer Units.857test # [ 1.500105] systemd[1]: Listening on D-Bus System Message Bus Socket.858test # [ 1.501214] systemd[1]: Listening on Journal Socket (/dev/log).859test # [ 1.502139] systemd[1]: Listening on Journal Sockets.860test # [ 1.502937] systemd[1]: Listening on udev Control Socket.861test # [ 1.503789] systemd[1]: Listening on udev Kernel Socket.862test # [ 1.504637] systemd[1]: Reached target Socket Units.863test # [ 1.506682] systemd[1]: Starting Create List of Static Device Nodes...864second # [ 1.513074] systemd[1]: Starting Load Kernel Module 9pnet_virtio...865second # [ 1.513126] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs866second # [ 1.515892] systemd[1]: Mounting Kernel Configuration File System...867test # [ 1.512710] systemd[1]: Starting Load Kernel Module 9pnet_virtio...868test # [ 1.513572] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs869second # [ 1.525584] systemd[1]: Starting Journal Service...870second # [ 1.526876] systemd[1]: Starting Load Kernel Modules...871second # [ 1.527585] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os872test # [ 1.525220] systemd[1]: Mounting Kernel Configuration File System...873second # [ 1.533584] systemd[1]: Starting Coldplug All udev Devices...874second # [ 1.536853] systemd[1]: Finished Create List of Static Device Nodes.875second # [ 1.538244] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.876test # [ 1.540506] systemd[1]: Starting Journal Service...877second # [ 1.549650] systemd[1]: Finished Load Kernel Module 9pnet_virtio.878second # [ 1.549976] systemd[1]: Mounted Kernel Configuration File System.879second # [ 1.551729] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...880test # [ 1.548536] systemd[1]: Starting Load Kernel Modules...881test # [ 1.549163] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os882test # [ 1.561059] systemd[1]: Starting Coldplug All udev Devices...883test # [ 1.568435] systemd[1]: Finished Create List of Static Device Nodes.884test # [ 1.570145] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.885second # [ 1.576398] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.886test # [ 1.576648] systemd[1]: Finished Load Kernel Module 9pnet_virtio.887test # [ 1.576842] systemd[1]: Mounted Kernel Configuration File System.888second # [ 1.585895] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.889second # [ 1.588002] systemd-journald[73]: Collecting audit messages is disabled.890second # [ 1.588745] systemd[1]: Starting Create Static Device Nodes in /dev...891test # [ 1.584597] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...892second # [ 1.593622] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev893second # [ 1.601421] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0894test # [ 1.602284] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.895second # [ 1.614832] [drm] features: -virgl +edid -resource_blob -host_visible896second # [ 1.614844] [drm] features: -context_init897test # [ 1.611032] systemd-journald[73]: Collecting audit messages is disabled.898second # [ 1.615346] [drm] number of scanouts: 1899second # [ 1.615362] [drm] number of cap sets: 0900test # [ 1.611936] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.901test # [ 1.613461] systemd[1]: Starting Create Static Device Nodes in /dev...902second # [ 1.621899] systemd[1]: Finished Create Static Device Nodes in /dev.903second # [ 1.622059] systemd[1]: Reached target Preparation for Local File Systems.904second # [ 1.622088] systemd[1]: Reached target Local File Systems.905second # [ 1.623044] systemd[1]: Starting Rule-based Manager for Device Events and Files...906test # [ 1.620525] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev907test # [ 1.624861] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0908test # [ 1.625088] [drm] features: -virgl +edid -resource_blob -host_visible909test # [ 1.625093] [drm] features: -context_init910test # [ 1.625549] [drm] number of scanouts: 1911test # [ 1.625565] [drm] number of cap sets: 0912second # [ 1.627815] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic913second # [ 1.627828] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0914test # [ 1.640719] systemd[1]: Finished Create Static Device Nodes in /dev.915test # [ 1.640886] systemd[1]: Reached target Preparation for Local File Systems.916test # [ 1.640918] systemd[1]: Reached target Local File Systems.917test # [ 1.643447] systemd[1]: Starting Rule-based Manager for Device Events and Files...918second # [ 1.645908] Console: switching to colour frame buffer device 160x50919second # [ 1.651195] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device920test # [ 1.652589] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic921test # [ 1.652602] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0922second # [ 1.672518] systemd[1]: Started Journal Service.923second # [ 1.679647] systemd-modules-load[74]: Inserted module 'dm_mod'924second # [ 1.680688] systemd-modules-load[74]: Module 'virtio_balloon' is built in925second # [ 1.681391] systemd-modules-load[74]: Module 'virtio_console' is built in926second # [ 1.682106] systemd-modules-load[74]: Inserted module 'virtio_gpu'927test # [ 1.676757] Console: switching to colour frame buffer device 160x50928second # [ 1.682791] systemd-modules-load[74]: Module 'virtio_rng' is built in929test # [ 1.682180] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device930second # [ 1.683485] systemd[1]: Finished Load Kernel Modules.931second # [ 1.692130] systemd[1]: Starting Apply Kernel Variables...932second # [ 1.700994] systemd[1]: Starting Create System Files and Directories...933test # [ 1.704699] systemd[1]: Finished Load Kernel Modules.934test # [ 1.706649] systemd[1]: Starting Apply Kernel Variables...935second # [ 1.708363] systemd-udevd[80]: Using default interface naming scheme 'v261'.936test # [ 1.710355] systemd[1]: Started Journal Service.937second # [ 1.713444] systemd[1]: Finished Apply Kernel Variables.938test # [ 1.708257] systemd-modules-load[74]: Inserted module 'dm_mod'939test # [ 1.709020] systemd-modules-load[74]: Module 'virtio_balloon' is built in940test # [ 1.716162] systemd-modules-load[74]: Module 'virtio_console' is built in941test # [ 1.716955] systemd-modules-load[74]: Inserted module 'virtio_gpu'942test # [ 1.717677] systemd-modules-load[74]: Module 'virtio_rng' is built in943test # [ 1.719505] systemd-udevd[81]: Using default interface naming scheme 'v261'.944second # [ 1.727988] systemd[1]: Finished Create System Files and Directories.945test # [ 1.724251] systemd[1]: Starting Create System Files and Directories...946second # [ 1.742121] systemd[1]: Started Rule-based Manager for Device Events and Files.947test # [ 1.743423] systemd[1]: Finished Apply Kernel Variables.948test # [ 1.752667] systemd[1]: Finished Create System Files and Directories.949test # [ 1.760995] systemd[1]: Started Rule-based Manager for Device Events and Files.950second # [ 1.776065] systemd[1]: Starting Virtual Console Setup...951test # [ 1.799098] systemd[1]: Starting Virtual Console Setup...952second # [ 1.808344] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.953second # [ 1.810407] systemd[1]: Finished Virtual Console Setup.954test # [ 1.828292] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.955test # [ 1.830474] systemd[1]: Finished Virtual Console Setup.956second # [ 2.036701] systemd[1]: Finished Coldplug All udev Devices.957second # [ 2.037282] systemd[1]: Reached target System Initialization.958second # [ 2.037818] systemd[1]: Reached target Basic System.959test # [ 2.076825] systemd[1]: Finished Coldplug All udev Devices.960test # [ 2.077395] systemd[1]: Reached target System Initialization.961test # [ 2.077928] systemd[1]: Reached target Basic System.962second # [ 2.131606] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.963second # [ 2.152279] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.964test # [ 2.167977] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.965test # [ 2.171187] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.966second # [ 2.204377] systemd[1]: Found device /dev/disk/by-label/nixos.967second # [ 2.216654] systemd[1]: Reached target Initrd Root Device.968second # [ 2.219728] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969second # [ 2.256109] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks970test # [ 2.253087] systemd[1]: Found device /dev/disk/by-label/nixos.971second # [ 2.263484] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.972test # [ 2.257181] systemd[1]: Reached target Initrd Root Device.973test # [ 2.259672] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...974test # [ 2.291605] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks975test # [ 2.298438] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.976second # [ 2.529822] systemd[1]: Mounting /sysroot...977second # [ 2.559396] EXT4-fs (vda): mounted filesystem 304d3212-49a0-4e3a-99fb-56cb7ddbe930 r/w with ordered data mode. Quota mode: none.978second # [ 2.558465] systemd[1]: Mounted /sysroot.979second # [ 2.560407] systemd[1]: Reached target Initrd Root File System.980second # [ 2.563077] systemd[1]: Starting Mountpoints Configured in the Real Root...981test # [ 2.555311] systemd[1]: Mounting /sysroot...982second # [ 2.574519] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload.983second # [ 2.579932] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)...984second # [ 2.583194] systemd[1]: Reloading...985test # [ 2.587232] EXT4-fs (vda): mounted filesystem 9ddadaa9-be1e-4dc5-abd8-4186022334fe r/w with ordered data mode. Quota mode: none.986test # [ 2.585303] systemd[1]: Mounted /sysroot.987test # [ 2.585761] systemd[1]: Reached target Initrd Root File System.988test # [ 2.588102] systemd[1]: Starting Mountpoints Configured in the Real Root...989test # [ 2.596922] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.990test # [ 2.600239] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...991test # [ 2.603489] systemd[1]: Reloading...992second # [ 2.740207] systemd[1]: Reloading finished in 157 ms.993second # [ 2.763570] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace...994second # [ 2.766419] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace...995test # [ 2.759471] systemd[1]: Reloading finished in 156 ms.996second # [ 2.774027] systemd[1]: Starting Load Kernel Module 9pnet_virtio...997second # [ 2.776070] systemd[1]: initrd-parse-etc.service: Deactivated successfully.998second # [ 2.784066] systemd[1]: Finished Mountpoints Configured in the Real Root.999second # [ 2.784694] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1000second # [ 2.787477] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1001test # [ 2.779529] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1002second # [ 2.789616] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1003test # [ 2.782660] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1004test # [ 2.790084] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1005test # [ 2.794866] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1006test # [ 2.800326] systemd[1]: Finished Mountpoints Configured in the Real Root.1007test # [ 2.802161] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1008test # [ 2.804212] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1009test # [ 2.805578] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1010second # [ 2.957179] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1011second # [ 2.960276] (udev-worker)[101]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1012second # [ 2.973732] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1013second # [ 2.974480] systemd[1]: Stopped Virtual Console Setup.1014second # [ 2.976491] systemd[1]: Stopping Virtual Console Setup...1015second # [ 2.979940] systemd[1]: Starting Virtual Console Setup...1016test # [ 2.987485] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1017second # [ 2.998559] systemd-vconsole-setup[140]: Configuration of first virtual console was skipped, ignoring remaining ones.1018second # [ 3.000657] systemd[1]: Finished Virtual Console Setup.1019test # [ 2.991801] (udev-worker)[97]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1020test # [ 3.014874] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1021test # [ 3.015636] systemd[1]: Stopped Virtual Console Setup.1022test # [ 3.016278] systemd[1]: Stopping Virtual Console Setup...1023test # [ 3.017524] systemd[1]: Starting Virtual Console Setup...1024test # [ 3.038481] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1025test # [ 3.040571] systemd[1]: Finished Virtual Console Setup.1026second # [ 3.534034] systemd[1]: Mounting /sysroot/nix/.ro-store...1027second # [ 3.544272] systemd[1]: Mounting /sysroot/nix/.rw-store...1028second # [ 3.547564] systemd[1]: Mounting /sysroot/run...1029second # [ 3.560147] systemd[1]: Mounting /sysroot/tmp/shared...1030test # [ 3.558565] systemd[1]: Mounting /sysroot/nix/.ro-store...1031test # [ 3.568262] systemd[1]: Mounting /sysroot/nix/.rw-store...1032test # [ 3.571529] systemd[1]: Mounting /sysroot/run...1033second # [ 3.584991] systemd[1]: Mounting /sysroot/tmp/xchg...1034test # [ 3.582763] systemd[1]: Mounting /sysroot/tmp/shared...1035second # [ 3.604237] systemd[1]: Mounted /sysroot/nix/.rw-store.1036test # [ 3.608279] systemd[1]: Mounting /sysroot/tmp/xchg...1037second # [ 3.620225] systemd[1]: Starting rw-sysroot-nix-store.service...1038second # [ 3.624874] systemd[1]: Mounted /sysroot/nix/.ro-store.1039second # [ 3.627233] systemd[1]: Mounted /sysroot/run.1040second # [ 3.629017] systemd[1]: Mounted /sysroot/tmp/shared.1041second # [ 3.635139] systemd[1]: Mounted /sysroot/tmp/xchg.1042test # [ 3.629314] systemd[1]: Mounted /sysroot/nix/.rw-store.1043second # [ 3.643498] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1044second # [ 3.644742] systemd[1]: Finished rw-sysroot-nix-store.service.1045test # [ 3.648231] systemd[1]: Starting rw-sysroot-nix-store.service...1046test # [ 3.651116] systemd[1]: Mounted /sysroot/nix/.ro-store.1047test # [ 3.653099] systemd[1]: Mounted /sysroot/run.1048test # [ 3.657235] systemd[1]: Mounted /sysroot/tmp/shared.1049test # [ 3.662644] systemd[1]: Mounted /sysroot/tmp/xchg.1050test # [ 3.671721] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1051test # [ 3.673199] systemd[1]: Finished rw-sysroot-nix-store.service.1052test # [ 3.675502] systemd[1]: Mounting /sysroot/nix/store...1053test # [ 3.700954] systemd[1]: Mounted /sysroot/nix/store.1054test # [ 3.702153] systemd[1]: Reached target Initrd File Systems.1055test # [ 3.704116] systemd[1]: Starting Find NixOS closure...1056test # [ 3.711784] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1057test # [ 3.734747] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1058test # [ 3.746649] systemd[1]: Finished Find NixOS closure.1059test # [ 3.747222] systemd[1]: Reached target Initrd Default Target.1060test # [ 3.751179] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1061test # [ 3.763725] systemd[1]: initrd-cleanup.service: Deactivated successfully.1062test # [ 3.764798] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1063test # [ 3.767140] systemd[1]: Stopped target Initrd Default Target.1064test # [ 3.767703] systemd[1]: Stopped target Basic System.1065test # [ 3.768231] systemd[1]: Stopped target Initrd Root Device.1066test # [ 3.770438] systemd[1]: Stopped target Path Units.1067test # [ 3.770921] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1068test # [ 3.771565] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1069test # [ 3.773114] systemd[1]: Stopped target Slice Units.1070test # [ 3.776054] systemd[1]: Stopped target Socket Units.1071test # [ 3.776545] systemd[1]: Stopped target System Initialization.1072test # [ 3.777034] systemd[1]: Stopped target Swaps.1073test # [ 3.777426] systemd[1]: Stopped target Timer Units.1074test # [ 3.777868] systemd[1]: dbus.socket: Deactivated successfully.1075test # [ 3.778377] systemd[1]: Closed D-Bus System Message Bus Socket.1076test # [ 3.778884] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1077test # [ 3.779519] systemd[1]: Stopped Find NixOS closure.1078test # [ 3.779950] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1079test # [ 3.783538] systemd[1]: Starting rw-sysroot-nix-store.service...1080test # [ 3.794343] systemd[1]: systemd-sysctl.service: Deactivated successfully.1081test # [ 3.794988] systemd[1]: Stopped Apply Kernel Variables.1082test # [ 3.796941] systemd[1]: systemd-modules-load.service: Deactivated successfully.1083test # [ 3.799256] systemd[1]: Stopped Load Kernel Modules.1084test # [ 3.800355] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1085test # [ 3.801053] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1086test # [ 3.801733] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1087test # [ 3.802357] systemd[1]: Stopped Create System Files and Directories.1088test # [ 3.802913] systemd[1]: Stopped target Local File Systems.1089test # [ 3.803393] systemd[1]: Stopped target Preparation for Local File Systems.1090test # [ 3.803970] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1091test # [ 3.810752] systemd[1]: Stopped Coldplug All udev Devices.1092test # [ 3.811287] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1093test # [ 3.811931] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1094test # [ 3.812787] systemd[1]: Stopped Virtual Console Setup.1095test # [ 3.813270] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1096test # [ 3.814263] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1097test # [ 3.814813] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1098test # [ 3.815431] systemd[1]: Finished rw-sysroot-nix-store.service.1099test # [ 3.815956] systemd[1]: systemd-udevd.service: Deactivated successfully.1100test # [ 3.816887] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1101test # [ 3.817541] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1102test # [ 3.818178] systemd[1]: Closed udev Control Socket.1103test # [ 3.818609] systemd[1]: Starting Cleanup udev Database...1104test # [ 3.819066] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1105test # [ 3.819679] systemd[1]: Stopped Create Static Device Nodes in /dev.1106test # [ 3.822799] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1107test # [ 3.824140] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1108test # [ 3.828192] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1109test # [ 3.828850] systemd[1]: Stopped Create List of Static Device Nodes.1110test # [ 3.839340] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1111test # [ 3.840470] systemd[1]: Finished Cleanup udev Database.1112test # [ 3.843775] systemd[1]: Reached target Switch Root.1113test # [ 3.845037] systemd[1]: Starting NixOS Activation...1114test # [ 4.014356] initrd-nixos-activation-start[179]: booting system configuration /nix/store/hvcpwzp5aib802vmfx6k40i2rjdp62r2-nixos-system-test-test1115test # [ 4.077108] initrd-nixos-activation-start[179]: running activation script...1116test # [ 4.508799] initrd-nixos-activation-start[202]: setting up /etc...1117second # [ 4.531495] systemd[1]: Mounting /sysroot/nix/store...1118second # [ 4.577021] systemd[1]: Mounted /sysroot/nix/store.1119second # [ 4.578804] systemd[1]: Reached target Initrd File Systems.1120second # [ 4.581990] systemd[1]: Starting Find NixOS closure...1121second # [ 4.589025] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1122second # [ 4.630848] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1123second # [ 4.636285] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1124second # [ 4.650324] systemd[1]: Finished Find NixOS closure.1125second # [ 4.652233] systemd[1]: Reached target Initrd Default Target.1126second # [ 4.654128] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1127second # [ 4.683939] systemd[1]: initrd-cleanup.service: Deactivated successfully.1128second # [ 4.685855] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1129second # [ 4.689157] systemd[1]: Stopped target Initrd Default Target.1130second # [ 4.692195] systemd[1]: Stopped target Basic System.1131second # [ 4.692968] systemd[1]: Stopped target Initrd Root Device.1132second # [ 4.694394] systemd[1]: Stopped target Path Units.1133second # [ 4.696222] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1134second # [ 4.699416] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1135second # [ 4.705173] systemd[1]: Stopped target Slice Units.1136second # [ 4.706025] systemd[1]: Stopped target Socket Units.1137second # [ 4.706634] systemd[1]: Stopped target System Initialization.1138second # [ 4.707314] systemd[1]: Stopped target Swaps.1139second # [ 4.707866] systemd[1]: Stopped target Timer Units.1140second # [ 4.713415] systemd[1]: dbus.socket: Deactivated successfully.1141second # [ 4.715429] systemd[1]: Closed D-Bus System Message Bus Socket.1142second # [ 4.717911] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1143second # [ 4.718736] systemd[1]: Stopped Find NixOS closure.1144second # [ 4.719270] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1145second # [ 4.719934] systemd[1]: Starting rw-sysroot-nix-store.service...1146second # [ 4.730955] systemd[1]: systemd-sysctl.service: Deactivated successfully.1147second # [ 4.731668] systemd[1]: Stopped Apply Kernel Variables.1148second # [ 4.734560] systemd[1]: systemd-modules-load.service: Deactivated successfully.1149second # [ 4.736299] systemd[1]: Stopped Load Kernel Modules.1150second # [ 4.736896] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1151second # [ 4.740215] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1152second # [ 4.740978] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1153second # [ 4.742017] systemd[1]: Stopped Create System Files and Directories.1154second # [ 4.743009] systemd[1]: Stopped target Local File Systems.1155second # [ 4.743602] systemd[1]: Stopped target Preparation for Local File Systems.1156second # [ 4.744470] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1157second # [ 4.745135] systemd[1]: Stopped Coldplug All udev Devices.1158second # [ 4.745826] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1159second # [ 4.746491] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1160second # [ 4.747141] systemd[1]: Stopped Virtual Console Setup.1161second # [ 4.747614] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1162second # [ 4.752221] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1163second # [ 4.756150] systemd[1]: systemd-udevd.service: Deactivated successfully.1164second # [ 4.756839] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1165second # [ 4.757586] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1166second # [ 4.758228] systemd[1]: Closed udev Control Socket.1167second # [ 4.758683] systemd[1]: Starting Cleanup udev Database...1168second # [ 4.759171] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1169second # [ 4.764520] systemd[1]: Stopped Create Static Device Nodes in /dev.1170second # [ 4.765117] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1171second # [ 4.765828] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1172second # [ 4.766434] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1173second # [ 4.767024] systemd[1]: Stopped Create List of Static Device Nodes.1174second # [ 4.767555] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1175test # [ 4.763260] initrd-nixos-activation-start[202]: setting up age secrets...1176second # [ 4.771906] systemd[1]: Finished rw-sysroot-nix-store.service.1177second # [ 4.776067] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1178second # [ 4.776754] systemd[1]: Finished Cleanup udev Database.1179second # [ 4.777229] systemd[1]: Reached target Switch Root.1180second # [ 4.777694] systemd[1]: Starting NixOS Activation...1181second # [ 4.943617] initrd-nixos-activation-start[179]: booting system configuration /nix/store/32hmpxw50hbba1k5ghwa1slcg5i95hyc-nixos-system-second-test1182second # [ 5.006701] initrd-nixos-activation-start[179]: running activation script...1183test # [ 5.044229] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1184test # [ 5.046044] systemd[1]: Finished NixOS Activation.1185test # [ 5.046858] systemd[1]: Starting Switch Root...1186test # [ 5.064687] systemd[1]: Switching root.1187test # [ 5.234636] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1188second # [ 5.437501] initrd-nixos-activation-start[202]: setting up /etc...1189second # [ 5.688912] initrd-nixos-activation-start[202]: setting up age secrets...1190test # [ 5.816840] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1191test # [ 5.823768] systemd[1]: Detected virtualization qemu.1192test # [ 5.826094] systemd[1]: Detected architecture arm64.1193test # [ 5.827341] systemd[1]: Detected first boot.1194test # [ 5.832668] systemd[1]: Initializing machine ID from random generator.1195second # [ 5.895356] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1196second # [ 5.897067] systemd[1]: Finished NixOS Activation.1197second # [ 5.897838] systemd[1]: Starting Switch Root...1198second # [ 5.912573] systemd[1]: Switching root.1199second # [ 6.080261] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1200test # [ 6.119957] systemd[1]: bpf-restrict-fs: LSM BPF program attached1201test # [ 6.314577] systemd[1]: Applying preset policy.1202second # [ 6.667699] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1203second # [ 6.674682] systemd[1]: Detected virtualization qemu.1204second # [ 6.676402] systemd[1]: Detected architecture arm64.1205second # [ 6.678748] systemd[1]: Detected first boot.1206second # [ 6.683667] systemd[1]: Initializing machine ID from random generator.1207test # [ 6.862890] systemd[1]: Populated /etc with preset unit settings.1208second # [ 6.973191] systemd[1]: bpf-restrict-fs: LSM BPF program attached1209second # [ 7.166818] systemd[1]: Applying preset policy.1210test # [ 7.412830] systemd[1]: initrd-switch-root.service: Deactivated successfully.1211test # [ 7.413692] systemd[1]: Stopped initrd-switch-root.service.1212test # [ 7.415588] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1213test # [ 7.418613] systemd[1]: Created slice Slice /system/getty.1214test # [ 7.420191] systemd[1]: Created slice User and Session Slice.1215test # [ 7.421504] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1216test # [ 7.422906] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1217test # [ 7.424175] systemd[1]: Expecting device /dev/hvc0...1218test # [ 7.425294] systemd[1]: Expecting device /dev/ttyAMA0...1219test # [ 7.426226] systemd[1]: Reached target Local Encrypted Volumes.1220test # [ 7.427275] systemd[1]: Stopped target initrd-fs.target.1221test # [ 7.428257] systemd[1]: Stopped target initrd-root-fs.target.1222test # [ 7.429311] systemd[1]: Stopped target initrd-switch-root.target.1223test # [ 7.430337] systemd[1]: Reached target Virtual Machines and Containers.1224test # [ 7.431380] systemd[1]: Reached target Path Units.1225test # [ 7.432299] systemd[1]: Reached target Remote File Systems.1226test # [ 7.433404] systemd[1]: Reached target Slice Units.1227test # [ 7.434823] systemd[1]: Reached target Swaps.1228test # [ 7.438404] systemd[1]: Listening on Query the User Interactively for a Password.1229test # [ 7.442711] systemd[1]: Listening on Process Core Dump Socket.1230test # [ 7.446122] systemd[1]: Listening on Credential Encryption/Decryption.1231test # [ 7.449491] systemd[1]: Listening on Factory Reset Management.1232test # [ 7.450520] systemd[1]: Listening on Hostname Service Socket.1233test # [ 7.454697] systemd[1]: Starting Journal Log Access Socket...1234test # [ 7.456234] systemd[1]: Listening on Journal Audit Socket.1235test # [ 7.459743] systemd[1]: Listening on Console Output Muting Service Socket.1236test # [ 7.461147] systemd[1]: Listening on Network Management Metrics Varlink Socket.1237test # [ 7.462451] systemd[1]: Listening on Network Management Varlink Socket.1238test # [ 7.464169] systemd[1]: Listening on Network Management Netlink Socket.1239test # [ 7.466458] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1240test # [ 7.468038] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1241test # [ 7.469819] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1242test # [ 7.479166] systemd[1]: Listening on Disk Repartitioning Service Socket.1243test # [ 7.480251] systemd[1]: Listening on Resolve Monitor Varlink Socket.1244test # [ 7.481352] systemd[1]: Listening on Resolve Service Varlink Socket.1245test # [ 7.482437] systemd[1]: Listening on udev Control Socket.1246test # [ 7.483449] systemd[1]: Listening on udev Varlink Socket.1247test # [ 7.487144] systemd[1]: Mounting Huge Pages File System...1248test # [ 7.490960] systemd[1]: Mounting POSIX Message Queue File System...1249test # [ 7.499514] systemd[1]: Mounting Kernel Debug File System...1250test # [ 7.503312] systemd[1]: Mounting Kernel Trace File System...1251test # [ 7.516971] systemd[1]: Starting Create List of Static Device Nodes...1252test # [ 7.521772] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1253test # [ 7.522863] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1254test # [ 7.536122] systemd[1]: Mounting Kernel Configuration File System...1255test # [ 7.538575] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1256test # [ 7.543112] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1257test # [ 7.552696] systemd[1]: Starting Load Kernel Module fuse...1258test # [ 7.556127] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671259test # [ 7.598563] systemd[1]: Starting Journal Service...1260test # [ 7.627498] systemd[1]: Starting Load Kernel Modules...1261test # [ 7.643285] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1262test # [ 7.664057] systemd[1]: Starting Remount Root and Kernel File Systems...1263test # [ 7.667081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1264test # [ 7.690946] systemd[1]: Starting Coldplug All udev Devices...1265test # [ 7.710335] fuse: init (API version 7.45)1266test # [ 7.712811] systemd[1]: Listening on Journal Log Access Socket.1267second # [ 7.722878] systemd[1]: Populated /etc with preset unit settings.1268test # [ 7.717327] systemd[1]: Mounted Huge Pages File System.1269test # [ 7.721727] systemd[1]: Mounted POSIX Message Queue File System.1270test # [ 7.726311] systemd-journald[329]: Collecting audit messages is enabled.1271test # [ 7.730546] systemd[1]: Mounted Kernel Debug File System.1272test # [ 7.733566] systemd[1]: Mounted Kernel Trace File System.1273test # [ 7.737770] systemd[1]: Finished Create List of Static Device Nodes.1274test # [ 7.742680] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1275test # [ 7.737637] systemd[1]: Queued start job for default target Multi-User System.1276test # [ 7.747448] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1277test # [ 7.750747] systemd[1]: Started Journal Service.1278test # [ 7.745155] systemd[1]: systemd-journald.service: Deactivated successfully.1279test # [ 7.751267] systemd-modules-load[330]: Module 'atkbd' is built in1280test # [ 7.755682] systemd-modules-load[330]: Module 'ctr' is built in1281test # [ 7.762070] systemd-modules-load[330]: Module 'loop' is built in1282test # [ 7.762739] systemd[1]: Mounted Kernel Configuration File System.1283test # [ 7.763406] systemd[1]: modprobe@fuse.service: Deactivated successfully.1284test # [ 7.764718] systemd[1]: Finished Load Kernel Module fuse.1285test # [ 7.770800] systemd[1]: Mounting FUSE Control File System...1286test # [ 7.776187] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1287test # [ 7.778903] systemd[1]: Finished Load Kernel Modules.1288test # [ 7.810447] EXT4-fs (vda): re-mounted 9ddadaa9-be1e-4dc5-abd8-4186022334fe.1289test # [ 7.819598] systemd[1]: Starting Firewall...1290test # [ 7.822946] systemd[1]: Starting Apply Kernel Variables...1291test # [ 7.825773] systemd[1]: Finished Remount Root and Kernel File Systems.1292test # [ 7.830763] systemd-oomd[331]: No swap; memory pressure usage will be degraded1293test # [ 7.836822] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1294test # [ 7.851706] systemd[1]: Listening on Disk Image Download Service Socket.1295test # [ 7.865303] systemd[1]: Starting Flush Journal to Persistent Storage...1296test # [ 7.869454] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1297test # [ 7.876812] systemd[1]: Starting Load/Save OS Random Seed...1298test # [ 7.880990] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1299test # [ 7.931843] systemd[1]: Mounted FUSE Control File System.1300test # [ 7.945663] systemd[1]: Finished Apply Kernel Variables.1301test # [ 7.959920] systemd[1]: Starting Network Name Resolution...1302test # [ 7.968097] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1303test # [ 7.978870] systemd-journald[329]: Received client request to flush runtime journal.1304test # [ 8.040937] systemd[1]: Starting Create Static Device Nodes in /dev...1305test # [ 8.048888] systemd[1]: Finished Load/Save OS Random Seed.1306test # [ 8.049717] systemd[1]: Reached target First Boot Complete.1307test # [ 8.054009] systemd[1]: Finished Flush Journal to Persistent Storage.1308test # [ 8.112176] systemd[1]: Finished Create Static Device Nodes in /dev.1309test # [ 8.112803] systemd[1]: Reached target Preparation for Local File Systems.1310test # [ 8.116536] systemd[1]: Starting Rule-based Manager for Device Events and Files...1311test # [ 8.140846] systemd-resolved[357]: Positive Trust Anchors:1312test # [ 8.141520] systemd-resolved[357]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1313test # [ 8.143699] systemd-resolved[357]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161314test # [ 8.148721] 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 test1315test # [ 8.251065] systemd-udevd[368]: Using default interface naming scheme 'v261'.1316second # [ 8.290084] systemd[1]: initrd-switch-root.service: Deactivated successfully.1317second # [ 8.290945] systemd[1]: Stopped initrd-switch-root.service.1318second # [ 8.292876] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1319second # [ 8.295825] systemd[1]: Created slice Slice /system/getty.1320second # [ 8.297379] systemd[1]: Created slice User and Session Slice.1321second # [ 8.298690] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1322second # [ 8.300093] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1323second # [ 8.300785] systemd[1]: Expecting device /dev/hvc0...1324second # [ 8.301907] systemd[1]: Expecting device /dev/ttyAMA0...1325second # [ 8.302893] systemd[1]: Reached target Local Encrypted Volumes.1326second # [ 8.303978] systemd[1]: Stopped target initrd-fs.target.1327second # [ 8.305010] systemd[1]: Stopped target initrd-root-fs.target.1328second # [ 8.306139] systemd[1]: Stopped target initrd-switch-root.target.1329second # [ 8.307187] systemd[1]: Reached target Virtual Machines and Containers.1330second # [ 8.308789] systemd[1]: Reached target Path Units.1331second # [ 8.310221] systemd[1]: Reached target Remote File Systems.1332second # [ 8.311676] systemd[1]: Reached target Slice Units.1333second # [ 8.313068] systemd[1]: Reached target Swaps.1334second # [ 8.316733] systemd[1]: Listening on Query the User Interactively for a Password.1335second # [ 8.321019] systemd[1]: Listening on Process Core Dump Socket.1336second # [ 8.324613] systemd[1]: Listening on Credential Encryption/Decryption.1337second # [ 8.328228] systemd[1]: Listening on Factory Reset Management.1338second # [ 8.329218] systemd[1]: Listening on Hostname Service Socket.1339second # [ 8.333462] systemd[1]: Starting Journal Log Access Socket...1340second # [ 8.335557] systemd[1]: Listening on Journal Audit Socket.1341second # [ 8.339077] systemd[1]: Listening on Console Output Muting Service Socket.1342second # [ 8.340391] systemd[1]: Listening on Network Management Metrics Varlink Socket.1343second # [ 8.341661] systemd[1]: Listening on Network Management Varlink Socket.1344second # [ 8.342804] systemd[1]: Listening on Network Management Netlink Socket.1345second # [ 8.344718] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1346second # [ 8.346450] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1347second # [ 8.348243] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1348second # [ 8.358336] systemd[1]: Listening on Disk Repartitioning Service Socket.1349second # [ 8.359932] systemd[1]: Listening on Resolve Monitor Varlink Socket.1350second # [ 8.360965] systemd[1]: Listening on Resolve Service Varlink Socket.1351second # [ 8.362108] systemd[1]: Listening on udev Control Socket.1352second # [ 8.363612] systemd[1]: Listening on udev Varlink Socket.1353second # [ 8.366723] systemd[1]: Mounting Huge Pages File System...1354second # [ 8.369912] systemd[1]: Mounting POSIX Message Queue File System...1355second # [ 8.373750] systemd[1]: Mounting Kernel Debug File System...1356second # [ 8.382289] systemd[1]: Mounting Kernel Trace File System...1357second # [ 8.390610] systemd[1]: Starting Create List of Static Device Nodes...1358second # [ 8.400884] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1359second # [ 8.401937] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1360test # [ 8.398121] systemd-resolved[357]: Using system hostname 'test'.1361second # [ 8.411705] systemd[1]: Mounting Kernel Configuration File System...1362second # [ 8.415113] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1363second # [ 8.418277] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1364test # [ 8.411599] systemd[1]: Mounting /run/wrappers...1365test # [ 8.413705] systemd[1]: Started Network Name Resolution.1366second # [ 8.431929] systemd[1]: Starting Load Kernel Module fuse...1367second # [ 8.432961] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671368second # [ 8.482867] systemd[1]: Starting Journal Service...1369test # [ 8.473508] systemd[1]: Mounted /run/wrappers.1370test # [ 8.474102] systemd[1]: Reached target Local File Systems.1371test # [ 8.478976] systemd[1]: Listening on Boot Loader Control Service Socket.1372test # [ 8.487695] systemd[1]: Starting register-nix-paths.service...1373test # [ 8.492391] systemd[1]: Starting Create SUID/SGID Wrappers...1374test # [ 8.493519] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1375second # [ 8.515386] systemd[1]: Starting Load Kernel Modules...1376test # [ 8.506850] systemd[1]: Starting Save Transient machine-id to Disk...1377second # [ 8.536104] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1378second # [ 8.549441] fuse: init (API version 7.45)1379test # [ 8.541744] systemd[1]: Starting Create System Files and Directories...1380second # [ 8.561188] systemd[1]: Starting Remount Root and Kernel File Systems...1381second # [ 8.563099] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1382test # [ 8.547825] systemd[1]: Started Rule-based Manager for Device Events and Files.1383second # [ 8.583060] systemd[1]: Starting Coldplug All udev Devices...1384second # [ 8.601798] systemd[1]: Listening on Journal Log Access Socket.1385second # [ 8.603634] systemd[1]: Mounted Huge Pages File System.1386second # [ 8.606085] systemd[1]: Mounted POSIX Message Queue File System.1387second # [ 8.607909] systemd[1]: Mounted Kernel Debug File System.1388second # [ 8.610897] systemd[1]: Mounted Kernel Trace File System.1389second # [ 8.614354] systemd[1]: Finished Create List of Static Device Nodes.1390second # [ 8.620101] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1391second # [ 8.625669] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1392second # [ 8.626225] systemd[1]: Mounted Kernel Configuration File System.1393second # [ 8.626694] systemd[1]: modprobe@fuse.service: Deactivated successfully.1394second # [ 8.631932] systemd[1]: Finished Load Kernel Module fuse.1395second # [ 8.635111] systemd-journald[306]: Collecting audit messages is enabled.1396second # [ 8.639845] systemd[1]: Finished Load Kernel Modules.1397second # [ 8.645223] systemd[1]: Mounting FUSE Control File System...1398second # [ 8.645437] systemd[1]: Queued start job for default target Multi-User System.1399second # [ 8.648978] systemd[1]: systemd-journald.service: Deactivated successfully.1400test # [ 8.643679] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1401second # [ 8.652347] systemd-modules-load[307]: Module 'atkbd' is built in1402second # [ 8.661593] systemd[1]: Starting Firewall...1403second # [ 8.658561] systemd-modules-load[307]: Module 'ctr' is built in1404test # [ 8.660231] systemd[1]: Finished Save Transient machine-id to Disk.1405second # [ 8.663532] systemd-modules-load[307]: Module 'loop' is built in1406second # [ 8.677840] systemd[1]: Starting Apply Kernel Variables...1407second # [ 8.681723] EXT4-fs (vda): re-mounted 304d3212-49a0-4e3a-99fb-56cb7ddbe930.1408second # [ 8.701633] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1409second # [ 8.714192] systemd[1]: Started Journal Service.1410second # [ 8.711486] systemd[1]: Finished Remount Root and Kernel File Systems.1411test # [ 8.721939] systemd[1]: Finished Create System Files and Directories.1412second # [ 8.734989] systemd-oomd[308]: No swap; memory pressure usage will be degraded1413test # [ 8.729987] systemd[1]: Starting Rebuild Journal Catalog...1414test # [ 8.732875] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1415second # [ 8.755699] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1416second # [ 8.777294] systemd[1]: Listening on Disk Image Download Service Socket.1417second # [ 8.782320] systemd[1]: Starting Flush Journal to Persistent Storage...1418second # [ 8.783497] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1419second # [ 8.791006] systemd[1]: Starting Load/Save OS Random Seed...1420second # [ 8.794087] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1421second # [ 8.815423] systemd[1]: Finished Apply Kernel Variables.1422second # [ 8.840570] systemd-journald[306]: Received client request to flush runtime journal.1423test # [ 8.842370] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1424test # [ 8.898800] systemd[1]: Finished Coldplug All udev Devices.1425second # [ 8.908290] systemd[1]: Mounted FUSE Control File System.1426second # [ 8.914941] systemd[1]: Starting Network Name Resolution...1427second # [ 8.919081] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1428second # [ 8.927719] systemd[1]: Starting Create Static Device Nodes in /dev...1429second # [ 8.931001] systemd[1]: Finished Load/Save OS Random Seed.1430second # [ 8.931517] systemd[1]: Reached target First Boot Complete.1431test # [ 8.926781] systemd[1]: Finished Rebuild Journal Catalog.1432second # [ 8.936371] systemd[1]: Finished Flush Journal to Persistent Storage.1433test # [ 8.935134] systemd[1]: Starting Update is Completed...1434test # [ 9.000401] systemd[1]: Finished Update is Completed.1435second # [ 9.009281] systemd-resolved[335]: Positive Trust Anchors:1436second # [ 9.009877] systemd-resolved[335]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1437second # [ 9.010872] systemd-resolved[335]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161438second # [ 9.016226] systemd-resolved[335]: 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 test1439second # [ 9.048797] systemd[1]: Finished Create Static Device Nodes in /dev.1440second # [ 9.049738] systemd[1]: Reached target Preparation for Local File Systems.1441second # [ 9.051304] systemd[1]: Starting Rule-based Manager for Device Events and Files...1442test # [ 9.097162] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1443second # [ 9.130412] systemd-udevd[349]: Using default interface naming scheme 'v261'.1444second # [ 9.268058] systemd-resolved[335]: Using system hostname 'second'.1445second # [ 9.281834] systemd[1]: Started Network Name Resolution.1446second # [ 9.291439] systemd[1]: Mounting /run/wrappers...1447second # [ 9.352240] systemd[1]: Mounted /run/wrappers.1448second # [ 9.356542] systemd[1]: Reached target Local File Systems.1449test # [ 9.349627] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1450second # [ 9.360090] systemd[1]: Listening on Boot Loader Control Service Socket.1451test # [ 9.352755] systemd[1]: Finished Create SUID/SGID Wrappers.1452second # [ 9.362469] systemd[1]: Starting register-nix-paths.service...1453second # [ 9.368126] systemd[1]: Starting Create SUID/SGID Wrappers...1454second # [ 9.369203] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1455second # [ 9.375280] systemd[1]: Starting Save Transient machine-id to Disk...1456test # [ 9.372887] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1457second # [ 9.409423] systemd[1]: Starting Create System Files and Directories...1458second # [ 9.423958] systemd[1]: Started Rule-based Manager for Device Events and Files.1459test # [ 9.418596] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1460second # [ 9.477855] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1461second # [ 9.489417] systemd[1]: Finished Save Transient machine-id to Disk.1462second # [ 9.600178] systemd[1]: Finished Create System Files and Directories.1463second # [ 9.616265] systemd[1]: Starting Rebuild Journal Catalog...1464second # [ 9.633901] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1465test # [ 9.688597] systemd[1]: Finished Firewall.1466test # [ 9.691136] systemd[1]: Reached target Preparation for Network.1467test # [ 9.693269] systemd[1]: Listening on Network Management Resolve Hook Socket.1468test # [ 9.696791] systemd[1]: Starting Network Management...1469second # [ 9.706257] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1470test # [ 9.699277] systemd[1]: Finished register-nix-paths.service.1471test # [ 9.701166] systemd[1]: Reached target System Initialization.1472test # [ 9.702851] systemd[1]: Started Discard unused filesystem blocks once a week.1473test # [ 9.708585] systemd[1]: Started Daily Cleanup of Temporary Directories.1474test # [ 9.709225] systemd[1]: Reached target Timer Units.1475test # [ 9.709722] systemd[1]: Listening on D-Bus System Message Bus Socket.1476test # [ 9.713583] systemd[1]: Listening on Nix Daemon Socket.1477test # [ 9.722645] systemd[1]: Listening on Authorization Manager Agent Helper.1478test # [ 9.723817] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1479test # [ 9.725949] systemd[1]: Reached target Socket Units.1480test # [ 9.727370] (udev-worker)[476]: Network interface NamePolicy= disabled on kernel command line.1481test # [ 9.734087] systemd[1]: Starting D-Bus System Message Bus...1482second # [ 9.745889] systemd[1]: Finished Coldplug All udev Devices.1483test # [ 9.738151] (udev-worker)[474]: Network interface NamePolicy= disabled on kernel command line.1484second # [ 9.781810] systemd[1]: Finished Rebuild Journal Catalog.1485second # [ 9.787436] systemd[1]: Starting Update is Completed...1486second # [ 9.843598] systemd[1]: Finished Update is Completed.1487test # [ 9.915246] mousedev: PS/2 mouse device common for all mice1488test # [ 9.930162] cfg80211: Loading compiled-in X.509 certificates for regulatory database1489second # [ 9.927222] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1490test # [ 9.936659] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...1491test # [ 9.950720] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'1492test # [ 9.952380] dbus-broker-launch[555]: Invalid user-name in /nix/store/a6d815a4vnb1kkzrrqphjwsdand11m9r-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1493test # [ 9.971690] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1494test # [ 9.972209] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1495test # [ 10.006232] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1496test # [ 10.009462] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1497test # [ 10.014515] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/9prxmvwvdr9mfqbb38w7jq4kicc7zi18-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1498test # [ 10.024978] dbus-broker-launch[555]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/5cpm90flydbxw9km2kl7pk8i1i5sc3nk-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1499test # [ 10.032698] systemd[1]: Started D-Bus System Message Bus.1500test # [ 10.037515] systemd[1]: Reached target Basic System.1501test # [ 10.038610] systemd[1]: Starting Network Manager Script Dispatcher Service...1502test # [ 10.043327] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1503test # [ 10.047431] systemd-networkd[551]: /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.1504test # [ 10.056858] systemd-networkd[551]: /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.1505test # [ 10.073425] systemd-networkd[551]: lo: Link UP1506test # [ 10.073894] systemd-networkd[551]: lo: Gained carrier1507test # [ 10.074371] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1508test # [ 10.074983] systemd-networkd[551]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1509test # [ 10.080199] systemd-networkd[551]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1510test # [ 10.086280] systemd-networkd[551]: eth1: Link UP1511test # [ 10.089652] systemd-networkd[551]: eth1: Gained carrier1512test # [ 10.094985] systemd-networkd[551]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1513test # [ 10.108571] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1514test # [ 10.122378] dbus-broker-launch[555]: Ready1515test # [ 10.126232] systemd[1]: Starting Network Manager...1516test # [ 10.141039] systemd[1]: Started backdoor.service.1517test # [ 10.164507] r3qn2wrxq8bfm2mry46agf2zjadxngay-wifi-secrets[565]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1518test # [ 10.173376] systemd[1]: Starting Import lastlog data into lastlog2 database...1519second # [ 10.191350] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1520test # [ 10.198610] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[564]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1521test # [ 10.202986] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1522second # [ 10.234468] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1523second # [ 10.236778] systemd[1]: Finished Create SUID/SGID Wrappers.1524test # [ 10.227989] kmrn99zb7hfffrbx2s86i3g3dg0y4036-wifi-secrets[566]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1525test # [ 10.236287] systemd[1]: Starting Post-Boot Actions...1526second # [ 10.262057] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1527test # [ 10.268541] systemd[1]: Started Reset console on configuration changes.1528test # [ 10.269704] systemd[1]: Started Network Management.1529test # [ 10.276597] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1530test # [ 10.283064] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1531test # [ 10.293100] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1532test # [ 10.299245] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1533test # [ 10.306341] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1534test # [ 10.320299] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1535test # [ 10.374718] systemd[1]: Finished Post-Boot Actions.1536test # connecting to host...1537test # [ 10.406893] nsncd[574]: Sep 06 10:02:20.235 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1538test # [ 10.411447] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1539test # [ 10.415953] systemd[1]: Started Name Service Cache Daemon (nsncd).1540test # [ 10.421361] systemd[1]: Reached target Host and Network Name Lookups.1541test # [ 10.421928] systemd[1]: Reached target User and Group Name Lookups.1542test # [ 10.441763] systemd[1]: Starting User Login Management...1543test: Guest shell says: b'Spawning backdoor root shell...\n'1544test # [ 10.461824] systemd[1]: Finished Import lastlog data into lastlog2 database.1545test # [ 10.490168] systemd[1]: Started Network Manager Script Dispatcher Service.1546test: connected to guest root shell1547second # [ 10.503649] systemd[1]: Finished Firewall.1548second # [ 10.504249] systemd[1]: Reached target Preparation for Network.1549test: (connecting took 10.74 seconds)1550test: (finished: waiting for the VM to finish booting, in 10.74 seconds)1551second # [ 10.505621] systemd[1]: Listening on Network Management Resolve Hook Socket.1552second # [ 10.508469] systemd[1]: Starting Network Management...1553second # [ 10.550706] (udev-worker)[446]: Network interface NamePolicy= disabled on kernel command line.1554second # [ 10.562235] (udev-worker)[447]: Network interface NamePolicy= disabled on kernel command line.1555test # [ 10.556096] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1556second # [ 10.596091] systemd[1]: Finished register-nix-paths.service.1557second # [ 10.597626] systemd[1]: Reached target System Initialization.1558second # [ 10.599754] systemd[1]: Started Discard unused filesystem blocks once a week.1559second # [ 10.602544] systemd[1]: Started Daily Cleanup of Temporary Directories.1560second # [ 10.606442] systemd[1]: Reached target Timer Units.1561second # [ 10.607395] systemd[1]: Listening on D-Bus System Message Bus Socket.1562second # [ 10.609314] systemd[1]: Listening on Nix Daemon Socket.1563test # [ 10.603013] systemd[1]: Starting Hostname Service...1564second # [ 10.612444] systemd[1]: Listening on Authorization Manager Agent Helper.1565second # [ 10.615669] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1566second # [ 10.618171] systemd[1]: Reached target Socket Units.1567second # [ 10.621945] systemd[1]: Starting D-Bus System Message Bus...1568test # [ 10.627971] systemd-logind[608]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1569test # [ 10.633333] systemd-logind[608]: Watching system buttons on /dev/input/event0 (gpio-keys)1570test # [ 10.635606] systemd-logind[608]: New seat seat0.1571test # [ 10.652602] systemd[1]: Started User Login Management.1572test # [ 10.664240] systemd[1]: Starting linger-users.service...1573second # [ 10.741212] cfg80211: Loading compiled-in X.509 certificates for regulatory database1574test # [ 10.730780] systemd[1]: linger-users.service: Deactivated successfully.1575test # [ 10.732649] systemd[1]: Finished linger-users.service.1576second # [ 10.745047] mousedev: PS/2 mouse device common for all mice1577test # [ 10.743054] systemd[1]: Started Hostname Service.1578second # [ 10.780642] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1579second # [ 10.781172] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1580second # [ 10.809565] dbus-broker-launch[532]: Looking up NSS user entry for 'systemd-timesync'...1581second # [ 10.820338] dbus-broker-launch[532]: NSS returned no entry for 'systemd-timesync'1582second # [ 10.821705] dbus-broker-launch[532]: Invalid user-name in /nix/store/a6d815a4vnb1kkzrrqphjwsdand11m9r-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1583second # [ 10.838047] systemd-networkd[527]: /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.1584test # [ 10.831411] systemd-networkd[551]: eth0: Link UP1585test # [ 10.831879] systemd-networkd[551]: eth0: Gained carrier1586second # [ 10.843199] systemd-networkd[527]: /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.1587second # [ 10.848442] systemd-networkd[527]: lo: Link UP1588second # [ 10.849104] systemd-networkd[527]: lo: Gained carrier1589second # [ 10.855603] systemd[1]: Started Network Management.1590test # [ 10.853015] systemd[1]: Started Network Manager.1591test # [ 10.854744] systemd[1]: Reached target Network.1592second # [ 10.859594] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1593second # [ 10.868088] systemd-networkd[527]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1594test # [ 10.861416] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1595second # [ 10.873024] systemd-networkd[527]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1596test # [ 10.866752] systemd[1]: Starting Permit User Sessions...1597second # [ 10.877101] systemd-networkd[527]: eth1: Link UP1598second # [ 10.878966] systemd-networkd[527]: eth1: Gained carrier1599second # [ 10.882329] systemd-networkd[527]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1600second # [ 10.897233] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1601second # [ 10.902051] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1602second # [ 10.910717] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/9prxmvwvdr9mfqbb38w7jq4kicc7zi18-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1603second # [ 10.922249] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/5cpm90flydbxw9km2kl7pk8i1i5sc3nk-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1604second # [ 10.928819] systemd[1]: Started D-Bus System Message Bus.1605second # [ 10.933320] systemd[1]: Reached target Basic System.1606second # [ 10.934006] systemd[1]: Starting Network Manager Script Dispatcher Service...1607second # [ 10.937153] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1608second # [ 10.944911] systemd[1]: Starting Network Manager...1609second # [ 10.964989] systemd[1]: Started backdoor.service.1610second # [ 10.988711] systemd[1]: Starting Import lastlog data into lastlog2 database...1611second # [ 10.996196] dbus-broker-launch[532]: Ready1612second # [ 11.017501] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1613test # [ 11.016251] systemd[1]: Finished Permit User Sessions.1614second # [ 11.024772] systemd[1]: Starting Post-Boot Actions...1615test # [ 11.033213] systemd[1]: Started Getty on tty1.1616test # [ 11.037819] systemd[1]: Reached target Login Prompts.1617second # [ 11.068329] systemd[1]: Started Reset console on configuration changes.1618test # [ 11.064251] NetworkManager[567]: <warn> [1788688940.8920] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1619test # [ 11.065958] NetworkManager[567]: <warn> [1788688940.8938] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1620second # [ 11.077586] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[542]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1621second # [ 11.093143] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1622test # [ 11.085839] systemd-resolved[357]: eth0: Bus client set default route setting: yes1623test # [ 11.090313] systemd-resolved[357]: eth0: Bus client set DNS server list to: 10.0.2.31624second # [ 11.118184] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1625second # [ 11.124200] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1626second # connecting to host...1627test # [ 11.144676] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1628test # [ 11.147097] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1629test # [ 11.158942] systemd[1]: Reached target Multi-User System.1630test # [ 11.162243] systemd[1]: Startup finished in 740ms (kernel) + 4.579s (initrd) + 5.840s (userspace) = 11.160s.1631second # [ 11.189126] systemd[1]: Finished Post-Boot Actions.1632second # [ 11.243842] systemd[1]: Started Name Service Cache Daemon (nsncd).1633second # [ 11.248683] nsncd[547]: Sep 06 10:02:21.074 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1634second # [ 11.249982] systemd[1]: Reached target Host and Network Name Lookups.1635second # [ 11.250551] systemd[1]: Reached target User and Group Name Lookups.1636second # [ 11.255597] systemd[1]: Starting User Login Management...1637second # [ 11.263536] systemd[1]: Finished Import lastlog data into lastlog2 database.1638second # [ 11.326908] systemd[1]: Started Network Manager Script Dispatcher Service.1639second # [ 11.401176] systemd-logind[575]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1640second # [ 11.404427] systemd-logind[575]: Watching system buttons on /dev/input/event0 (gpio-keys)1641second # [ 11.406777] systemd-logind[575]: New seat seat0.1642second # [ 11.410447] systemd[1]: Starting Hostname Service...1643second # [ 11.410953] systemd[1]: Started User Login Management.1644second # [ 11.419348] systemd[1]: Starting linger-users.service...1645second # [ 11.492397] systemd[1]: linger-users.service: Deactivated successfully.1646second # [ 11.493498] systemd[1]: Finished linger-users.service.1647test # [ 11.490463] systemd-networkd[551]: eth1: Gained IPv6LL1648second # [ 11.542490] systemd[1]: Started Hostname Service.1649test # [ 11.594354] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31650second # [ 11.635517] systemd-networkd[527]: eth0: Link UP1651second # [ 11.636137] systemd-networkd[527]: eth0: Gained carrier1652second # [ 11.655289] systemd[1]: Started Network Manager.1653second # [ 11.657682] systemd[1]: Reached target Network.1654second # [ 11.663067] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1655second # [ 11.669511] systemd[1]: Starting Permit User Sessions...1656test: (finished: waiting for unit NetworkManager.service, in 11.98 seconds)1657test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1658test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1659cleanup1660kill QemuMachine (pid 47)1661second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1662test # [ 11.849873] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1663test # [ 11.871230] systemd[1]: Starting Virtual Console Setup...1664test # [ 11.890797] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1665test # [ 11.891472] systemd[1]: Stopped Virtual Console Setup.1666test # [ 11.899244] systemd[1]: Starting Virtual Console Setup...1667test # [ 11.921684] systemd-logind[608]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1668kill QemuMachine (pid 48)1669test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1670(finished: cleanup, in 0.30 seconds)1671Traceback (most recent call last):1672 File "/nix/store/5dhilq5mc2vy035sl6jrm9pj22s00qf5-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1673 sys.exit(main())1674 ~~~~^^1675 File "/nix/store/5dhilq5mc2vy035sl6jrm9pj22s00qf5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main1676 driver.run_tests()1677 ~~~~~~~~~~~~~~~~^^1678 File "/nix/store/5dhilq5mc2vy035sl6jrm9pj22s00qf5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 437, in run_tests1679 self.test_script()1680 ~~~~~~~~~~~~~~~~^^1681 File "/nix/store/5dhilq5mc2vy035sl6jrm9pj22s00qf5-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 395, in test_script1682 exec(self.tests, symbols, None)1683 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^1684 File "<string>", line 4, in <module>1685AssertionError: Expected mock password in connection file:1686[connection]1687autoconnect=true1688id=1689type=wifi16901691[wifi]1692mode=infrastructure1693ssid=16941695[wifi-security]1696key-mgmt=wpa-psk1697psk=1698