vm-test-run-wifi
checks.aarch64-linux.wifi
· build #102
· 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)14second # Disk image does not exist, creating the virtualisation disk image...15second: QEMU running (pid 47)16second # Formatting '/build/vm-state-second/tmp.uOi7mncbFk', fmt=raw size=107374182417test # Disk image does not exist, creating the virtualisation disk image...18second # mke2fs 1.47.4 (6-Mar-2025)19test # Formatting '/build/vm-state-test/tmp.Sjo3ml35aO', fmt=raw size=107374182420second # Discarding device blocks: 0/262144 done21test # mke2fs 1.47.4 (6-Mar-2025)22second # Creating filesystem with 262144 4k blocks and 65536 inodes23test # Discarding device blocks: 0/262144 done24(finished: start all VMs, in 0.53 seconds)25test # Creating filesystem with 262144 4k blocks and 65536 inodes26test: waiting for unit NetworkManager.service27test # Filesystem UUID: d28bfbaf-1919-4372-afdb-7c3e589f7f9a28test: waiting for the VM to finish booting29test # Superblock backups stored on blocks:30second # Filesystem UUID: f28f032b-969b-4c90-9ca9-4b7ec8513ba531second # Superblock backups stored on blocks:32second # 32768, 98304, 163840, 22937633test # 32768, 98304, 163840, 22937634second # 35test # 36second # Allocating group tables: 0/8 done37test # Allocating group tables: 0/8 done38second # Writing inode tables: 0/8 done39test # Writing inode tables: 0/8 done40second # Creating journal (8192 blocks): done41test # Creating journal (8192 blocks): done42second # Writing superblocks and filesystem accounting information: 0/8 done43test # Writing superblocks and filesystem accounting information: 0/8 done44second # 45test # 46second # Virtualisation disk image created.47test # Virtualisation disk image created.48second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49second # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 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]59test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]60second # [ 0.000000] DMA32 empty61second # [ 0.000000] Normal empty62second # [ 0.000000] Device empty63second # [ 0.000000] Movable zone start for each node64test # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 UTC 202665test # [ 0.000000] KASLR enabled66second # [ 0.000000] Early memory node ranges67test # [ 0.000000] random: crng init done68second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]69test # [ 0.000000] Machine model: linux,dummy-virt70test # [ 0.000000] efi: UEFI not found.71second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]72test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT73second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000074second # [ 0.000000] psci: probing for conduit method from DT.75test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]76second # [ 0.000000] psci: PSCIv1.3 detected in firmware.77test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]78second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs79test # [ 0.000000] Zone ranges:80second # [ 0.000000] psci: Trusted OS migration not required81test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]82test # [ 0.000000] DMA32 empty83second # [ 0.000000] psci: SMC Calling Convention v1.184test # [ 0.000000] Normal empty85test # [ 0.000000] Device empty86second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)87test # [ 0.000000] Movable zone start for each node88test # [ 0.000000] Early memory node ranges89second # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129690test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]91second # [ 0.000000] Detected PIPT I-cache on CPU092second # [ 0.000000] CPU features: detected: GICv3 CPU interface93test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]94second # [ 0.000000] CPU features: detected: Spectre-v495test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000096second # [ 0.000000] CPU features: detected: Spectre-BHB97test # [ 0.000000] psci: probing for conduit method from DT.98second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR99test # [ 0.000000] psci: PSCIv1.3 detected in firmware.100test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs101second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)102test # [ 0.000000] psci: Trusted OS migration not required103second # [ 0.000000] CPU features: detected: ARM erratum 1418040104test # [ 0.000000] psci: SMC Calling Convention v1.1105second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion106test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)107second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing108second # [ 0.000000] alternatives: applying boot alternatives109test # [ 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 interface112test # [ 0.000000] CPU features: detected: Spectre-v4113test # [ 0.000000] CPU features: detected: Spectre-BHB114test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR115test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)116second # [ 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/ahsy382b3qyyw8pa1ik3hbjk32l5964i-nixos-system-second-test/init regInfo=/nix/store/ghv4hrls3306p8l1cyh0lv18dwr3mbnv-closure-info/registration console=ttyAMA0,115200n8 console=tty0117test # [ 0.000000] CPU features: detected: ARM erratum 1418040118test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion119second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ghv4hrls3306p8l1cyh0lv18dwr3mbnv-closure-info/registration", will be passed to user space.120test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing121second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes122test # [ 0.000000] alternatives: applying boot alternatives123second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)124second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)125second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB126second # [ 0.000000] software IO TLB: area num 1.127test # [ 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/h4r9invcd6mfpbq3xqqn4m88rz5nj3mn-nixos-system-test-test/init regInfo=/nix/store/1bn2ndwbv52kw4jn3h44yrgl2mbxjanh-closure-info/registration console=ttyAMA0,115200n8 console=tty0128second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)129second # [ 0.000000] Fallback order for Node 0: 0130second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144131test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/1bn2ndwbv52kw4jn3h44yrgl2mbxjanh-closure-info/registration", will be passed to user space.132second # [ 0.000000] Policy zone: DMA133test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes134second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off135second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1136test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)137second # [ 0.000000] allocated 2097152 bytes of page_ext138test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)139second # [ 0.000000] ftrace: allocating 74886 entries in 294 pages140test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB141second # [ 0.000000] ftrace: allocated 294 pages with 4 groups142test # [ 0.000000] software IO TLB: area num 1.143second # [ 0.000000] rcu: Hierarchical RCU implementation.144second # [ 0.000000] rcu: RCU event tracing is enabled.145test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)146test # [ 0.000000] Fallback order for Node 0: 0147second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.148test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144149second # [ 0.000000] Trampoline variant of Tasks RCU enabled.150test # [ 0.000000] Policy zone: DMA151second # [ 0.000000] Rude variant of Tasks RCU enabled.152second # [ 0.000000] Tracing variant of Tasks RCU enabled.153test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off154test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1155second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.156test # [ 0.000000] allocated 2097152 bytes of page_ext157second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1158test # [ 0.000000] ftrace: allocating 74886 entries in 294 pages159test # [ 0.000000] ftrace: allocated 294 pages with 4 groups160second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.161test # [ 0.000000] rcu: Hierarchical RCU implementation.162test # [ 0.000000] rcu: RCU event tracing is enabled.163second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.164test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.165second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.166test # [ 0.000000] Trampoline variant of Tasks RCU enabled.167second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0168test # [ 0.000000] Rude variant of Tasks RCU enabled.169second # [ 0.000000] GICv3: 256 SPIs implemented170test # [ 0.000000] Tracing variant of Tasks RCU enabled.171second # [ 0.000000] GICv3: 0 Extended SPIs implemented172second # [ 0.000000] Root IRQ handler: gic_handle_irq173test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.174second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI175test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1176second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0177test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.178second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000179second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]180test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.181second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)182test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.183test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0184second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)185test # [ 0.000000] GICv3: 256 SPIs implemented186second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000187test # [ 0.000000] GICv3: 0 Extended SPIs implemented188test # [ 0.000000] Root IRQ handler: gic_handle_irq189second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000190test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI191test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0192second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.193test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000194second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns195test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]196second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040197test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)198second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).199test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)200second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns201test # [ 0.000000] GICv3: using LPI property table @0x0000000044d20000202second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns203test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d30000204second # [ 0.000049] arm-pv: using stolen time PV205test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.206second # [ 0.000328] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)207second # [ 0.000577] Console: colour dummy device 80x25208test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns209second # [ 0.000587] printk: legacy console [tty0] enabled210test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040211test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).212second # [ 0.000811] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)213second # [ 0.000817] pid_max: default: 32768 minimum: 301214test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns215second # [ 0.000898] LSM: initializing lsm=capability,landlock,yama,bpf,ima216second # [ 0.001011] landlock: Up and running.217test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns218second # [ 0.001013] Yama: becoming mindful.219test # [ 0.000051] arm-pv: using stolen time PV220second # [ 0.001327] LSM support for eBPF active221second # [ 0.001493] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)222test # [ 0.000340] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)223test # [ 0.000571] Console: colour dummy device 80x25224second # [ 0.001513] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)225test # [ 0.000582] printk: legacy console [tty0] enabled226second # [ 0.003291] cacheinfo: Unable to detect cache hierarchy for CPU 0227second # [ 0.004115] rcu: Hierarchical SRCU implementation.228test # [ 0.000802] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)229second # [ 0.004121] rcu: Max phase no-delay instances is 1000.230test # [ 0.000808] pid_max: default: 32768 minimum: 301231second # [ 0.005074] fsl-mc MSI: its@8080000 domain created232test # [ 0.000888] LSM: initializing lsm=capability,landlock,yama,bpf,ima233second # [ 0.005226] EFI services will not be available.234test # [ 0.000997] landlock: Up and running.235second # [ 0.005347] smp: Bringing up secondary CPUs ...236test # [ 0.000999] Yama: becoming mindful.237second # [ 0.005385] smp: Brought up 1 node, 1 CPU238test # [ 0.001326] LSM support for eBPF active239second # [ 0.005388] SMP: Total of 1 processors activated.240test # [ 0.001490] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)241second # [ 0.005389] CPU: All CPU(s) started at EL1242second # [ 0.005400] CPU features: detected: 32-bit EL0 Support243test # [ 0.001509] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)244test # [ 0.003273] cacheinfo: Unable to detect cache hierarchy for CPU 0245second # [ 0.005402] CPU features: detected: Data cache clean to the PoU not required for I/D coherence246test # [ 0.004109] rcu: Hierarchical SRCU implementation.247second # [ 0.005405] CPU features: detected: Common not Private translations248test # [ 0.004114] rcu: Max phase no-delay instances is 1000.249second # [ 0.005407] CPU features: detected: CRC32 instructions250test # [ 0.005047] fsl-mc MSI: its@8080000 domain created251second # [ 0.005409] CPU features: detected: Data cache clean to Point of Persistence252test # [ 0.005219] EFI services will not be available.253test # [ 0.005311] smp: Bringing up secondary CPUs ...254second # [ 0.005411] CPU features: detected: Enhanced Virtualization Traps255test # [ 0.005348] smp: Brought up 1 node, 1 CPU256second # [ 0.005421] CPU features: detected: RCpc load-acquire (LDAPR)257test # [ 0.005351] SMP: Total of 1 processors activated.258second # [ 0.005423] CPU features: detected: LSE atomic instructions259test # [ 0.005352] CPU: All CPU(s) started at EL1260test # [ 0.005364] CPU features: detected: 32-bit EL0 Support261second # [ 0.005425] CPU features: detected: Privileged Access Never262test # [ 0.005366] CPU features: detected: Data cache clean to the PoU not required for I/D coherence263second # [ 0.005427] CPU features: detected: PMUv3264test # [ 0.005369] CPU features: detected: Common not Private translations265second # [ 0.005429] CPU features: detected: RAS Extension Support266test # [ 0.005371] CPU features: detected: CRC32 instructions267second # [ 0.005432] CPU features: detected: Speculative Store Bypassing Safe (SSBS)268test # [ 0.005373] CPU features: detected: Data cache clean to Point of Persistence269second # [ 0.005457] alternatives: applying system-wide alternatives270test # [ 0.005376] CPU features: detected: Enhanced Virtualization Traps271second # [ 0.006820] CPU features: detected: Hardware dirty bit management on CPU0272test # [ 0.005387] CPU features: detected: RCpc load-acquire (LDAPR)273test # [ 0.005389] CPU features: detected: LSE atomic instructions274test # [ 0.005391] CPU features: detected: Privileged Access Never275second # [ 0.007002] Memory: 891476K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115784K reserved, 32768K cma-reserved)276test # [ 0.005393] CPU features: detected: PMUv3277second # [ 0.007452] devtmpfs: initialized278test # [ 0.005395] CPU features: detected: RAS Extension Support279second # [ 0.008975] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)280test # [ 0.005399] CPU features: detected: Speculative Store Bypassing Safe (SSBS)281second # [ 0.008996] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).282test # [ 0.005424] alternatives: applying system-wide alternatives283second # [ 0.009121] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL284test # [ 0.006801] CPU features: detected: Hardware dirty bit management on CPU0285second # [ 0.009125] 0 pages in range for non-PLT usage286second # [ 0.009126] 508288 pages in range for PLT usage287second # [ 0.009251] pinctrl core: initialized pinctrl subsystem288test # [ 0.007032] Memory: 891460K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115784K reserved, 32768K cma-reserved)289second # [ 0.010033] DMI not present or invalid.290test # [ 0.007455] devtmpfs: initialized291second # [ 0.013273] NET: Registered PF_NETLINK/PF_ROUTE protocol family292test # [ 0.009268] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)293second # [ 0.015871] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations294test # [ 0.009296] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).295second # [ 0.016003] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations296test # [ 0.009435] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL297test # [ 0.009439] 0 pages in range for non-PLT usage298second # [ 0.016179] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations299test # [ 0.009440] 508288 pages in range for PLT usage300second # [ 0.016197] audit: initializing netlink subsys (disabled)301test # [ 0.009575] pinctrl core: initialized pinctrl subsystem302second # [ 0.016767] thermal_sys: Registered thermal governor 'fair_share'303test # [ 0.010348] DMI not present or invalid.304second # [ 0.016769] thermal_sys: Registered thermal governor 'bang_bang'305test # [ 0.013567] NET: Registered PF_NETLINK/PF_ROUTE protocol family306second # [ 0.016772] thermal_sys: Registered thermal governor 'step_wise'307test # [ 0.015952] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations308second # [ 0.016774] thermal_sys: Registered thermal governor 'user_space'309test # [ 0.016107] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations310second # [ 0.016776] thermal_sys: Registered thermal governor 'power_allocator'311test # [ 0.016264] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations312second # [ 0.016804] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1313test # [ 0.016284] audit: initializing netlink subsys (disabled)314second # [ 0.016818] cpuidle: using governor ladder315second # [ 0.016823] cpuidle: using governor menu316second # [ 0.016948] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.317test # [ 0.016904] thermal_sys: Registered thermal governor 'fair_share'318second # [ 0.016969] ASID allocator initialised with 32768 entries319test # [ 0.016906] thermal_sys: Registered thermal governor 'bang_bang'320second # [ 0.017635] Serial: AMBA PL011 UART driver321test # [ 0.016909] thermal_sys: Registered thermal governor 'step_wise'322second # [ 0.020745] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1323test # [ 0.016911] thermal_sys: Registered thermal governor 'user_space'324second # [ 0.020911] printk: console [ttyAMA0] enabled325test # [ 0.016913] thermal_sys: Registered thermal governor 'power_allocator'326test # [ 0.016937] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1327test # [ 0.016951] cpuidle: using governor ladder328test # [ 0.016956] cpuidle: using governor menu329test # [ 0.017094] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.330test # [ 0.017115] ASID allocator initialised with 32768 entries331test # [ 0.017790] Serial: AMBA PL011 UART driver332test # [ 0.021160] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1333test # [ 0.021307] printk: console [ttyAMA0] enabled334second # [ 0.093940] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages335second # [ 0.093955] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page336second # [ 0.093961] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages337second # [ 0.093964] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page338second # [ 0.093968] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages339second # [ 0.093971] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page340second # [ 0.093974] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages341second # [ 0.093977] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page342test # [ 0.094221] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages343test # [ 0.094236] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page344test # [ 0.094242] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages345second # [ 0.098997] fbcon: Taking over console346second # [ 0.099014] ACPI: Interpreter disabled.347test # [ 0.094245] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page348second # [ 0.100226] iommu: Default domain type: Translated349test # [ 0.094249] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages350second # [ 0.100236] iommu: DMA domain TLB invalidation policy: strict mode351test # [ 0.094251] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page352second # [ 0.101404] SCSI subsystem initialized353test # [ 0.094255] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages354test # [ 0.094258] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page355test # [ 0.099313] fbcon: Taking over console356test # [ 0.099330] ACPI: Interpreter disabled.357test # [ 0.100568] iommu: Default domain type: Translated358test # [ 0.100578] iommu: DMA domain TLB invalidation policy: strict mode359test # [ 0.101747] SCSI subsystem initialized360second # [ 0.106273] usbcore: registered new interface driver usbfs361second # [ 0.106313] usbcore: registered new interface driver hub362second # [ 0.106328] usbcore: registered new device driver usb363second # [ 0.106536] pps_core: LinuxPPS API ver. 1 registered364second # [ 0.106543] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>365second # [ 0.106549] PTP clock support registered366second # [ 0.106577] EDAC MC: Ver: 3.0.0367second # [ 0.109596] scmi_core: SCMI protocol bus registered368second # [ 0.110361] FPGA manager framework369test # [ 0.106638] usbcore: registered new interface driver usbfs370second # [ 0.111349] vgaarb: loaded371test # [ 0.106689] usbcore: registered new interface driver hub372test # [ 0.106701] usbcore: registered new device driver usb373second # [ 0.111765] clocksource: Switched to clocksource arch_sys_counter374test # [ 0.106898] pps_core: LinuxPPS API ver. 1 registered375test # [ 0.106903] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>376test # [ 0.106910] PTP clock support registered377test # [ 0.106946] EDAC MC: Ver: 3.0.0378test # [ 0.109918] scmi_core: SCMI protocol bus registered379test # [ 0.110714] FPGA manager framework380test # [ 0.111716] vgaarb: loaded381test # [ 0.112147] clocksource: Switched to clocksource arch_sys_counter382second # [ 0.122068] VFS: Disk quotas dquot_6.6.0383second # [ 0.122102] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)384second # [ 0.124418] netfs: FS-Cache loaded385second # [ 0.124530] pnp: PnP ACPI: disabled386test # [ 0.121833] VFS: Disk quotas dquot_6.6.0387test # [ 0.121867] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)388second # [ 0.126884] NET: Registered PF_INET protocol family389test # [ 0.124190] netfs: FS-Cache loaded390second # [ 0.127073] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)391test # [ 0.124303] pnp: PnP ACPI: disabled392test # [ 0.126649] NET: Registered PF_INET protocol family393test # [ 0.126842] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)394second # [ 0.151914] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)395second # [ 0.151942] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)396second # [ 0.151956] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)397second # [ 0.151997] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)398second # [ 0.152065] TCP: Hash tables configured (established 8192 bind 8192)399second # [ 0.152151] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)400second # [ 0.152214] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)401second # [ 0.152269] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)402second # [ 0.152400] NET: Registered PF_UNIX/PF_LOCAL protocol family403test # [ 0.150887] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)404second # [ 0.152436] NET: Registered PF_XDP protocol family405second # [ 0.152457] PCI: CLS 0 bytes, default 64406test # [ 0.150916] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)407second # [ 0.152667] Trying to unpack rootfs image as initramfs...408test # [ 0.150928] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.150971] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.151039] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.151125] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.151156] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413second # [ 0.165735] kvm [1]: HYP mode not available414test # [ 0.151216] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)415test # [ 0.151326] NET: Registered PF_UNIX/PF_LOCAL protocol family416test # [ 0.151363] NET: Registered PF_XDP protocol family417test # [ 0.151384] PCI: CLS 0 bytes, default 64418test # [ 0.151570] Trying to unpack rootfs image as initramfs...419test # [ 0.166084] kvm [1]: HYP mode not available420test # [ 0.228540] Initialise system trusted keyrings421test # [ 0.229058] workingset: timestamp_bits=42 max_order=18 bucket_order=0422test # [ 0.230014] squashfs: version 4.0 (2009/01/31) Phillip Lougher423test # [ 0.230527] 9p: Installing v9fs 9p2000 file system support424second # [ 0.236114] Initialise system trusted keyrings425second # [ 0.236602] workingset: timestamp_bits=42 max_order=18 bucket_order=0426second # [ 0.237605] squashfs: version 4.0 (2009/01/31) Phillip Lougher427second # [ 0.238109] 9p: Installing v9fs 9p2000 file system support428test # [ 0.253405] Key type asymmetric registered429second # [ 0.257447] Key type asymmetric registered430test # [ 0.253432] Asymmetric key parser 'x509' registered431second # [ 0.257470] Asymmetric key parser 'x509' registered432test # [ 0.253489] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)433second # [ 0.257522] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)434test # [ 0.254810] io scheduler mq-deadline registered435test # [ 0.254823] io scheduler kyber registered436second # [ 0.263828] io scheduler mq-deadline registered437second # [ 0.263844] io scheduler kyber registered438second # [ 0.266696] pl061_gpio 9030000.pl061: PL061 GPIO chip registered439second # [ 0.267463] ledtrig-cpu: registered to indicate activity on CPUs440second # [ 0.268266] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:441second # [ 0.268289] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000442second # [ 0.268304] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000443second # [ 0.268310] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000444second # [ 0.268347] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits445second # [ 0.268382] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]446second # [ 0.268450] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00447test # [ 0.264263] pl061_gpio 9030000.pl061: PL061 GPIO chip registered448second # [ 0.268468] pci_bus 0000:00: root bus resource [bus 00-ff]449test # [ 0.264606] ledtrig-cpu: registered to indicate activity on CPUs450second # [ 0.268473] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]451test # [ 0.264942] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:452second # [ 0.268476] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]453test # [ 0.264964] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000454second # [ 0.268480] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]455test # [ 0.264981] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000456second # [ 0.268549] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint457second # [ 0.269022] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint458test # [ 0.264987] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000459second # [ 0.269151] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]460test # [ 0.265020] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits461second # [ 0.269162] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]462second # [ 0.269183] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]463test # [ 0.265043] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]464second # [ 0.269194] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]465test # [ 0.265120] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00466test # [ 0.265138] pci_bus 0000:00: root bus resource [bus 00-ff]467second # [ 0.269511] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint468test # [ 0.265143] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]469second # [ 0.269639] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]470second # [ 0.269651] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]471test # [ 0.265147] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]472second # [ 0.269672] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]473test # [ 0.265150] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]474second # [ 0.269986] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint475test # [ 0.265265] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint476second # [ 0.270113] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]477test # [ 0.265718] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint478second # [ 0.270124] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]479test # [ 0.265848] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]480second # [ 0.270144] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]481test # [ 0.265860] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]482test # [ 0.265880] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]483second # [ 0.270459] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint484second # [ 0.270584] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]485test # [ 0.265892] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]486second # [ 0.270595] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]487test # [ 0.266204] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint488second # [ 0.270615] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]489test # [ 0.266333] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]490test # [ 0.266344] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]491second # [ 0.270931] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint492test # [ 0.266365] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]493second # [ 0.271057] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]494second # [ 0.271068] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]495test # [ 0.266678] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint496test # [ 0.266806] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]497second # [ 0.271088] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]498test # [ 0.266818] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]499second # [ 0.271404] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint500test # [ 0.266838] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]501second # [ 0.271530] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]502second # [ 0.271542] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]503test # [ 0.267148] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint504test # [ 0.267273] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]505second # [ 0.271563] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]506test # [ 0.267284] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]507test # [ 0.267305] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]508test # [ 0.267617] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint509test # [ 0.267744] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]510test # [ 0.267755] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]511test # [ 0.267776] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]512test # [ 0.268082] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint513test # [ 0.268230] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]514test # [ 0.268242] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]515test # [ 0.268263] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]516test # [ 0.268587] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint517test # [ 0.268726] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]518test # [ 0.268737] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]519test # [ 0.268761] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]520test # [ 0.268771] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]521test # [ 0.269117] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint522test # [ 0.269256] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]523test # [ 0.269278] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]524second # [ 0.295987] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint525test # [ 0.269594] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint526second # [ 0.296132] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]527test # [ 0.269723] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]528second # [ 0.296144] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]529test # [ 0.269744] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]530second # [ 0.296169] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]531test # [ 0.270009] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint532second # [ 0.296181] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]533test # [ 0.270132] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]534second # [ 0.296505] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint535test # [ 0.270300] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint536second # [ 0.296646] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]537test # [ 0.270514] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]538second # [ 0.296668] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]539test # [ 0.270527] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]540second # [ 0.296997] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint541test # [ 0.270548] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]542second # [ 0.297128] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]543test # [ 0.270866] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint544test # [ 0.270991] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]545second # [ 0.297150] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]546test # [ 0.271002] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]547second # [ 0.297419] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint548test # [ 0.271023] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]549second # [ 0.297543] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]550test # [ 0.271445] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned551second # [ 0.297714] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint552test # [ 0.271457] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned553second # [ 0.297960] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]554second # [ 0.297973] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]555test # [ 0.271462] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned556second # [ 0.297994] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]557test # [ 0.271495] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned558second # [ 0.298332] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint559test # [ 0.271526] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned560second # [ 0.298462] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]561test # [ 0.271559] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned562second # [ 0.298473] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]563test # [ 0.271590] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned564second # [ 0.298494] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]565second # [ 0.298913] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned566test # [ 0.271621] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned567second # [ 0.298924] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned568test # [ 0.271652] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned569second # [ 0.298929] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned570test # [ 0.271685] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned571test # [ 0.271717] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned572second # [ 0.298963] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned573test # [ 0.271748] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned574second # [ 0.298996] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned575second # [ 0.299030] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned576test # [ 0.271830] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned577test # [ 0.271862] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned578second # [ 0.299063] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned579test # [ 0.271876] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned580second # [ 0.299095] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned581test # [ 0.271890] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned582second # [ 0.299128] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned583test # [ 0.271904] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned584second # [ 0.299160] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned585test # [ 0.271918] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned586second # [ 0.299192] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned587test # [ 0.271931] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned588test # [ 0.271945] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned589second # [ 0.299224] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned590test # [ 0.271958] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned591second # [ 0.299297] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned592test # [ 0.271972] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned593second # [ 0.299329] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned594test # [ 0.271986] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned595second # [ 0.299342] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned596test # [ 0.272000] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned597second # [ 0.299356] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned598test # [ 0.272013] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned599second # [ 0.299370] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned600test # [ 0.272027] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned601second # [ 0.299384] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned602test # [ 0.272040] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned603test # [ 0.272054] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned604second # [ 0.299397] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned605test # [ 0.272067] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned606second # [ 0.299411] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned607test # [ 0.272086] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned608second # [ 0.299425] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned609test # [ 0.272099] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned610second # [ 0.299439] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned611test # [ 0.272113] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned612second # [ 0.299453] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned613test # [ 0.272126] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned614second # [ 0.299467] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned615test # [ 0.272140] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned616second # [ 0.299481] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned617second # [ 0.299494] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned618second # [ 0.299508] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned619second # [ 0.299522] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned620second # [ 0.299535] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned621second # [ 0.299553] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned622second # [ 0.299566] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned623second # [ 0.299580] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned624second # [ 0.299593] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned625second # [ 0.299607] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned626second # [ 0.299624] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]627second # [ 0.299630] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]628second # [ 0.299634] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]629test # [ 0.328237] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]630test # [ 0.328254] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]631test # [ 0.328259] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]632test # [ 0.329060] pci 0000:00:0a.0: enabling device (0000 -> 0002)633second # [ 0.336471] pci 0000:00:0a.0: enabling device (0000 -> 0002)634second # [ 0.342832] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)635test # [ 0.345091] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)636test # [ 0.347031] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)637second # [ 0.352850] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)638test # [ 0.349910] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)639test # [ 0.352032] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)640second # [ 0.359892] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)641second # [ 0.361899] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)642second # [ 0.363699] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)643test # [ 0.361230] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)644test # [ 0.363160] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)645test # [ 0.365972] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)646second # [ 0.372901] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)647second # [ 0.374844] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)648second # [ 0.386040] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)649test # [ 0.376215] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)650test # [ 0.378142] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)651test # [ 0.379785] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)652test # [ 0.381865] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)653second # [ 0.388500] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)654second # [ 0.390173] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)655test # [ 0.393626] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled656test # [ 0.395074] msm_serial: driver initialized657test # [ 0.395172] SuperH (H)SCI(F) driver initialized658test # [ 0.395208] STM32 USART driver initialized659second # [ 0.400236] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)660second # [ 0.404160] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled661second # [ 0.405665] msm_serial: driver initialized662second # [ 0.405737] SuperH (H)SCI(F) driver initialized663second # [ 0.405770] STM32 USART driver initialized664test # [ 0.414296] loop: module loaded665test # [ 0.414426] virtio_blk virtio5: 1/0/0 default/read/poll queues666test # [ 0.415210] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)667second # [ 0.429971] loop: module loaded668second # [ 0.430109] virtio_blk virtio5: 1/0/0 default/read/poll queues669second # [ 0.430645] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)670test # [ 0.424507] megasas: 07.734.00.00-rc1671test # [ 0.425006] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]672test # [ 0.427340] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000673test # [ 0.427462] Intel/Sharp Extended Query Table at 0x0031674test # [ 0.431159] Using buffer write method675test # [ 0.431215] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]676test # [ 0.440751] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000677test # [ 0.440773] Intel/Sharp Extended Query Table at 0x0031678test # [ 0.442509] Using buffer write method679test # [ 0.442529] Concatenating MTD devices:680test # [ 0.442532] (0): "0.flash"681test # [ 0.442535] (1): "0.flash"682test # [ 0.442537] into device "0.flash"683second # [ 0.440144] megasas: 07.734.00.00-rc1684second # [ 0.440594] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]685second # [ 0.454385] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000686second # [ 0.454415] Intel/Sharp Extended Query Table at 0x0031687second # [ 0.471832] Using buffer write method688second # [ 0.471868] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689second # [ 0.473963] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690second # [ 0.473982] Intel/Sharp Extended Query Table at 0x0031691second # [ 0.475628] Using buffer write method692second # [ 0.475648] Concatenating MTD devices:693second # [ 0.475651] (0): "0.flash"694second # [ 0.475654] (1): "0.flash"695second # [ 0.475657] into device "0.flash"696test # [ 0.653181] Freeing initrd memory: 26980K697test # [ 0.659941] tun: Universal TUN/TAP device driver, 1.6698second # [ 0.665573] Freeing initrd memory: 26980K699test # [ 0.662681] thunder_xcv, ver 1.0700test # [ 0.662710] thunder_bgx, ver 1.0701test # [ 0.662722] nicpf, ver 1.0702test # [ 0.663033] e1000: Intel(R) PRO/1000 Network Driver703test # [ 0.663041] e1000: Copyright (c) 1999-2006 Intel Corporation.704test # [ 0.663056] e1000e: Intel(R) PRO/1000 Network Driver705test # [ 0.663062] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.706test # [ 0.663075] igb: Intel(R) Gigabit Ethernet Network Driver707test # [ 0.663078] igb: Copyright (c) 2007-2014 Intel Corporation.708test # [ 0.663090] igbvf: Intel(R) Gigabit Virtual Function Network Driver709test # [ 0.663093] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.710test # [ 0.663159] sky2: driver version 1.30711second # [ 0.672195] tun: Universal TUN/TAP device driver, 1.6712test # [ 0.664036] usbcore: registered new interface driver usb-storage713test # [ 0.664120] usbcore: registered new interface driver usbserial_generic714test # [ 0.664129] usbserial: USB Serial support registered for generic715test # [ 0.670669] ehci-pci 0000:00:0a.0: EHCI Host Controller716test # [ 0.670705] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1717test # [ 0.670946] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000718second # [ 0.674726] thunder_xcv, ver 1.0719second # [ 0.674753] thunder_bgx, ver 1.0720test # [ 0.672772] hv_vmbus: registering driver hyperv_keyboard721second # [ 0.674766] nicpf, ver 1.0722second # [ 0.675051] e1000: Intel(R) PRO/1000 Network Driver723second # [ 0.675059] e1000: Copyright (c) 1999-2006 Intel Corporation.724test # [ 0.673750] rtc-pl031 9010000.pl031: registered as rtc0725second # [ 0.675074] e1000e: Intel(R) PRO/1000 Network Driver726second # [ 0.675079] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.727test # [ 0.673790] rtc-pl031 9010000.pl031: setting system clock to 2026-09-03T15:03:19 UTC (1788447799)728second # [ 0.675094] igb: Intel(R) Gigabit Ethernet Network Driver729test # [ 0.673950] i2c_dev: i2c /dev entries driver730second # [ 0.675098] igb: Copyright (c) 2007-2014 Intel Corporation.731second # [ 0.675108] igbvf: Intel(R) Gigabit Virtual Function Network Driver732second # [ 0.675112] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.733second # [ 0.675171] sky2: driver version 1.30734second # [ 0.676567] ehci-pci 0000:00:0a.0: EHCI Host Controller735second # [ 0.676623] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1736second # [ 0.676859] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000737second # [ 0.682935] usbcore: registered new interface driver usb-storage738second # [ 0.683069] usbcore: registered new interface driver usbserial_generic739second # [ 0.683079] usbserial: USB Serial support registered for generic740second # [ 0.683361] hv_vmbus: registering driver hyperv_keyboard741second # [ 0.685695] rtc-pl031 9010000.pl031: registered as rtc0742second # [ 0.685737] rtc-pl031 9010000.pl031: setting system clock to 2026-09-03T15:03:19 UTC (1788447799)743second # [ 0.685895] i2c_dev: i2c /dev entries driver744second # [ 0.687807] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00745second # [ 0.688610] hub 1-0:1.0: USB hub found746second # [ 0.688988] hub 1-0:1.0: 6 ports detected747second # [ 0.690422] sdhci: Secure Digital Host Controller Interface driver748second # [ 0.690436] sdhci: Copyright(c) Pierre Ossman749second # [ 0.690567] Synopsys Designware Multimedia Card Interface Driver750second # [ 0.690728] sdhci-pltfm: SDHCI platform and OF driver helper751second # [ 0.691578] hid: raw HID events driver (C) Jiri Kosina752second # [ 0.691722] usbcore: registered new interface driver usbhid753second # [ 0.691727] usbhid: USB HID core driver754test # [ 0.676774] sdhci: Secure Digital Host Controller Interface driver755test # [ 0.676789] sdhci: Copyright(c) Pierre Ossman756test # [ 0.676937] Synopsys Designware Multimedia Card Interface Driver757test # [ 0.677111] sdhci-pltfm: SDHCI platform and OF driver helper758test # [ 0.677963] hid: raw HID events driver (C) Jiri Kosina759second # [ 0.725228] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available760test # [ 0.678138] usbcore: registered new interface driver usbhid761second # [ 0.725974] drop_monitor: Initializing network drop monitor service762test # [ 0.678144] usbhid: USB HID core driver763second # [ 0.726087] NET: Registered PF_INET6 protocol family764second # [ 0.728289] Segment Routing with IPv6765second # [ 0.728307] In-situ OAM (IOAM) with IPv6766second # [ 0.728363] NET: Registered PF_PACKET protocol family767test # [ 0.723630] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00768test # [ 0.723829] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available769test # [ 0.724635] drop_monitor: Initializing network drop monitor service770test # [ 0.724765] NET: Registered PF_INET6 protocol family771test # [ 0.725197] hub 1-0:1.0: USB hub found772test # [ 0.725223] hub 1-0:1.0: 6 ports detected773test # [ 0.728509] Segment Routing with IPv6774test # [ 0.728526] In-situ OAM (IOAM) with IPv6775test # [ 0.728597] NET: Registered PF_PACKET protocol family776second # [ 0.729418] 9pnet: Installing 9P2000 support777second # [ 0.730925] Key type dns_resolver registered778second # [ 0.734447] registered taskstats version 1779test # [ 0.729670] 9pnet: Installing 9P2000 support780second # [ 0.734596] Loading compiled-in X.509 certificates781test # [ 0.731469] Key type dns_resolver registered782test # [ 0.735007] registered taskstats version 1783test # [ 0.735160] Loading compiled-in X.509 certificates784second # [ 0.740144] Demotion targets for Node 0: null785second # [ 0.740211] Key type .fscrypt registered786second # [ 0.740217] Key type fscrypt-provisioning registered787second # [ 0.740320] ima: No TPM chip found, activating TPM-bypass!788second # [ 0.740332] ima: Allocated hash algorithm: sha1789second # [ 0.740383] ima: No architecture policies found790second # [ 0.742971] input: gpio-keys as /devices/platform/gpio-keys/input/input0791test # [ 0.740585] Demotion targets for Node 0: null792test # [ 0.740649] Key type .fscrypt registered793test # [ 0.740654] Key type fscrypt-provisioning registered794test # [ 0.740802] ima: No TPM chip found, activating TPM-bypass!795test # [ 0.740816] ima: Allocated hash algorithm: sha1796test # [ 0.740867] ima: No architecture policies found797test # [ 0.743456] input: gpio-keys as /devices/platform/gpio-keys/input/input0798second # [ 0.753086] clk: Disabling unused clocks799second # [ 0.753102] PM: genpd: Disabling unused power domains800second # [ 0.756134] Freeing unused kernel memory: 4736K801second # [ 0.756212] Run /init as init process802test # [ 0.753834] clk: Disabling unused clocks803test # [ 0.753851] PM: genpd: Disabling unused power domains804test # [ 0.756979] Freeing unused kernel memory: 4736K805test # [ 0.757073] Run /init as init process806second # [ 0.774054] systemd[1]: Successfully made /usr/ read-only.807test # [ 0.778587] systemd[1]: Successfully made /usr/ read-only.808second # [ 0.947823] usb 1-1: new high-speed USB device number 2 using ehci-pci809test # [ 0.976208] usb 1-1: new high-speed USB device number 2 using ehci-pci810second # [ 1.099875] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1811second # [ 1.108601] 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.115800] systemd[1]: Detected virtualization qemu.813second # [ 1.116948] systemd[1]: Detected architecture arm64.814second # [ 1.118125] systemd[1]: Running in initrd.815test # [ 1.113108] 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)816test # [ 1.116648] systemd[1]: Detected virtualization qemu.817second # [ 1.119850] systemd[1]: Initializing machine ID from random generator.818test # [ 1.117285] systemd[1]: Detected architecture arm64.819test # [ 1.117866] systemd[1]: Running in initrd.820second # [ 1.121644] systemd[1]: Hostname set to <second>.821test # [ 1.118992] systemd[1]: Initializing machine ID from random generator.822test # [ 1.120005] systemd[1]: Hostname set to <test>.823test # [ 1.126368] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1824second # [ 1.179969] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0825test # [ 1.208449] 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.299801] usb 1-2: new high-speed USB device number 3 using ehci-pci827test # [ 1.328218] usb 1-2: new high-speed USB device number 3 using ehci-pci828test # [ 1.369291] systemd[1]: bpf-restrict-fs: LSM BPF program attached829second # [ 1.392493] systemd[1]: bpf-restrict-fs: LSM BPF program attached830test # [ 1.439224] systemd[1]: Queued start job for default target Initrd Default Target.831test # [ 1.449968] systemd[1]: Created slice Slice /system/modprobe.832second # [ 1.453292] 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/input2833test # [ 1.451091] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.834second # [ 1.455148] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0835test # [ 1.452164] systemd[1]: Expecting device /dev/disk/by-label/nixos...836test # [ 1.453024] systemd[1]: Reached target Path Units.837test # [ 1.453662] systemd[1]: Reached target Slice Units.838test # [ 1.454307] systemd[1]: Reached target Swaps.839test # [ 1.454889] systemd[1]: Reached target Timer Units.840test # [ 1.455805] systemd[1]: Listening on D-Bus System Message Bus Socket.841test # [ 1.456937] systemd[1]: Listening on Journal Socket (/dev/log).842test # [ 1.457849] systemd[1]: Listening on Journal Sockets.843test # [ 1.458638] systemd[1]: Listening on udev Control Socket.844test # [ 1.459554] systemd[1]: Listening on udev Kernel Socket.845test # [ 1.460322] systemd[1]: Reached target Socket Units.846test # [ 1.463035] systemd[1]: Starting Create List of Static Device Nodes...847test # [ 1.472534] systemd[1]: Starting Load Kernel Module 9pnet_virtio...848test # [ 1.473913] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs849second # [ 1.483311] systemd[1]: Queued start job for default target Initrd Default Target.850test # [ 1.480943] systemd[1]: Mounting Kernel Configuration File System...851test # [ 1.486304] 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/input2852test # [ 1.486465] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0853second # [ 1.494390] systemd[1]: Created slice Slice /system/modprobe.854second # [ 1.495710] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.855second # [ 1.497351] systemd[1]: Expecting device /dev/disk/by-label/nixos...856second # [ 1.497411] systemd[1]: Reached target Path Units.857second # [ 1.497446] systemd[1]: Reached target Slice Units.858second # [ 1.497477] systemd[1]: Reached target Swaps.859second # [ 1.497509] systemd[1]: Reached target Timer Units.860second # [ 1.497784] systemd[1]: Listening on D-Bus System Message Bus Socket.861second # [ 1.497980] systemd[1]: Listening on Journal Socket (/dev/log).862second # [ 1.498142] systemd[1]: Listening on Journal Sockets.863second # [ 1.498273] systemd[1]: Listening on udev Control Socket.864second # [ 1.498418] systemd[1]: Listening on udev Kernel Socket.865second # [ 1.498463] systemd[1]: Reached target Socket Units.866test # [ 1.505404] systemd[1]: Starting Journal Service...867second # [ 1.510225] systemd[1]: Starting Create List of Static Device Nodes...868second # [ 1.516963] systemd[1]: Starting Load Kernel Module 9pnet_virtio...869second # [ 1.518001] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs870test # [ 1.520268] systemd[1]: Starting Load Kernel Modules...871test # [ 1.520838] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os872second # [ 1.527889] systemd[1]: Mounting Kernel Configuration File System...873test # [ 1.533386] systemd[1]: Starting Coldplug All udev Devices...874second # [ 1.537535] systemd[1]: Starting Journal Service...875second # [ 1.555924] systemd[1]: Starting Load Kernel Modules...876second # [ 1.556597] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os877test # [ 1.552324] systemd[1]: Finished Create List of Static Device Nodes.878test # [ 1.553196] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.879test # [ 1.553384] systemd[1]: Finished Load Kernel Module 9pnet_virtio.880second # [ 1.563967] systemd[1]: Starting Coldplug All udev Devices...881test # [ 1.570020] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.882second # [ 1.577436] systemd[1]: Finished Create List of Static Device Nodes.883second # [ 1.578226] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.884second # [ 1.578412] systemd[1]: Finished Load Kernel Module 9pnet_virtio.885second # [ 1.578590] systemd[1]: Mounted Kernel Configuration File System.886test # [ 1.579406] systemd-journald[73]: Collecting audit messages is disabled.887second # [ 1.588096] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...888test # [ 1.588222] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev889test # [ 1.592801] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0890test # [ 1.593021] [drm] features: -virgl +edid -resource_blob -host_visible891test # [ 1.593026] [drm] features: -context_init892test # [ 1.593476] [drm] number of scanouts: 1893test # [ 1.593492] [drm] number of cap sets: 0894test # [ 1.598908] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...895test # [ 1.599344] systemd[1]: Mounted Kernel Configuration File System.896test # [ 1.612605] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.897test # [ 1.614306] systemd[1]: Starting Create Static Device Nodes in /dev...898test # [ 1.616446] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic899test # [ 1.616460] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0900second # [ 1.620505] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.901second # [ 1.631675] systemd-journald[73]: Collecting audit messages is disabled.902second # [ 1.636766] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.903second # [ 1.638366] systemd[1]: Starting Create Static Device Nodes in /dev...904test # [ 1.633940] Console: switching to colour frame buffer device 160x50905second # [ 1.643872] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev906second # [ 1.651155] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0907second # [ 1.651371] [drm] features: -virgl +edid -resource_blob -host_visible908second # [ 1.651376] [drm] features: -context_init909second # [ 1.659889] [drm] number of scanouts: 1910second # [ 1.659907] [drm] number of cap sets: 0911test # [ 1.656580] systemd[1]: Finished Create Static Device Nodes in /dev.912test # [ 1.656890] systemd[1]: Reached target Preparation for Local File Systems.913test # [ 1.656922] systemd[1]: Reached target Local File Systems.914test # [ 1.659391] systemd[1]: Starting Rule-based Manager for Device Events and Files...915test # [ 1.664725] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device916second # [ 1.668307] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic917second # [ 1.668321] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0918test # [ 1.664717] systemd-modules-load[74]: Inserted module 'dm_mod'919test # [ 1.665954] systemd-modules-load[74]: Module 'virtio_balloon' is built in920test # [ 1.666710] systemd-modules-load[74]: Module 'virtio_console' is built in921test # [ 1.667418] systemd-modules-load[74]: Inserted module 'virtio_gpu'922test # [ 1.676365] systemd[1]: Started Journal Service.923test # [ 1.671864] systemd-modules-load[74]: Module 'virtio_rng' is built in924second # [ 1.685543] Console: switching to colour frame buffer device 160x50925test # [ 1.680395] systemd[1]: Finished Load Kernel Modules.926test # [ 1.681014] systemd[1]: Starting Apply Kernel Variables...927second # [ 1.692182] systemd[1]: Finished Create Static Device Nodes in /dev.928second # [ 1.692329] systemd[1]: Reached target Preparation for Local File Systems.929second # [ 1.692354] systemd[1]: Reached target Local File Systems.930second # [ 1.694865] systemd[1]: Starting Rule-based Manager for Device Events and Files...931second # [ 1.703684] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device932test # [ 1.697987] systemd[1]: Starting Create System Files and Directories...933second # [ 1.718973] systemd[1]: Finished Load Kernel Modules.934second # [ 1.716234] systemd-modules-load[74]: Inserted module 'dm_mod'935second # [ 1.720954] systemd[1]: Starting Apply Kernel Variables...936second # [ 1.717596] systemd-modules-load[74]: Module 'virtio_balloon' is built in937second # [ 1.718280] systemd-modules-load[74]: Module 'virtio_console' is built in938second # [ 1.718992] systemd-modules-load[74]: Inserted module 'virtio_gpu'939second # [ 1.719631] systemd-modules-load[74]: Module 'virtio_rng' is built in940second # [ 1.728217] systemd[1]: Started Journal Service.941test # [ 1.725501] systemd-udevd[81]: Using default interface naming scheme 'v261'.942test # [ 1.735529] systemd[1]: Finished Create System Files and Directories.943test # [ 1.736817] systemd[1]: Finished Apply Kernel Variables.944second # [ 1.749029] systemd[1]: Starting Create System Files and Directories...945test # [ 1.752079] systemd[1]: Started Rule-based Manager for Device Events and Files.946second # [ 1.760602] systemd[1]: Finished Apply Kernel Variables.947second # [ 1.765782] systemd[1]: Finished Create System Files and Directories.948second # [ 1.770873] systemd-udevd[79]: Using default interface naming scheme 'v261'.949second # [ 1.788111] systemd[1]: Started Rule-based Manager for Device Events and Files.950test # [ 1.812411] systemd[1]: Starting Virtual Console Setup...951second # [ 1.826400] systemd[1]: Starting Virtual Console Setup...952test # [ 1.848325] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.953test # [ 1.850387] systemd[1]: Finished Virtual Console Setup.954second # [ 1.865138] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.955second # [ 1.866440] systemd[1]: Finished Virtual Console Setup.956test # [ 2.065357] systemd[1]: Finished Coldplug All udev Devices.957test # [ 2.066001] systemd[1]: Reached target System Initialization.958test # [ 2.066519] systemd[1]: Reached target Basic System.959second # [ 2.076796] systemd[1]: Finished Coldplug All udev Devices.960second # [ 2.077374] systemd[1]: Reached target System Initialization.961second # [ 2.077896] systemd[1]: Reached target Basic System.962second # [ 2.173904] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.963test # [ 2.170387] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.964second # [ 2.188223] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.965test # [ 2.186503] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.966second # [ 2.260076] systemd[1]: Found device /dev/disk/by-label/nixos.967second # [ 2.262821] systemd[1]: Reached target Initrd Root Device.968test # [ 2.259253] systemd[1]: Found device /dev/disk/by-label/nixos.969second # [ 2.264146] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...970test # [ 2.261517] systemd[1]: Reached target Initrd Root Device.971test # [ 2.264054] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...972second # [ 2.298501] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks973test # [ 2.296551] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks974second # [ 2.334000] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.975test # [ 2.331595] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.976test # [ 2.532476] systemd[1]: Mounting /sysroot...977test # [ 2.564595] EXT4-fs (vda): mounted filesystem d28bfbaf-1919-4372-afdb-7c3e589f7f9a r/w with ordered data mode. Quota mode: none.978test # [ 2.559553] systemd[1]: Mounted /sysroot.979test # [ 2.561651] systemd[1]: Reached target Initrd Root File System.980test # [ 2.564819] systemd[1]: Starting Mountpoints Configured in the Real Root...981second # [ 2.570127] systemd[1]: Mounting /sysroot...982test # [ 2.582913] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.983test # [ 2.587571] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...984test # [ 2.591007] systemd[1]: Reloading...985second # [ 2.604776] EXT4-fs (vda): mounted filesystem f28f032b-969b-4c90-9ca9-4b7ec8513ba5 r/w with ordered data mode. Quota mode: none.986second # [ 2.601377] systemd[1]: Mounted /sysroot.987second # [ 2.602810] systemd[1]: Reached target Initrd Root File System.988second # [ 2.606886] systemd[1]: Mounting /sysroot/nix/.ro-store...989second # [ 2.617643] systemd[1]: Mounting /sysroot/nix/.rw-store...990second # [ 2.630801] systemd[1]: Mounting /sysroot/run...991second # [ 2.638443] systemd[1]: Mounting /sysroot/tmp/shared...992second # [ 2.658017] systemd[1]: Mounting /sysroot/tmp/xchg...993second # [ 2.666647] systemd[1]: Starting Mountpoints Configured in the Real Root...994second # [ 2.677603] systemd[1]: Mounted /sysroot/nix/.rw-store.995second # [ 2.682419] systemd[1]: Mounted /sysroot/nix/.ro-store.996second # [ 2.711338] systemd[1]: Starting rw-sysroot-nix-store.service...997second # [ 2.719939] systemd[1]: Mounted /sysroot/run.998second # [ 2.720566] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.999second # [ 2.723570] systemd[1]: Finished rw-sysroot-nix-store.service.1000second # [ 2.724257] systemd[1]: Mounted /sysroot/tmp/shared.1001second # [ 2.728301] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.1002second # [ 2.736109] systemd[1]: Mounted /sysroot/tmp/xchg.1003second # [ 2.737620] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...1004second # [ 2.738981] systemd[1]: Reloading...1005test # [ 2.753486] systemd[1]: Reloading finished in 164 ms.1006test # [ 2.775821] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1007test # [ 2.778394] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1008test # [ 2.782842] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1009test # [ 2.783806] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1010test # [ 2.792129] systemd[1]: Finished Mountpoints Configured in the Real Root.1011test # [ 2.792772] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1012test # [ 2.801404] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1013test # [ 2.802062] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1014second # [ 2.904096] systemd[1]: Reloading finished in 163 ms.1015second # [ 2.932494] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...1016second # [ 2.936966] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...1017second # [ 2.938395] systemd[1]: Starting rw-sysroot-nix-store.service...1018second # [ 2.942439] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019second # [ 2.944114] systemd[1]: Finished Mountpoints Configured in the Real Root.1020second # [ 2.945794] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1021second # [ 2.962936] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1022second # [ 2.963850] systemd[1]: Finished rw-sysroot-nix-store.service.1023test # [ 3.036940] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1024test # [ 3.040440] (udev-worker)[94]: 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 directory1025test # [ 3.046021] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1026test # [ 3.047193] systemd[1]: Stopped Virtual Console Setup.1027test # [ 3.051180] systemd[1]: Stopping Virtual Console Setup...1028test # [ 3.051811] systemd[1]: Starting Virtual Console Setup...1029second # [ 3.071569] (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 directory1030test # [ 3.072071] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1031test # [ 3.072751] systemd[1]: Stopped Virtual Console Setup.1032test # [ 3.076233] systemd[1]: Starting Virtual Console Setup...1033second # [ 3.080970] (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 directory1034second # [ 3.087409] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1035second # [ 3.089331] systemd[1]: Stopped Virtual Console Setup.1036second # [ 3.091191] systemd[1]: Stopping Virtual Console Setup...1037second # [ 3.093115] systemd[1]: Starting Virtual Console Setup...1038test # [ 3.094593] systemd-vconsole-setup[146]: Configuration of first virtual console was skipped, ignoring remaining ones.1039test # [ 3.096864] systemd[1]: Finished Virtual Console Setup.1040second # [ 3.118682] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.1041second # [ 3.120876] systemd[1]: Finished Virtual Console Setup.1042test # [ 3.532942] systemd[1]: Mounting /sysroot/nix/.ro-store...1043test # [ 3.544275] systemd[1]: Mounting /sysroot/nix/.rw-store...1044test # [ 3.547411] systemd[1]: Mounting /sysroot/run...1045test # [ 3.560255] systemd[1]: Mounting /sysroot/tmp/shared...1046second # [ 3.571978] systemd[1]: Mounting /sysroot/nix/store...1047test # [ 3.582364] systemd[1]: Mounting /sysroot/tmp/xchg...1048test # [ 3.606558] systemd[1]: Mounted /sysroot/nix/.rw-store.1049second # [ 3.616786] systemd[1]: Mounted /sysroot/nix/store.1050test # [ 3.614338] systemd[1]: Starting rw-sysroot-nix-store.service...1051second # [ 3.618896] systemd[1]: Reached target Initrd File Systems.1052second # [ 3.622770] systemd[1]: Starting Find NixOS closure...1053test # [ 3.621908] systemd[1]: Mounted /sysroot/nix/.ro-store.1054test # [ 3.624108] systemd[1]: Mounted /sysroot/run.1055second # [ 3.632741] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1056test # [ 3.629728] systemd[1]: Mounted /sysroot/tmp/shared.1057test # [ 3.630547] systemd[1]: Mounted /sysroot/tmp/xchg.1058test # [ 3.639603] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1059test # [ 3.641069] systemd[1]: Finished rw-sysroot-nix-store.service.1060second # [ 3.667927] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1061second # [ 3.672129] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1062second # [ 3.688671] systemd[1]: Finished Find NixOS closure.1063second # [ 3.690802] systemd[1]: Reached target Initrd Default Target.1064second # [ 3.692203] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1065second # [ 3.720665] systemd[1]: Stopped target Initrd Default Target.1066second # [ 3.722516] systemd[1]: Stopped target Basic System.1067second # [ 3.724224] systemd[1]: Stopped target Initrd Root Device.1068second # [ 3.728294] systemd[1]: Stopped target Path Units.1069second # [ 3.729390] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1070second # [ 3.731087] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1071second # [ 3.736172] systemd[1]: Stopped target Slice Units.1072second # [ 3.736880] systemd[1]: Stopped target Socket Units.1073second # [ 3.737758] systemd[1]: Stopped target System Initialization.1074second # [ 3.738479] systemd[1]: Stopped target Swaps.1075second # [ 3.739048] systemd[1]: Stopped target Timer Units.1076second # [ 3.739682] systemd[1]: dbus.socket: Deactivated successfully.1077second # [ 3.744159] systemd[1]: Closed D-Bus System Message Bus Socket.1078second # [ 3.744931] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1079second # [ 3.746104] systemd[1]: Stopped Find NixOS closure.1080second # [ 3.746685] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1081second # [ 3.751090] systemd[1]: Starting rw-sysroot-nix-store.service...1082second # [ 3.751818] systemd[1]: systemd-sysctl.service: Deactivated successfully.1083second # [ 3.754954] systemd[1]: Stopped Apply Kernel Variables.1084second # [ 3.756624] systemd[1]: systemd-modules-load.service: Deactivated successfully.1085second # [ 3.765051] systemd[1]: Stopped Load Kernel Modules.1086second # [ 3.765651] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1087second # [ 3.774211] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1088second # [ 3.775818] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1089second # [ 3.778135] systemd[1]: Stopped Create System Files and Directories.1090second # [ 3.779918] systemd[1]: Stopped target Local File Systems.1091second # [ 3.780592] systemd[1]: Stopped target Preparation for Local File Systems.1092second # [ 3.782235] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1093second # [ 3.784182] systemd[1]: Stopped Coldplug All udev Devices.1094second # [ 3.784695] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1095second # [ 3.786242] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1096second # [ 3.787373] systemd[1]: Stopped Virtual Console Setup.1097second # [ 3.791199] systemd[1]: initrd-cleanup.service: Deactivated successfully.1098second # [ 3.791808] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1099second # [ 3.792646] systemd[1]: systemd-udevd.service: Deactivated successfully.1100second # [ 3.793231] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1101second # [ 3.793840] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1102second # [ 3.794441] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1103second # [ 3.794947] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1104second # [ 3.795550] systemd[1]: Finished rw-sysroot-nix-store.service.1105second # [ 3.796250] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1106second # [ 3.796870] systemd[1]: Closed udev Control Socket.1107second # [ 3.797320] systemd[1]: Starting Cleanup udev Database...1108second # [ 3.797792] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1109second # [ 3.798437] systemd[1]: Stopped Create Static Device Nodes in /dev.1110second # [ 3.798980] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1111second # [ 3.799668] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1112second # [ 3.800378] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1113second # [ 3.800992] systemd[1]: Stopped Create List of Static Device Nodes.1114second # [ 3.818929] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1115second # [ 3.819849] systemd[1]: Finished Cleanup udev Database.1116second # [ 3.821711] systemd[1]: Reached target Switch Root.1117second # [ 3.822382] systemd[1]: Starting NixOS Activation...1118second # [ 4.008284] initrd-nixos-activation-start[179]: booting system configuration /nix/store/ahsy382b3qyyw8pa1ik3hbjk32l5964i-nixos-system-second-test1119second # [ 4.074804] initrd-nixos-activation-start[179]: running activation script...1120second # [ 4.521403] initrd-nixos-activation-start[202]: setting up /etc...1121test # [ 4.531334] systemd[1]: Mounting /sysroot/nix/store...1122test # [ 4.572860] systemd[1]: Mounted /sysroot/nix/store.1123test # [ 4.576200] systemd[1]: Reached target Initrd File Systems.1124test # [ 4.578883] systemd[1]: Starting Find NixOS closure...1125test # [ 4.588354] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1126test # [ 4.636374] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1127test # [ 4.639396] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1128test # [ 4.652804] systemd[1]: Finished Find NixOS closure.1129test # [ 4.654972] systemd[1]: Reached target Initrd Default Target.1130test # [ 4.656370] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1131test # [ 4.690786] systemd[1]: initrd-cleanup.service: Deactivated successfully.1132test # [ 4.692414] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1133test # [ 4.695924] systemd[1]: Stopped target Initrd Default Target.1134test # [ 4.697200] systemd[1]: Stopped target Basic System.1135test # [ 4.698254] systemd[1]: Stopped target Initrd Root Device.1136test # [ 4.700159] systemd[1]: Stopped target Path Units.1137test # [ 4.701881] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1138test # [ 4.703948] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1139test # [ 4.708190] systemd[1]: Stopped target Slice Units.1140test # [ 4.708908] systemd[1]: Stopped target Socket Units.1141test # [ 4.709789] systemd[1]: Stopped target System Initialization.1142test # [ 4.710448] systemd[1]: Stopped target Swaps.1143test # [ 4.711068] systemd[1]: Stopped target Timer Units.1144test # [ 4.711588] systemd[1]: dbus.socket: Deactivated successfully.1145test # [ 4.716108] systemd[1]: Closed D-Bus System Message Bus Socket.1146test # [ 4.717058] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1147test # [ 4.717945] systemd[1]: Stopped Find NixOS closure.1148test # [ 4.718415] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1149test # [ 4.721057] systemd[1]: Starting rw-sysroot-nix-store.service...1150test # [ 4.721694] systemd[1]: systemd-sysctl.service: Deactivated successfully.1151test # [ 4.722455] systemd[1]: Stopped Apply Kernel Variables.1152test # [ 4.722922] systemd[1]: systemd-modules-load.service: Deactivated successfully.1153test # [ 4.723525] systemd[1]: Stopped Load Kernel Modules.1154test # [ 4.723963] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1155test # [ 4.737771] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1156test # [ 4.739345] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1157test # [ 4.740273] systemd[1]: Stopped Create System Files and Directories.1158test # [ 4.741794] systemd[1]: Stopped target Local File Systems.1159test # [ 4.742512] systemd[1]: Stopped target Preparation for Local File Systems.1160test # [ 4.743289] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1161test # [ 4.743922] systemd[1]: Stopped Coldplug All udev Devices.1162test # [ 4.747358] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1163test # [ 4.748932] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1164test # [ 4.752153] systemd[1]: Stopped Virtual Console Setup.1165test # [ 4.752678] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1166test # [ 4.753339] systemd[1]: Finished rw-sysroot-nix-store.service.1167test # [ 4.753854] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1168test # [ 4.754476] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1169test # [ 4.755006] systemd[1]: systemd-udevd.service: Deactivated successfully.1170test # [ 4.755556] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1171test # [ 4.757037] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1172test # [ 4.757673] systemd[1]: Closed udev Control Socket.1173test # [ 4.758110] systemd[1]: Starting Cleanup udev Database...1174test # [ 4.758591] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1175test # [ 4.759241] systemd[1]: Stopped Create Static Device Nodes in /dev.1176test # [ 4.759766] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1177test # [ 4.761112] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1178test # [ 4.761756] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1179test # [ 4.762389] systemd[1]: Stopped Create List of Static Device Nodes.1180second # [ 4.786700] initrd-nixos-activation-start[202]: setting up age secrets...1181test # [ 4.782409] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1182test # [ 4.783156] systemd[1]: Finished Cleanup udev Database.1183test # [ 4.783646] systemd[1]: Reached target Switch Root.1184test # [ 4.787543] systemd[1]: Starting NixOS Activation...1185test # [ 4.934136] initrd-nixos-activation-start[183]: booting system configuration /nix/store/h4r9invcd6mfpbq3xqqn4m88rz5nj3mn-nixos-system-test-test1186second # [ 4.967439] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1187second # [ 4.969275] systemd[1]: Finished NixOS Activation.1188second # [ 4.972106] systemd[1]: Starting Switch Root...1189second # [ 4.988704] systemd[1]: Switching root.1190test # [ 4.988351] initrd-nixos-activation-start[183]: running activation script...1191second # [ 5.166239] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1192test # [ 5.378949] initrd-nixos-activation-start[206]: setting up /etc...1193test # [ 5.619629] initrd-nixos-activation-start[206]: setting up age secrets...1194second # [ 5.775168] 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)1195second # [ 5.782359] systemd[1]: Detected virtualization qemu.1196second # [ 5.784128] systemd[1]: Detected architecture arm64.1197second # [ 5.786405] systemd[1]: Detected first boot.1198second # [ 5.791425] systemd[1]: Initializing machine ID from random generator.1199test # [ 5.873555] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1200test # [ 5.875267] systemd[1]: Finished NixOS Activation.1201test # [ 5.876088] systemd[1]: Starting Switch Root...1202test # [ 5.892554] systemd[1]: Switching root.1203test # [ 6.070810] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1204second # [ 6.080360] systemd[1]: bpf-restrict-fs: LSM BPF program attached1205second # [ 6.277013] systemd[1]: Applying preset policy.1206test # [ 6.671713] 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)1207test # [ 6.678584] systemd[1]: Detected virtualization qemu.1208test # [ 6.680238] systemd[1]: Detected architecture arm64.1209test # [ 6.681986] systemd[1]: Detected first boot.1210test # [ 6.687667] systemd[1]: Initializing machine ID from random generator.1211second # [ 6.869847] systemd[1]: Populated /etc with preset unit settings.1212test # [ 7.001296] systemd[1]: bpf-restrict-fs: LSM BPF program attached1213test # [ 7.172894] systemd[1]: Applying preset policy.1214second # [ 7.378487] systemd[1]: initrd-switch-root.service: Deactivated successfully.1215second # [ 7.379355] systemd[1]: Stopped initrd-switch-root.service.1216second # [ 7.381176] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1217second # [ 7.384029] systemd[1]: Created slice Slice /system/getty.1218second # [ 7.384480] systemd[1]: Created slice User and Session Slice.1219second # [ 7.385008] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1220second # [ 7.385372] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1221second # [ 7.385693] systemd[1]: Expecting device /dev/hvc0...1222second # [ 7.385970] systemd[1]: Expecting device /dev/ttyAMA0...1223second # [ 7.386261] systemd[1]: Reached target Local Encrypted Volumes.1224second # [ 7.386548] systemd[1]: Stopped target initrd-fs.target.1225second # [ 7.386827] systemd[1]: Stopped target initrd-root-fs.target.1226second # [ 7.387097] systemd[1]: Stopped target initrd-switch-root.target.1227second # [ 7.387372] systemd[1]: Reached target Virtual Machines and Containers.1228second # [ 7.387646] systemd[1]: Reached target Path Units.1229second # [ 7.393501] systemd[1]: Reached target Remote File Systems.1230second # [ 7.394419] systemd[1]: Reached target Slice Units.1231second # [ 7.395592] systemd[1]: Reached target Swaps.1232second # [ 7.399210] systemd[1]: Listening on Query the User Interactively for a Password.1233second # [ 7.403173] systemd[1]: Listening on Process Core Dump Socket.1234second # [ 7.406466] systemd[1]: Listening on Credential Encryption/Decryption.1235second # [ 7.409400] systemd[1]: Listening on Factory Reset Management.1236second # [ 7.410389] systemd[1]: Listening on Hostname Service Socket.1237second # [ 7.414656] systemd[1]: Starting Journal Log Access Socket...1238second # [ 7.416941] systemd[1]: Listening on Journal Audit Socket.1239second # [ 7.420734] systemd[1]: Listening on Console Output Muting Service Socket.1240second # [ 7.422404] systemd[1]: Listening on Network Management Metrics Varlink Socket.1241second # [ 7.424402] systemd[1]: Listening on Network Management Varlink Socket.1242second # [ 7.426096] systemd[1]: Listening on Network Management Netlink Socket.1243second # [ 7.427936] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1244second # [ 7.430020] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1245second # [ 7.431694] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1246second # [ 7.441101] systemd[1]: Listening on Disk Repartitioning Service Socket.1247second # [ 7.441602] systemd[1]: Listening on Resolve Monitor Varlink Socket.1248second # [ 7.441954] systemd[1]: Listening on Resolve Service Varlink Socket.1249second # [ 7.442292] systemd[1]: Listening on udev Control Socket.1250second # [ 7.442647] systemd[1]: Listening on udev Varlink Socket.1251second # [ 7.447843] systemd[1]: Mounting Huge Pages File System...1252second # [ 7.451135] systemd[1]: Mounting POSIX Message Queue File System...1253second # [ 7.458985] systemd[1]: Mounting Kernel Debug File System...1254second # [ 7.467999] systemd[1]: Mounting Kernel Trace File System...1255second # [ 7.475551] systemd[1]: Starting Create List of Static Device Nodes...1256second # [ 7.489379] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1257second # [ 7.490870] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1258second # [ 7.498304] systemd[1]: Mounting Kernel Configuration File System...1259second # [ 7.500222] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1260second # [ 7.508523] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1261second # [ 7.516325] systemd[1]: Starting Load Kernel Module fuse...1262second # [ 7.518021] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671263second # [ 7.578173] systemd[1]: Starting Journal Service...1264second # [ 7.604693] systemd[1]: Starting Load Kernel Modules...1265test # [ 7.621845] systemd[1]: Populated /etc with preset unit settings.1266second # [ 7.636865] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1267second # [ 7.640728] fuse: init (API version 7.45)1268second # [ 7.651681] systemd[1]: Starting Remount Root and Kernel File Systems...1269second # [ 7.655406] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1270second # [ 7.676090] systemd[1]: Starting Coldplug All udev Devices...1271second # [ 7.699562] systemd[1]: Listening on Journal Log Access Socket.1272second # [ 7.702313] systemd[1]: Mounted Huge Pages File System.1273second # [ 7.705842] systemd[1]: Mounted POSIX Message Queue File System.1274second # [ 7.708665] systemd-journald[307]: Collecting audit messages is enabled.1275second # [ 7.713055] systemd[1]: Mounted Kernel Debug File System.1276second # [ 7.718204] systemd[1]: Mounted Kernel Trace File System.1277second # [ 7.720565] systemd[1]: Finished Create List of Static Device Nodes.1278second # [ 7.722360] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1279second # [ 7.726071] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1280second # [ 7.725612] systemd[1]: Queued start job for default target Multi-User System.1281second # [ 7.734711] systemd[1]: Started Journal Service.1282second # [ 7.729227] systemd[1]: systemd-journald.service: Deactivated successfully.1283second # [ 7.739997] EXT4-fs (vda): re-mounted f28f032b-969b-4c90-9ca9-4b7ec8513ba5.1284second # [ 7.737395] systemd[1]: Mounted Kernel Configuration File System.1285second # [ 7.738139] systemd[1]: modprobe@fuse.service: Deactivated successfully.1286second # [ 7.741658] systemd[1]: Finished Load Kernel Module fuse.1287second # [ 7.747576] systemd[1]: Finished Remount Root and Kernel File Systems.1288second # [ 7.749880] systemd-modules-load[308]: Module 'atkbd' is built in1289second # [ 7.754053] systemd-modules-load[308]: Module 'ctr' is built in1290second # [ 7.756395] systemd-modules-load[308]: Module 'loop' is built in1291second # [ 7.760977] systemd[1]: Finished Load Kernel Modules.1292second # [ 7.764463] systemd[1]: Listening on Disk Image Download Service Socket.1293second # [ 7.778086] systemd[1]: Mounting FUSE Control File System...1294second # [ 7.781556] systemd[1]: Starting Firewall...1295second # [ 7.789487] systemd[1]: Starting Flush Journal to Persistent Storage...1296second # [ 7.791824] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1297second # [ 7.798794] systemd[1]: Starting Load/Save OS Random Seed...1298second # [ 7.809457] systemd-oomd[310]: No swap; memory pressure usage will be degraded1299second # [ 7.820185] systemd[1]: Starting Apply Kernel Variables...1300second # [ 7.838662] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1301second # [ 7.842013] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1302second # [ 7.845797] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1303second # [ 7.889494] systemd[1]: Finished Load/Save OS Random Seed.1304second # [ 7.896442] systemd[1]: Reached target First Boot Complete.1305second # [ 7.909595] systemd-journald[307]: Received client request to flush runtime journal.1306second # [ 7.968934] systemd[1]: Mounted FUSE Control File System.1307second # [ 7.976359] systemd[1]: Finished Flush Journal to Persistent Storage.1308second # [ 7.979354] systemd[1]: Finished Apply Kernel Variables.1309second # [ 7.987117] systemd[1]: Starting Network Name Resolution...1310second # [ 8.010666] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1311second # [ 8.022864] systemd[1]: Starting Create Static Device Nodes in /dev...1312second # [ 8.125278] systemd[1]: Finished Create Static Device Nodes in /dev.1313second # [ 8.125908] systemd[1]: Reached target Preparation for Local File Systems.1314second # [ 8.128667] systemd[1]: Starting Rule-based Manager for Device Events and Files...1315second # [ 8.151645] systemd-resolved[340]: Positive Trust Anchors:1316second # [ 8.153014] systemd-resolved[340]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1317second # [ 8.157389] systemd-resolved[340]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161318second # [ 8.160424] systemd-resolved[340]: 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 test1319test # [ 8.197166] systemd[1]: initrd-switch-root.service: Deactivated successfully.1320test # [ 8.198044] systemd[1]: Stopped initrd-switch-root.service.1321test # [ 8.199990] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1322test # [ 8.202596] systemd[1]: Created slice Slice /system/getty.1323test # [ 8.203063] systemd[1]: Created slice User and Session Slice.1324test # [ 8.203183] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1325test # [ 8.203261] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1326test # [ 8.203695] systemd[1]: Expecting device /dev/hvc0...1327test # [ 8.203982] systemd[1]: Expecting device /dev/ttyAMA0...1328test # [ 8.207451] systemd[1]: Reached target Local Encrypted Volumes.1329test # [ 8.208709] systemd[1]: Stopped target initrd-fs.target.1330test # [ 8.209612] systemd[1]: Stopped target initrd-root-fs.target.1331test # [ 8.211093] systemd[1]: Stopped target initrd-switch-root.target.1332test # [ 8.212671] systemd[1]: Reached target Virtual Machines and Containers.1333test # [ 8.214182] systemd[1]: Reached target Path Units.1334test # [ 8.215542] systemd[1]: Reached target Remote File Systems.1335test # [ 8.217012] systemd[1]: Reached target Slice Units.1336test # [ 8.217852] systemd[1]: Reached target Swaps.1337test # [ 8.221863] systemd[1]: Listening on Query the User Interactively for a Password.1338test # [ 8.227423] systemd[1]: Listening on Process Core Dump Socket.1339test # [ 8.231003] systemd[1]: Listening on Credential Encryption/Decryption.1340test # [ 8.234975] systemd[1]: Listening on Factory Reset Management.1341test # [ 8.235974] systemd[1]: Listening on Hostname Service Socket.1342test # [ 8.241291] systemd[1]: Starting Journal Log Access Socket...1343test # [ 8.243389] systemd[1]: Listening on Journal Audit Socket.1344test # [ 8.247867] systemd[1]: Listening on Console Output Muting Service Socket.1345test # [ 8.249599] systemd[1]: Listening on Network Management Metrics Varlink Socket.1346test # [ 8.250790] systemd[1]: Listening on Network Management Varlink Socket.1347test # [ 8.251916] systemd[1]: Listening on Network Management Netlink Socket.1348test # [ 8.253105] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1349test # [ 8.254191] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1350test # [ 8.255487] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1351test # [ 8.264068] systemd[1]: Listening on Disk Repartitioning Service Socket.1352test # [ 8.265209] systemd[1]: Listening on Resolve Monitor Varlink Socket.1353test # [ 8.266265] systemd[1]: Listening on Resolve Service Varlink Socket.1354test # [ 8.267320] systemd[1]: Listening on udev Control Socket.1355second # [ 8.264441] systemd-udevd[350]: Using default interface naming scheme 'v261'.1356test # [ 8.268341] systemd[1]: Listening on udev Varlink Socket.1357test # [ 8.271228] systemd[1]: Mounting Huge Pages File System...1358test # [ 8.274309] systemd[1]: Mounting POSIX Message Queue File System...1359test # [ 8.280619] systemd[1]: Mounting Kernel Debug File System...1360test # [ 8.289772] systemd[1]: Mounting Kernel Trace File System...1361test # [ 8.299522] systemd[1]: Starting Create List of Static Device Nodes...1362test # [ 8.306621] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1363test # [ 8.308910] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1364test # [ 8.314505] systemd[1]: Mounting Kernel Configuration File System...1365test # [ 8.316446] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1366test # [ 8.323594] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1367test # [ 8.335887] systemd[1]: Starting Load Kernel Module fuse...1368test # [ 8.338417] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671369second # [ 8.378698] systemd[1]: Mounting /run/wrappers...1370test # [ 8.383435] systemd[1]: Starting Journal Service...1371test # [ 8.421168] systemd[1]: Starting Load Kernel Modules...1372second # [ 8.418870] systemd-resolved[340]: Using system hostname 'second'.1373second # [ 8.430701] systemd[1]: Started Network Name Resolution.1374test # [ 8.439067] fuse: init (API version 7.45)1375test # [ 8.446394] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1376second # [ 8.448503] systemd[1]: Mounted /run/wrappers.1377second # [ 8.449744] systemd[1]: Reached target Local File Systems.1378second # [ 8.455954] systemd[1]: Listening on Boot Loader Control Service Socket.1379test # [ 8.464386] systemd[1]: Starting Remount Root and Kernel File Systems...1380second # [ 8.462250] systemd[1]: Starting register-nix-paths.service...1381second # [ 8.465333] systemd[1]: Starting Create SUID/SGID Wrappers...1382test # [ 8.468303] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1383second # [ 8.465927] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1384second # [ 8.470128] systemd[1]: Starting Save Transient machine-id to Disk...1385second # [ 8.481441] systemd[1]: Starting Create System Files and Directories...1386test # [ 8.488252] systemd[1]: Starting Coldplug All udev Devices...1387test # [ 8.492851] systemd-journald[332]: Collecting audit messages is enabled.1388test # [ 8.506983] systemd[1]: Listening on Journal Log Access Socket.1389test # [ 8.501628] systemd[1]: Queued start job for default target Multi-User System.1390test # [ 8.512338] systemd[1]: Started Journal Service.1391test # [ 8.506681] systemd[1]: systemd-journald.service: Deactivated successfully.1392test # [ 8.512697] systemd[1]: Mounted Huge Pages File System.1393test # [ 8.517077] systemd[1]: Mounted POSIX Message Queue File System.1394test # [ 8.517757] systemd[1]: Mounted Kernel Debug File System.1395test # [ 8.518359] systemd[1]: Mounted Kernel Trace File System.1396test # [ 8.518969] systemd[1]: Finished Create List of Static Device Nodes.1397test # [ 8.519650] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1398test # [ 8.535039] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1399test # [ 8.540549] systemd[1]: Mounted Kernel Configuration File System.1400test # [ 8.546569] systemd[1]: modprobe@fuse.service: Deactivated successfully.1401test # [ 8.549701] systemd[1]: Finished Load Kernel Module fuse.1402test # [ 8.555040] systemd[1]: Mounting FUSE Control File System...1403second # [ 8.564858] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1404test # [ 8.560840] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1405test # [ 8.563461] systemd-modules-load[333]: Module 'atkbd' is built in[ 8.576261] EXT4-fs (vda): re-mounted d28bfbaf-1919-4372-afdb-7c3e589f7f9a.1406test # 1407test # [ 8.570483] systemd-modules-load[333]: Module 'ctr' is built in1408test # [ 8.571042] systemd-modules-load[333]: Module 'loop' is built in1409second # [ 8.576825] systemd[1]: Finished Save Transient machine-id to Disk.1410second # [ 8.582129] systemd[1]: Started Rule-based Manager for Device Events and Files.1411test # [ 8.588295] systemd[1]: Finished Load Kernel Modules.1412test # [ 8.592863] systemd[1]: Finished Remount Root and Kernel File Systems.1413test # [ 8.596059] systemd[1]: Listening on Disk Image Download Service Socket.1414test # [ 8.606047] systemd[1]: Starting Firewall...1415test # [ 8.611367] systemd[1]: Starting Flush Journal to Persistent Storage...1416test # [ 8.618135] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1417test # [ 8.622758] systemd[1]: Starting Load/Save OS Random Seed...1418test # [ 8.630037] systemd-oomd[334]: No swap; memory pressure usage will be degraded1419test # [ 8.643974] systemd[1]: Starting Apply Kernel Variables...1420test # [ 8.645639] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1421test # [ 8.648943] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1422second # [ 8.674470] systemd[1]: Finished Create System Files and Directories.1423second # [ 8.689304] systemd[1]: Starting Rebuild Journal Catalog...1424second # [ 8.693336] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1425test # [ 8.710019] systemd[1]: Mounted FUSE Control File System.1426test # [ 8.728927] systemd-journald[332]: Received client request to flush runtime journal.1427test # [ 8.802828] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1428test # [ 8.806370] systemd[1]: Starting Create Static Device Nodes in /dev...1429test # [ 8.810387] systemd[1]: Finished Load/Save OS Random Seed.1430second # [ 8.817528] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1431test # [ 8.813559] systemd[1]: Reached target First Boot Complete.1432test # [ 8.817718] systemd[1]: Finished Flush Journal to Persistent Storage.1433test # [ 8.818415] systemd[1]: Finished Apply Kernel Variables.1434test # [ 8.821081] systemd[1]: Starting Network Name Resolution...1435second # [ 8.831019] systemd[1]: Finished Coldplug All udev Devices.1436test # [ 8.844650] systemd[1]: Finished Create Static Device Nodes in /dev.1437test # [ 8.845440] systemd[1]: Reached target Preparation for Local File Systems.1438test # [ 8.855402] systemd[1]: Starting Rule-based Manager for Device Events and Files...1439second # [ 8.863851] systemd[1]: Finished Rebuild Journal Catalog.1440second # [ 8.867504] systemd[1]: Starting Update is Completed...1441second # [ 8.935322] systemd[1]: Finished Update is Completed.1442test # [ 8.968672] systemd-resolved[366]: Positive Trust Anchors:1443test # [ 8.969681] systemd-resolved[366]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1444test # [ 8.974463] systemd-resolved[366]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161445test # [ 8.978444] systemd-resolved[366]: 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 test1446test # [ 9.002898] systemd-udevd[371]: Using default interface naming scheme 'v261'.1447second # [ 9.062176] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1448test # [ 9.193351] systemd[1]: Mounting /run/wrappers...1449test # [ 9.197347] systemd-resolved[366]: Using system hostname 'test'.1450test # [ 9.212825] systemd[1]: Started Network Name Resolution.1451test # [ 9.252410] systemd[1]: Mounted /run/wrappers.1452test # [ 9.253009] systemd[1]: Reached target Local File Systems.1453test # [ 9.256495] systemd[1]: Listening on Boot Loader Control Service Socket.1454test # [ 9.260519] systemd[1]: Starting register-nix-paths.service...1455test # [ 9.273944] systemd[1]: Starting Create SUID/SGID Wrappers...1456test # [ 9.276541] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1457test # [ 9.285651] systemd[1]: Starting Save Transient machine-id to Disk...1458test # [ 9.297260] systemd[1]: Starting Create System Files and Directories...1459test # [ 9.304959] systemd[1]: Started Rule-based Manager for Device Events and Files.1460second # [ 9.327494] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1461second # [ 9.330331] systemd[1]: Finished Create SUID/SGID Wrappers.1462second # [ 9.344572] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1463second # [ 9.386484] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1464test # [ 9.421923] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1465test # [ 9.438313] systemd[1]: Finished Save Transient machine-id to Disk.1466test # [ 9.487798] systemd[1]: Finished Create System Files and Directories.1467test # [ 9.500190] systemd[1]: Starting Rebuild Journal Catalog...1468test # [ 9.503668] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1469test # [ 9.612508] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1470test # [ 9.636825] systemd[1]: Finished Coldplug All udev Devices.1471second # [ 9.663624] (udev-worker)[455]: Network interface NamePolicy= disabled on kernel command line.1472test # [ 9.669075] systemd[1]: Finished Rebuild Journal Catalog.1473second # [ 9.676840] systemd[1]: Finished Firewall.1474second # [ 9.677956] systemd[1]: Reached target Preparation for Network.1475test # [ 9.675000] systemd[1]: Starting Update is Completed...1476second # [ 9.680262] systemd[1]: Listening on Network Management Resolve Hook Socket.1477second # [ 9.687902] systemd[1]: Starting Network Management...1478second # [ 9.701901] (udev-worker)[452]: Network interface NamePolicy= disabled on kernel command line.1479second # [ 9.704803] systemd[1]: Finished register-nix-paths.service.1480second # [ 9.707368] systemd[1]: Reached target System Initialization.1481second # [ 9.710038] systemd[1]: Started Discard unused filesystem blocks once a week.1482second # [ 9.713129] systemd[1]: Started Daily Cleanup of Temporary Directories.1483second # [ 9.715513] systemd[1]: Reached target Timer Units.1484second # [ 9.717855] systemd[1]: Listening on D-Bus System Message Bus Socket.1485second # [ 9.719806] systemd[1]: Listening on Nix Daemon Socket.1486second # [ 9.724692] systemd[1]: Listening on Authorization Manager Agent Helper.1487second # [ 9.727787] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1488second # [ 9.730321] systemd[1]: Reached target Socket Units.1489second # [ 9.733862] systemd[1]: Starting D-Bus System Message Bus...1490test # [ 9.734793] systemd[1]: Finished Update is Completed.1491test # [ 9.815406] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1492second # [ 9.918812] cfg80211: Loading compiled-in X.509 certificates for regulatory database1493second # [ 9.931438] mousedev: PS/2 mouse device common for all mice1494second # [ 9.938996] dbus-broker-launch[534]: Looking up NSS user entry for 'systemd-timesync'...1495second # [ 9.951542] dbus-broker-launch[534]: NSS returned no entry for 'systemd-timesync'1496second # [ 9.952734] dbus-broker-launch[534]: Invalid user-name in /nix/store/3kbz1c7kf55s2gymixbphi46vczkadln-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1497second # [ 9.964620] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1498second # [ 9.965134] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1499second # [ 10.013950] systemd-networkd[530]: /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.1500second # [ 10.016150] dbus-broker-launch[534]: 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'1501second # [ 10.019627] dbus-broker-launch[534]: 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'1502second # [ 10.027178] systemd-networkd[530]: /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.1503second # [ 10.037454] dbus-broker-launch[534]: 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'1504second # [ 10.049912] systemd-networkd[530]: lo: Link UP1505second # [ 10.050383] systemd-networkd[530]: lo: Gained carrier1506second # [ 10.050849] dbus-broker-launch[534]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/5cpm90flydbxw9km2kl7pk8i1i5sc3nk-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1507second # [ 10.058411] systemd[1]: Started Network Management.1508second # [ 10.062882] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1509second # [ 10.069935] systemd[1]: Started D-Bus System Message Bus.1510second # [ 10.072819] systemd[1]: Reached target Basic System.1511test # [ 10.070167] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1512second # [ 10.074825] systemd-networkd[530]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1513second # [ 10.084728] systemd-networkd[530]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1514second # [ 10.085482] systemd-networkd[530]: eth1: Link UP1515second # [ 10.085914] systemd-networkd[530]: eth1: Gained carrier1516second # [ 10.086371] systemd-networkd[530]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1517second # [ 10.087624] systemd[1]: Starting Network Manager Script Dispatcher Service...1518second # [ 10.100559] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1519second # [ 10.105822] systemd[1]: Starting Network Manager...1520second # [ 10.131494] systemd[1]: Started backdoor.service.1521second # [ 10.140064] dbus-broker-launch[534]: Ready1522test # [ 10.142186] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1523second # [ 10.154112] systemd[1]: Starting Import lastlog data into lastlog2 database...1524test # [ 10.165364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1525test # [ 10.166919] systemd[1]: Finished Create SUID/SGID Wrappers.1526second # [ 10.175767] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1527second # [ 10.190397] systemd[1]: Starting Post-Boot Actions...1528second # [ 10.212316] systemd[1]: Started Reset console on configuration changes.1529second # [ 10.258863] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[544]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1530second # [ 10.263375] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1531second # connecting to host...1532second # [ 10.311374] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1533second # [ 10.320696] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1534second # [ 10.362060] systemd[1]: Finished Post-Boot Actions.1535second # [ 10.410371] systemd[1]: Finished Import lastlog data into lastlog2 database.1536test # [ 10.431649] (udev-worker)[462]: Network interface NamePolicy= disabled on kernel command line.1537second # [ 10.442071] systemd[1]: Started Name Service Cache Daemon (nsncd).1538second # [ 10.448984] nsncd[549]: Sep 03 15:03:29.266 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1539second # [ 10.450381] systemd[1]: Reached target Host and Network Name Lookups.1540second # [ 10.450941] systemd[1]: Reached target User and Group Name Lookups.1541second # [ 10.457858] systemd[1]: Starting User Login Management...1542second # [ 10.461275] systemd[1]: Started Network Manager Script Dispatcher Service.1543test # [ 10.480642] (udev-worker)[464]: Network interface NamePolicy= disabled on kernel command line.1544test # [ 10.488093] systemd[1]: Finished register-nix-paths.service.1545test # [ 10.490398] systemd[1]: Reached target System Initialization.1546test # [ 10.492660] systemd[1]: Started Discard unused filesystem blocks once a week.1547test # [ 10.494717] systemd[1]: Started Daily Cleanup of Temporary Directories.1548test # [ 10.498949] systemd[1]: Reached target Timer Units.1549test # [ 10.501555] systemd[1]: Listening on D-Bus System Message Bus Socket.1550test # [ 10.505496] systemd[1]: Listening on Nix Daemon Socket.1551test # [ 10.506016] systemd[1]: Listening on Authorization Manager Agent Helper.1552test # [ 10.506600] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1553test # [ 10.507339] systemd[1]: Reached target Socket Units.1554test # [ 10.511323] systemd[1]: Starting D-Bus System Message Bus...1555test # [ 10.529308] systemd[1]: Finished Firewall.1556test # [ 10.531673] systemd[1]: Reached target Preparation for Network.1557test # [ 10.533398] systemd[1]: Listening on Network Management Resolve Hook Socket.1558test # [ 10.537174] systemd[1]: Starting Network Management...1559second # [ 10.546623] systemd[1]: Starting Hostname Service...1560second # [ 10.593315] systemd-logind[582]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1561second # [ 10.594343] systemd-logind[582]: Watching system buttons on /dev/input/event0 (gpio-keys)1562second # [ 10.594997] systemd-logind[582]: New seat seat0.1563second # [ 10.601834] systemd[1]: Started User Login Management.1564second # [ 10.606370] systemd[1]: Starting linger-users.service...1565test # [ 10.662312] mousedev: PS/2 mouse device common for all mice1566second # [ 10.680500] systemd[1]: linger-users.service: Deactivated successfully.1567second # [ 10.681667] systemd[1]: Finished linger-users.service.1568second # [ 10.690102] systemd[1]: Started Hostname Service.1569test # [ 10.704999] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...1570test # [ 10.732902] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'1571test # [ 10.734562] dbus-broker-launch[555]: Invalid user-name in /nix/store/3kbz1c7kf55s2gymixbphi46vczkadln-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1572test # [ 10.751462] cfg80211: Loading compiled-in X.509 certificates for regulatory database1573test # [ 10.786709] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1574test # [ 10.787212] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1575second # [ 10.792345] systemd-networkd[530]: eth0: Link UP1576second # [ 10.792841] systemd-networkd[530]: eth0: Gained carrier1577test # [ 10.794052] 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'1578test # [ 10.796478] 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'1579test # [ 10.800442] 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'1580second # [ 10.811176] systemd[1]: Started Network Manager.1581test # [ 10.805405] 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'1582second # [ 10.813684] systemd[1]: Reached target Network.1583test # [ 10.814280] systemd[1]: Started D-Bus System Message Bus.1584second # [ 10.818575] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1585test # [ 10.817196] systemd[1]: Reached target Basic System.1586second # [ 10.823226] systemd[1]: Starting Permit User Sessions...1587test # [ 10.820202] systemd[1]: Starting Network Manager Script Dispatcher Service...1588test # [ 10.828807] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1589test # [ 10.842633] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1590test # [ 10.867592] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1591test # [ 10.874506] systemd-networkd[558]: /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.1592test # [ 10.885926] systemd-networkd[558]: /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.1593test # [ 10.900107] systemd-networkd[558]: lo: Link UP1594test # [ 10.901699] systemd-networkd[558]: lo: Gained carrier1595test # [ 10.908471] systemd-networkd[558]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1596test # [ 10.914655] systemd-networkd[558]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1597test # [ 10.926029] dbus-broker-launch[555]: Ready1598test # [ 10.930889] systemd[1]: Starting Network Manager...1599test # [ 10.934108] systemd-networkd[558]: eth1: Link UP1600test # [ 10.937850] systemd-networkd[558]: eth1: Gained carrier1601test # [ 10.943977] systemd-networkd[558]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1602test # [ 10.954253] systemd[1]: Started backdoor.service.1603test # [ 10.970007] systemd[1]: Starting Import lastlog data into lastlog2 database...1604second # [ 10.979225] systemd[1]: Finished Permit User Sessions.1605test # [ 10.989707] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[567]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1606second # [ 10.995585] systemd[1]: Started Getty on tty1.1607second # [ 10.997933] systemd[1]: Reached target Login Prompts.1608test # [ 11.018057] r3qn2wrxq8bfm2mry46agf2zjadxngay-wifi-secrets[568]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1609second # [ 11.030124] systemd-resolved[340]: eth0: Bus client set default route setting: yes1610second # [ 11.035186] systemd-resolved[340]: eth0: Bus client set DNS server list to: 10.0.2.31611test # [ 11.032962] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1612test # [ 11.044589] kmrn99zb7hfffrbx2s86i3g3dg0y4036-wifi-secrets[569]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1613test # [ 11.063067] systemd[1]: Starting Post-Boot Actions...1614test # [ 11.089289] systemd[1]: Started Reset console on configuration changes.1615test # [ 11.114847] systemd[1]: Started Network Management.1616second # [ 11.119467] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1617test # [ 11.117496] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1618second # [ 11.125223] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1619second # [ 11.133305] systemd[1]: Reached target Multi-User System.1620second # [ 11.137000] systemd[1]: Startup finished in 753ms (kernel) + 4.507s (initrd) + 5.874s (userspace) = 11.135s.1621test # [ 11.127407] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1622test # [ 11.134837] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1623test # [ 11.142391] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1624test # [ 11.155254] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1625test # [ 11.162181] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1626test # connecting to host...1627test # [ 11.219705] systemd[1]: Finished Post-Boot Actions.1628second # [ 11.234031] systemd-networkd[530]: eth1: Gained IPv6LL1629test: Guest shell says: b'Spawning backdoor root shell...\n'1630test # [ 11.256338] systemd[1]: Started Name Service Cache Daemon (nsncd).1631test # [ 11.257108] nsncd[580]: Sep 03 15:03:30.090 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1632test: connected to guest root shell1633test: (connecting took 11.53 seconds)1634test: (finished: waiting for the VM to finish booting, in 11.53 seconds)1635test # [ 11.265710] systemd[1]: Started Network Manager Script Dispatcher Service.1636test # [ 11.267528] systemd[1]: Reached target Host and Network Name Lookups.1637test # [ 11.268304] systemd[1]: Reached target User and Group Name Lookups.1638test # [ 11.272758] systemd[1]: Starting User Login Management...1639test # [ 11.285594] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1640test # [ 11.303005] systemd[1]: Finished Import lastlog data into lastlog2 database.1641test # [ 11.379236] systemd[1]: Starting Hostname Service...1642test # [ 11.446831] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1643test # [ 11.468315] systemd-logind[615]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1644test # [ 11.471289] systemd-logind[615]: Watching system buttons on /dev/input/event0 (gpio-keys)1645test # [ 11.471969] systemd-logind[615]: New seat seat0.1646test # [ 11.480158] systemd[1]: Started User Login Management.1647test # [ 11.487199] systemd[1]: Starting linger-users.service...1648second # [ 11.531439] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31649test # [ 11.544972] systemd[1]: Started Hostname Service.1650test # [ 11.553518] systemd[1]: linger-users.service: Deactivated successfully.1651test # [ 11.555764] systemd[1]: Finished linger-users.service.1652test # [ 11.623299] systemd-networkd[558]: eth0: Link UP1653test # [ 11.623792] systemd-networkd[558]: eth0: Gained carrier1654test # [ 11.644140] systemd[1]: Started Network Manager.1655test # [ 11.645766] systemd[1]: Reached target Network.1656test # [ 11.653182] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1657test # [ 11.674970] systemd[1]: Starting Permit User Sessions...1658second # [ 11.776822] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1659test # [ 11.781886] systemd[1]: Finished Permit User Sessions.1660test # [ 11.800660] systemd[1]: Started Getty on tty1.1661test # [ 11.802310] systemd[1]: Reached target Login Prompts.1662second # [ 11.807191] systemd[1]: Starting Virtual Console Setup...1663second # [ 11.828338] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1664second # [ 11.832143] systemd[1]: Stopped Virtual Console Setup.1665second # [ 11.836414] systemd[1]: Starting Virtual Console Setup...1666second # [ 11.842438] systemd-logind[582]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1667test # [ 11.852635] systemd-resolved[366]: eth0: Bus client set default route setting: yes1668test # [ 11.857888] systemd-resolved[366]: eth0: Bus client set DNS server list to: 10.0.2.31669test # [ 11.871860] NetworkManager[570]: <warn> [1788447810.6979] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1670test # [ 11.882004] NetworkManager[570]: <warn> [1788447810.7004] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1671second # [ 11.905192] systemd-networkd[530]: eth0: Gained IPv6LL1672test # [ 11.920522] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1673test # [ 11.922739] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1674test # [ 11.936472] systemd[1]: Reached target Multi-User System.1675test # [ 11.936991] systemd[1]: Startup finished in 754ms (kernel) + 5.411s (initrd) + 5.770s (userspace) = 11.936s.1676second # [ 12.312895] systemd-vconsole-setup[643]: Configuration of first virtual console was skipped, ignoring remaining ones.1677second # [ 12.315707] systemd[1]: Finished Virtual Console Setup.1678test # [ 12.413063] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31679test: (finished: waiting for unit NetworkManager.service, in 12.77 seconds)1680test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1681test # [ 12.546422] systemd-networkd[558]: eth1: Gained IPv6LL1682test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1683test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1684test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.03 seconds)1685test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1686test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.03 seconds)1687(finished: run the VM test script, in 13.40 seconds)1688test script finished in 13.46s1689cleanup1690kill QemuMachine (pid 47)1691second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1692test # [ 12.746365] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1693test # [ 12.776460] systemd[1]: Starting Virtual Console Setup...1694test # [ 12.795581] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1695test # [ 12.796865] systemd[1]: Stopped Virtual Console Setup.1696test # [ 12.800136] systemd[1]: Starting Virtual Console Setup...1697test # [ 12.809806] systemd-logind[615]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1698kill QemuMachine (pid 48)1699test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1700(finished: cleanup, in 0.29 seconds)