vm-test-run-wifi
checks.aarch64-linux.wifi
· build #441
· 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 vm13second # Disk image does not exist, creating the virtualisation disk image...14second # Formatting '/build/vm-state-second/tmp.kSCopSQhoR', fmt=raw size=107374182415second # mke2fs 1.47.4 (6-Mar-2025)16second # Discarding device blocks: 0/262144 done17second # Creating filesystem with 262144 4k blocks and 65536 inodes18second # Filesystem UUID: 235ccac8-d358-4119-8253-4558ab49ee4a19second # Superblock backups stored on blocks:20second # 32768, 98304, 163840, 22937621second # 22second # Allocating group tables: 0/8 done23second # Writing inode tables: 0/8 done24second # Creating journal (8192 blocks): done25second # Writing superblocks and filesystem accounting information: 0/8 done26second # 27second # Virtualisation disk image created.28second: QEMU running (pid 47)29test # Disk image does not exist, creating the virtualisation disk image...30test: QEMU running (pid 48)31test # Formatting '/build/vm-state-test/tmp.bpI3MEbGda', fmt=raw size=107374182432test # mke2fs 1.47.4 (6-Mar-2025)33test # Discarding device blocks: 0/262144 done34test # Creating filesystem with 262144 4k blocks and 65536 inodes35test # Filesystem UUID: 13a5909b-75a1-46d8-91b8-51a5d8bc604136test # Superblock backups stored on blocks:37test # 32768, 98304, 163840, 22937638test # 39test # Allocating group tables: 0/8 done40test # Writing inode tables: 0/8 done41test # Creating journal (8192 blocks): done42test # Writing superblocks and filesystem accounting information: 0/8 done43test # 44test # Virtualisation disk image created.45(finished: start all VMs, in 0.44 seconds)46test: waiting for unit NetworkManager.service47test: waiting for the VM to finish booting48second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49second # [ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Aug 19 16:18:21 UTC 202650second # [ 0.000000] KASLR enabled51second # [ 0.000000] random: crng init done52second # [ 0.000000] Machine model: linux,dummy-virt53second # [ 0.000000] efi: UEFI not found.54second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT55second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]56second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]57second # [ 0.000000] Zone ranges:58second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]59second # [ 0.000000] DMA32 empty60second # [ 0.000000] Normal empty61second # [ 0.000000] Device empty62second # [ 0.000000] Movable zone start for each node63second # [ 0.000000] Early memory node ranges64second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]65second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]66second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000067second # [ 0.000000] psci: probing for conduit method from DT.68second # [ 0.000000] psci: PSCIv1.3 detected in firmware.69second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs70second # [ 0.000000] psci: Trusted OS migration not required71second # [ 0.000000] psci: SMC Calling Convention v1.172second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)73second # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u31129674second # [ 0.000000] Detected PIPT I-cache on CPU075second # [ 0.000000] CPU features: detected: GICv3 CPU interface76second # [ 0.000000] CPU features: detected: Spectre-v477second # [ 0.000000] CPU features: detected: Spectre-BHB78second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR79second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)80second # [ 0.000000] CPU features: detected: ARM erratum 141804081test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]82second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion83second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing84second # [ 0.000000] alternatives: applying boot alternatives85test # [ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Aug 19 16:18:21 UTC 202686test # [ 0.000000] KASLR enabled87test # [ 0.000000] random: crng init done88test # [ 0.000000] Machine model: linux,dummy-virt89test # [ 0.000000] efi: UEFI not found.90test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT91test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]92second # [ 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/dkdgmkd0q0n8qvg06lvb9n9bhvw9pz66-nixos-system-second-test/init regInfo=/nix/store/ihinz71gg5568ny8xw6vcx2r7phl4rms-closure-info/registration console=ttyAMA0,115200n8 console=tty093test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f]94test # [ 0.000000] Zone ranges:95test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]96test # [ 0.000000] DMA32 empty97second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ihinz71gg5568ny8xw6vcx2r7phl4rms-closure-info/registration", will be passed to user space.98test # [ 0.000000] Normal empty99test # [ 0.000000] Device empty100second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes101test # [ 0.000000] Movable zone start for each node102test # [ 0.000000] Early memory node ranges103second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)104test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]105second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)106test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]107second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB108test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000109second # [ 0.000000] software IO TLB: area num 1.110test # [ 0.000000] psci: probing for conduit method from DT.111second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)112test # [ 0.000000] psci: PSCIv1.3 detected in firmware.113second # [ 0.000000] Fallback order for Node 0: 0114test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs115second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144116test # [ 0.000000] psci: Trusted OS migration not required117second # [ 0.000000] Policy zone: DMA118test # [ 0.000000] psci: SMC Calling Convention v1.1119second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off120test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)121second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1122test # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296123second # [ 0.000000] allocated 2097152 bytes of page_ext124test # [ 0.000000] Detected PIPT I-cache on CPU0125second # [ 0.000000] ftrace: allocating 74881 entries in 294 pages126test # [ 0.000000] CPU features: detected: GICv3 CPU interface127second # [ 0.000000] ftrace: allocated 294 pages with 4 groups128second # [ 0.000000] rcu: Hierarchical RCU implementation.129test # [ 0.000000] CPU features: detected: Spectre-v4130second # [ 0.000000] rcu: RCU event tracing is enabled.131test # [ 0.000000] CPU features: detected: Spectre-BHB132test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR133second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.134test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)135second # [ 0.000000] Trampoline variant of Tasks RCU enabled.136second # [ 0.000000] Rude variant of Tasks RCU enabled.137test # [ 0.000000] CPU features: detected: ARM erratum 1418040138second # [ 0.000000] Tracing variant of Tasks RCU enabled.139second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.140test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion141test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing142second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1143test # [ 0.000000] alternatives: applying boot alternatives144second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.145second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.146second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.147test # [ 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/5c74aq96g7d42fbjn35xjzh0pl7djmcj-nixos-system-test-test/init regInfo=/nix/store/z3i2i3pf2ha4xfdlpkk7g4psbwsz74dw-closure-info/registration console=ttyAMA0,115200n8 console=tty0148second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0149test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/z3i2i3pf2ha4xfdlpkk7g4psbwsz74dw-closure-info/registration", will be passed to user space.150second # [ 0.000000] GICv3: 256 SPIs implemented151second # [ 0.000000] GICv3: 0 Extended SPIs implemented152second # [ 0.000000] Root IRQ handler: gic_handle_irq153second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI154second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0155second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000156test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes157test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)158test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)159test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB160test # [ 0.000000] software IO TLB: area num 1.161second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]162second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)163test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)164test # [ 0.000000] Fallback order for Node 0: 0165test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144166test # [ 0.000000] Policy zone: DMA167second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)168second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000169second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000170second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.171test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off172second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns173test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1174second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040175test # [ 0.000000] allocated 2097152 bytes of page_ext176test # [ 0.000000] ftrace: allocating 74881 entries in 294 pages177test # [ 0.000000] ftrace: allocated 294 pages with 4 groups178test # [ 0.000000] rcu: Hierarchical RCU implementation.179test # [ 0.000000] rcu: RCU event tracing is enabled.180second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).181second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns182second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns183second # [ 0.000078] arm-pv: using stolen time PV184test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.185test # [ 0.000000] Trampoline variant of Tasks RCU enabled.186second # [ 0.000656] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)187test # [ 0.000000] Rude variant of Tasks RCU enabled.188second # [ 0.001002] Console: colour dummy device 80x25189test # [ 0.000000] Tracing variant of Tasks RCU enabled.190second # [ 0.001015] printk: legacy console [tty0] enabled191second # [ 0.001250] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)192second # [ 0.001255] pid_max: default: 32768 minimum: 301193second # [ 0.001356] LSM: initializing lsm=capability,landlock,yama,bpf,ima194second # [ 0.001557] landlock: Up and running.195test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.196test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1197test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.198test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.199second # [ 0.001559] Yama: becoming mindful.200second # [ 0.002341] LSM support for eBPF active201test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.202second # [ 0.002530] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)203test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0204test # [ 0.000000] GICv3: 256 SPIs implemented205test # [ 0.000000] GICv3: 0 Extended SPIs implemented206test # [ 0.000000] Root IRQ handler: gic_handle_irq207test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI208test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0209second # [ 0.002548] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)210second # [ 0.004797] cacheinfo: Unable to detect cache hierarchy for CPU 0211second # [ 0.005544] rcu: Hierarchical SRCU implementation.212second # [ 0.005549] rcu: Max phase no-delay instances is 1000.213second # [ 0.006503] fsl-mc MSI: its@8080000 domain created214second # [ 0.006679] EFI services will not be available.215test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000216test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]217second # [ 0.006811] smp: Bringing up secondary CPUs ...218second # [ 0.006843] smp: Brought up 1 node, 1 CPU219test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)220second # [ 0.006846] SMP: Total of 1 processors activated.221second # [ 0.006848] CPU: All CPU(s) started at EL1222second # [ 0.006862] CPU features: detected: 32-bit EL0 Support223test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)224test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000225second # [ 0.006865] CPU features: detected: Data cache clean to the PoU not required for I/D coherence226test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000227second # [ 0.006868] CPU features: detected: Common not Private translations228second # [ 0.006870] CPU features: detected: CRC32 instructions229test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.230second # [ 0.006871] CPU features: detected: Data cache clean to Point of Persistence231test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns232second # [ 0.006874] CPU features: detected: Enhanced Virtualization Traps233test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040234second # [ 0.006885] CPU features: detected: RCpc load-acquire (LDAPR)235test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).236second # [ 0.006891] CPU features: detected: LSE atomic instructions237second # [ 0.006893] CPU features: detected: Privileged Access Never238second # [ 0.006895] CPU features: detected: PMUv3239test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns240second # [ 0.006896] CPU features: detected: RAS Extension Support241test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns242test # [ 0.000079] arm-pv: using stolen time PV243second # [ 0.006900] CPU features: detected: Speculative Store Bypassing Safe (SSBS)244second # [ 0.006934] alternatives: applying system-wide alternatives245test # [ 0.000579] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)246second # [ 0.008497] CPU features: detected: Hardware dirty bit management on CPU0247test # [ 0.000919] Console: colour dummy device 80x25248test # [ 0.000935] printk: legacy console [tty0] enabled249second # [ 0.008729] Memory: 891432K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115800K reserved, 32768K cma-reserved)250test # [ 0.001164] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)251second # [ 0.009261] devtmpfs: initialized252test # [ 0.001169] pid_max: default: 32768 minimum: 301253second # [ 0.010816] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)254test # [ 0.001275] LSM: initializing lsm=capability,landlock,yama,bpf,ima255test # [ 0.001605] landlock: Up and running.256second # [ 0.010837] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).257test # [ 0.001608] Yama: becoming mindful.258second # [ 0.010972] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL259test # [ 0.002436] LSM support for eBPF active260second # [ 0.010975] 0 pages in range for non-PLT usage261test # [ 0.002628] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)262second # [ 0.010976] 508288 pages in range for PLT usage263second # [ 0.011106] pinctrl core: initialized pinctrl subsystem264test # [ 0.002648] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)265second # [ 0.011955] DMI not present or invalid.266test # [ 0.004838] cacheinfo: Unable to detect cache hierarchy for CPU 0267second # [ 0.016280] NET: Registered PF_NETLINK/PF_ROUTE protocol family268test # [ 0.005573] rcu: Hierarchical SRCU implementation.269second # [ 0.018723] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations270test # [ 0.005579] rcu: Max phase no-delay instances is 1000.271test # [ 0.006572] fsl-mc MSI: its@8080000 domain created272second # [ 0.018867] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations273test # [ 0.006774] EFI services will not be available.274test # [ 0.006894] smp: Bringing up secondary CPUs ...275second # [ 0.019019] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations276test # [ 0.006940] smp: Brought up 1 node, 1 CPU277second # [ 0.019044] audit: initializing netlink subsys (disabled)278test # [ 0.006943] SMP: Total of 1 processors activated.279second # [ 0.019743] thermal_sys: Registered thermal governor 'fair_share'280test # [ 0.006945] CPU: All CPU(s) started at EL1281second # [ 0.019746] thermal_sys: Registered thermal governor 'bang_bang'282test # [ 0.006962] CPU features: detected: 32-bit EL0 Support283second # [ 0.019749] thermal_sys: Registered thermal governor 'step_wise'284test # [ 0.006965] CPU features: detected: Data cache clean to the PoU not required for I/D coherence285second # [ 0.019751] thermal_sys: Registered thermal governor 'user_space'286test # [ 0.006968] CPU features: detected: Common not Private translations287second # [ 0.019754] thermal_sys: Registered thermal governor 'power_allocator'288test # [ 0.006970] CPU features: detected: CRC32 instructions289second # [ 0.019780] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1290test # [ 0.006972] CPU features: detected: Data cache clean to Point of Persistence291second # [ 0.019799] cpuidle: using governor ladder292test # [ 0.006975] CPU features: detected: Enhanced Virtualization Traps293second # [ 0.019804] cpuidle: using governor menu294test # [ 0.006989] CPU features: detected: RCpc load-acquire (LDAPR)295second # [ 0.019954] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.296test # [ 0.006991] CPU features: detected: LSE atomic instructions297second # [ 0.019980] ASID allocator initialised with 32768 entries298test # [ 0.006993] CPU features: detected: Privileged Access Never299second # [ 0.020724] Serial: AMBA PL011 UART driver300test # [ 0.006995] CPU features: detected: PMUv3301test # [ 0.006996] CPU features: detected: RAS Extension Support302second # [ 0.023981] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1303second # [ 0.024144] printk: console [ttyAMA0] enabled304test # [ 0.007000] CPU features: detected: Speculative Store Bypassing Safe (SSBS)305test # [ 0.007035] alternatives: applying system-wide alternatives306test # [ 0.008527] CPU features: detected: Hardware dirty bit management on CPU0307test # [ 0.008798] Memory: 891440K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115796K reserved, 32768K cma-reserved)308test # [ 0.009330] devtmpfs: initialized309test # [ 0.010897] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)310test # [ 0.010920] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).311test # [ 0.011074] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL312test # [ 0.011078] 0 pages in range for non-PLT usage313test # [ 0.011079] 508288 pages in range for PLT usage314test # [ 0.011230] pinctrl core: initialized pinctrl subsystem315test # [ 0.012034] DMI not present or invalid.316test # [ 0.015879] NET: Registered PF_NETLINK/PF_ROUTE protocol family317test # [ 0.018231] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations318test # [ 0.018378] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations319test # [ 0.018531] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations320second # [ 0.099237] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages321test # [ 0.018553] audit: initializing netlink subsys (disabled)322second # [ 0.099262] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page323test # [ 0.019251] thermal_sys: Registered thermal governor 'fair_share'324second # [ 0.099269] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages325test # [ 0.019254] thermal_sys: Registered thermal governor 'bang_bang'326second # [ 0.099272] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page327test # [ 0.019257] thermal_sys: Registered thermal governor 'step_wise'328test # [ 0.019259] thermal_sys: Registered thermal governor 'user_space'329test # [ 0.019261] thermal_sys: Registered thermal governor 'power_allocator'330test # [ 0.019291] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1331test # [ 0.019305] cpuidle: using governor ladder332test # [ 0.019310] cpuidle: using governor menu333second # [ 0.099275] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages334second # [ 0.099278] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page335second # [ 0.099281] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages336second # [ 0.099284] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page337test # [ 0.019452] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.338test # [ 0.019477] ASID allocator initialised with 32768 entries339test # [ 0.020182] Serial: AMBA PL011 UART driver340second # [ 0.104449] fbcon: Taking over console341second # [ 0.104472] ACPI: Interpreter disabled.342second # [ 0.105767] iommu: Default domain type: Translated343second # [ 0.105780] iommu: DMA domain TLB invalidation policy: strict mode344test # [ 0.023512] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1345test # [ 0.023675] printk: console [ttyAMA0] enabled346second # [ 0.106967] SCSI subsystem initialized347second # [ 0.111643] usbcore: registered new interface driver usbfs348second # [ 0.111686] usbcore: registered new interface driver hub349second # [ 0.111697] usbcore: registered new device driver usb350second # [ 0.111917] pps_core: LinuxPPS API ver. 1 registered351second # [ 0.111924] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>352second # [ 0.111931] PTP clock support registered353second # [ 0.111959] EDAC MC: Ver: 3.0.0354second # [ 0.115001] scmi_core: SCMI protocol bus registered355second # [ 0.115783] FPGA manager framework356test # [ 0.101483] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages357test # [ 0.101510] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page358test # [ 0.101518] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages359test # [ 0.101521] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page360second # [ 0.117005] vgaarb: loaded361second # [ 0.117441] clocksource: Switched to clocksource arch_sys_counter362test # [ 0.101524] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages363test # [ 0.101527] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page364test # [ 0.101531] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages365test # [ 0.101533] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page366test # [ 0.106885] fbcon: Taking over console367test # [ 0.106911] ACPI: Interpreter disabled.368test # [ 0.108300] iommu: Default domain type: Translated369test # [ 0.108315] iommu: DMA domain TLB invalidation policy: strict mode370test # [ 0.109535] SCSI subsystem initialized371test # [ 0.110105] usbcore: registered new interface driver usbfs372test # [ 0.110150] usbcore: registered new interface driver hub373test # [ 0.110160] usbcore: registered new device driver usb374test # [ 0.110383] pps_core: LinuxPPS API ver. 1 registered375test # [ 0.110389] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>376test # [ 0.110396] PTP clock support registered377test # [ 0.110425] EDAC MC: Ver: 3.0.0378second # [ 0.126673] VFS: Disk quotas dquot_6.6.0379test # [ 0.113744] scmi_core: SCMI protocol bus registered380second # [ 0.126711] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)381second # [ 0.129039] netfs: FS-Cache loaded382test # [ 0.114568] FPGA manager framework383second # [ 0.129184] pnp: PnP ACPI: disabled384second # [ 0.131583] NET: Registered PF_INET protocol family385second # [ 0.131769] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)386test # [ 0.121331] vgaarb: loaded387test # [ 0.121818] clocksource: Switched to clocksource arch_sys_counter388test # [ 0.127163] VFS: Disk quotas dquot_6.6.0389test # [ 0.127206] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390test # [ 0.129607] netfs: FS-Cache loaded391test # [ 0.129743] pnp: PnP ACPI: disabled392test # [ 0.132249] NET: Registered PF_INET protocol family393test # [ 0.132460] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)394second # [ 0.156771] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)395second # [ 0.156804] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)396second # [ 0.156818] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)397second # [ 0.156859] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)398second # [ 0.156933] TCP: Hash tables configured (established 8192 bind 8192)399second # [ 0.157036] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)400second # [ 0.157068] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)401second # [ 0.157125] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)402second # [ 0.157304] NET: Registered PF_UNIX/PF_LOCAL protocol family403second # [ 0.157389] NET: Registered PF_XDP protocol family404test # [ 0.157433] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)405second # [ 0.157412] PCI: CLS 0 bytes, default 64406second # [ 0.157562] Trying to unpack rootfs image as initramfs...407test # [ 0.157466] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)408test # [ 0.157480] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.157520] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.157588] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.157688] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.157719] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.157773] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414second # [ 0.171721] kvm [1]: HYP mode not available415test # [ 0.162686] NET: Registered PF_UNIX/PF_LOCAL protocol family416test # [ 0.162739] NET: Registered PF_XDP protocol family417test # [ 0.162762] PCI: CLS 0 bytes, default 64418test # [ 0.162990] Trying to unpack rootfs image as initramfs...419test # [ 0.171455] kvm [1]: HYP mode not available420second # [ 0.237520] Initialise system trusted keyrings421second # [ 0.238041] workingset: timestamp_bits=42 max_order=18 bucket_order=0422second # [ 0.239037] squashfs: version 4.0 (2009/01/31) Phillip Lougher423second # [ 0.239564] 9p: Installing v9fs 9p2000 file system support424test # [ 0.242223] Initialise system trusted keyrings425test # [ 0.242767] workingset: timestamp_bits=42 max_order=18 bucket_order=0426test # [ 0.243816] squashfs: version 4.0 (2009/01/31) Phillip Lougher427test # [ 0.244358] 9p: Installing v9fs 9p2000 file system support428second # [ 0.262569] Key type asymmetric registered429second # [ 0.262606] Asymmetric key parser 'x509' registered430second # [ 0.262663] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)431second # [ 0.263997] io scheduler mq-deadline registered432second # [ 0.264011] io scheduler kyber registered433test # [ 0.263819] Key type asymmetric registered434test # [ 0.263851] Asymmetric key parser 'x509' registered435test # [ 0.263913] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)436second # [ 0.273635] pl061_gpio 9030000.pl061: PL061 GPIO chip registered437second # [ 0.273989] ledtrig-cpu: registered to indicate activity on CPUs438second # [ 0.274302] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:439second # [ 0.274324] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000440second # [ 0.274339] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000441test # [ 0.269972] io scheduler mq-deadline registered442test # [ 0.269996] io scheduler kyber registered443second # [ 0.274344] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000444second # [ 0.274386] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits445second # [ 0.274411] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]446second # [ 0.274485] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00447second # [ 0.274503] pci_bus 0000:00: root bus resource [bus 00-ff]448second # [ 0.274508] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]449test # [ 0.272998] pl061_gpio 9030000.pl061: PL061 GPIO chip registered450second # [ 0.274512] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]451test # [ 0.273786] ledtrig-cpu: registered to indicate activity on CPUs452second # [ 0.274516] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]453test # [ 0.274619] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:454second # [ 0.274636] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint455second # [ 0.275087] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint456second # [ 0.275222] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]457second # [ 0.275235] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]458second # [ 0.275255] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]459second # [ 0.275267] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]460second # [ 0.275594] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint461second # [ 0.275724] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]462second # [ 0.275736] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]463test # [ 0.274648] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000464test # [ 0.274663] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000465test # [ 0.274669] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000466test # [ 0.274708] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits467test # [ 0.274732] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]468test # [ 0.274809] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00469second # [ 0.275757] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]470test # [ 0.274838] pci_bus 0000:00: root bus resource [bus 00-ff]471second # [ 0.276075] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint472second # [ 0.276204] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]473second # [ 0.276216] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]474second # [ 0.276236] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475second # [ 0.276553] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint476second # [ 0.276681] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]477second # [ 0.276693] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]478second # [ 0.276714] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]479test # [ 0.274844] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]480test # [ 0.274848] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]481test # [ 0.274851] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]482test # [ 0.274974] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint483test # [ 0.275430] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint484test # [ 0.275566] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]485test # [ 0.275580] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]486test # [ 0.275602] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]487second # [ 0.277059] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint488second # [ 0.277191] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]489second # [ 0.277204] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]490second # [ 0.277225] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]491second # [ 0.277580] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint492second # [ 0.277711] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]493second # [ 0.277723] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]494second # [ 0.277744] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]495second # [ 0.278065] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint496second # [ 0.278198] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]497second # [ 0.278210] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]498second # [ 0.278234] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]499second # [ 0.278245] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]500second # [ 0.278626] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint501second # [ 0.278761] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]502test # [ 0.275613] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]503test # [ 0.275951] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint504test # [ 0.276085] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]505test # [ 0.276097] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]506test # [ 0.276118] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]507test # [ 0.276444] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint508test # [ 0.276578] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]509test # [ 0.276589] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]510test # [ 0.276611] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]511test # [ 0.276941] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint512test # [ 0.277073] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]513test # [ 0.277084] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]514test # [ 0.277106] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]515test # [ 0.277441] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint516test # [ 0.277576] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]517test # [ 0.277588] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]518second # [ 0.278784] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]519second # [ 0.279120] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint520second # [ 0.279257] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]521second # [ 0.279278] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]522second # [ 0.279555] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint523second # [ 0.279682] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]524second # [ 0.279882] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint525second # [ 0.280098] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]526test # [ 0.277609] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]527second # [ 0.280113] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]528second # [ 0.280133] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]529second # [ 0.280465] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint530second # [ 0.280596] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]531second # [ 0.280608] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]532second # [ 0.280629] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]533second # [ 0.281067] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned534second # [ 0.281079] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned535second # [ 0.281084] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned536second # [ 0.281120] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned537second # [ 0.281152] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned538second # [ 0.281186] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned539second # [ 0.281218] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned540second # [ 0.281251] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned541second # [ 0.281284] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned542second # [ 0.281317] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned543second # [ 0.281349] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned544test # [ 0.302100] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint545test # [ 0.302256] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]546second # [ 0.281381] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned547test # [ 0.302269] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]548test # [ 0.302291] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]549test # [ 0.302633] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint550test # [ 0.302769] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]551test # [ 0.302780] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]552test # [ 0.302807] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]553test # [ 0.302819] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]554test # [ 0.303213] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint555test # [ 0.303352] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]556test # [ 0.303374] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]557test # [ 0.303719] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint558test # [ 0.303856] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]559test # [ 0.303878] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560test # [ 0.304164] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint561second # [ 0.325527] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned562test # [ 0.304295] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]563second # [ 0.325608] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned564test # [ 0.304485] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint565second # [ 0.325624] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned566test # [ 0.304659] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]567second # [ 0.325640] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned568test # [ 0.304673] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]569second # [ 0.325656] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned570test # [ 0.304694] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]571test # [ 0.305067] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint572test # [ 0.305200] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]573test # [ 0.305211] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]574second # [ 0.325671] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned575second # [ 0.325687] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned576second # [ 0.325702] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned577second # [ 0.325718] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned578test # [ 0.305232] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]579test # [ 0.305673] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned580test # [ 0.305686] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned581test # [ 0.305692] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned582test # [ 0.305727] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned583test # [ 0.305760] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned584test # [ 0.305794] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned585second # [ 0.325733] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned586second # [ 0.325750] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned587second # [ 0.325765] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned588second # [ 0.325780] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned589second # [ 0.325794] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned590second # [ 0.325808] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned591second # [ 0.325822] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned592second # [ 0.325837] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned593second # [ 0.325858] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned594second # [ 0.325872] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned595second # [ 0.325886] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned596second # [ 0.325900] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned597second # [ 0.325914] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned598second # [ 0.325937] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]599second # [ 0.325942] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]600second # [ 0.325946] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]601second # [ 0.326748] pci 0000:00:0a.0: enabling device (0000 -> 0002)602test # [ 0.325922] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned603test # [ 0.325973] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned604test # [ 0.326010] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned605test # [ 0.326047] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned606test # [ 0.326081] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned607test # [ 0.326114] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned608test # [ 0.326186] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned609test # [ 0.326277] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned610test # [ 0.326294] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned611test # [ 0.326310] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned612test # [ 0.326325] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned613test # [ 0.326340] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned614test # [ 0.326354] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned615test # [ 0.326369] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned616test # [ 0.326382] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned617test # [ 0.326397] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned618test # [ 0.326411] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned619test # [ 0.326426] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned620test # [ 0.326441] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned621test # [ 0.326455] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned622test # [ 0.326468] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned623test # [ 0.326482] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned624test # [ 0.326496] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned625test # [ 0.326516] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned626test # [ 0.326530] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned627test # [ 0.326543] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned628test # [ 0.326557] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned629test # [ 0.326571] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned630test # [ 0.326593] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]631test # [ 0.326599] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]632test # [ 0.326603] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]633test # [ 0.327443] pci 0000:00:0a.0: enabling device (0000 -> 0002)634second # [ 0.353917] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)635second # [ 0.355882] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)636second # [ 0.357763] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)637second # [ 0.359739] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)638test # [ 0.358678] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)639second # [ 0.369666] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)640second # [ 0.371532] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)641second # [ 0.373360] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)642test # [ 0.360636] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)643second # [ 0.383363] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)644second # [ 0.385303] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)645second # [ 0.387975] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)646test # [ 0.370352] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)647test # [ 0.372383] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)648test # [ 0.374305] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)649test # [ 0.376230] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)650second # [ 0.394426] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)651test # [ 0.386048] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)652test # [ 0.388045] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)653second # [ 0.410219] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled654second # [ 0.411864] msm_serial: driver initialized655second # [ 0.411959] SuperH (H)SCI(F) driver initialized656second # [ 0.411994] STM32 USART driver initialized657test # [ 0.398018] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)658test # [ 0.399802] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)659test # [ 0.401861] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)660test # [ 0.410563] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled661test # [ 0.412191] msm_serial: driver initialized662test # [ 0.412306] SuperH (H)SCI(F) driver initialized663test # [ 0.412344] STM32 USART driver initialized664second # [ 0.430843] loop: module loaded665second # [ 0.430988] virtio_blk virtio5: 1/0/0 default/read/poll queues666second # [ 0.431528] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)667second # [ 0.441870] megasas: 07.734.00.00-rc1668second # [ 0.442331] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]669second # [ 0.444460] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000670second # [ 0.444514] Intel/Sharp Extended Query Table at 0x0031671test # [ 0.435756] loop: module loaded672test # [ 0.435921] virtio_blk virtio5: 1/0/0 default/read/poll queues673test # [ 0.436508] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)674second # [ 0.454011] Using buffer write method675second # [ 0.454099] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]676second # [ 0.457103] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000677test # [ 0.442268] megasas: 07.734.00.00-rc1678second # [ 0.457131] Intel/Sharp Extended Query Table at 0x0031679second # [ 0.458597] Using buffer write method680test # [ 0.442810] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]681second # [ 0.458618] Concatenating MTD devices:682second # [ 0.458622] (0): "0.flash"683second # [ 0.458625] (1): "0.flash"684test # [ 0.444986] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000685second # [ 0.458627] into device "0.flash"686test # [ 0.445043] Intel/Sharp Extended Query Table at 0x0031687test # [ 0.454417] Using buffer write method688test # [ 0.454492] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689test # [ 0.456682] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690test # [ 0.456708] Intel/Sharp Extended Query Table at 0x0031691test # [ 0.466326] Using buffer write method692test # [ 0.466360] Concatenating MTD devices:693test # [ 0.466363] (0): "0.flash"694test # [ 0.466366] (1): "0.flash"695test # [ 0.466369] into device "0.flash"696second # [ 0.692567] Freeing initrd memory: 26996K697second # [ 0.699707] tun: Universal TUN/TAP device driver, 1.6698second # [ 0.702556] thunder_xcv, ver 1.0699second # [ 0.702591] thunder_bgx, ver 1.0700second # [ 0.702604] nicpf, ver 1.0701second # [ 0.702914] e1000: Intel(R) PRO/1000 Network Driver702second # [ 0.702922] e1000: Copyright (c) 1999-2006 Intel Corporation.703second # [ 0.702940] e1000e: Intel(R) PRO/1000 Network Driver704second # [ 0.702947] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.705second # [ 0.702959] igb: Intel(R) Gigabit Ethernet Network Driver706second # [ 0.702962] igb: Copyright (c) 2007-2014 Intel Corporation.707second # [ 0.702974] igbvf: Intel(R) Gigabit Virtual Function Network Driver708second # [ 0.702977] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.709second # [ 0.703039] sky2: driver version 1.30710test # [ 0.695715] Freeing initrd memory: 26992K711second # [ 0.703827] usbcore: registered new interface driver usb-storage712second # [ 0.703950] usbcore: registered new interface driver usbserial_generic713second # [ 0.703971] usbserial: USB Serial support registered for generic714second # [ 0.704255] hv_vmbus: registering driver hyperv_keyboard715second # [ 0.705272] ehci-pci 0000:00:0a.0: EHCI Host Controller716second # [ 0.705308] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1717second # [ 0.705571] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000718second # [ 0.713395] rtc-pl031 9010000.pl031: registered as rtc0719second # [ 0.713482] rtc-pl031 9010000.pl031: setting system clock to 2026-08-20T05:08:13 UTC (1787202493)720second # [ 0.713706] i2c_dev: i2c /dev entries driver721test # [ 0.702808] tun: Universal TUN/TAP device driver, 1.6722second # [ 0.716559] sdhci: Secure Digital Host Controller Interface driver723second # [ 0.716578] sdhci: Copyright(c) Pierre Ossman724second # [ 0.716710] Synopsys Designware Multimedia Card Interface Driver725second # [ 0.716889] sdhci-pltfm: SDHCI platform and OF driver helper726second # [ 0.717497] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00727test # [ 0.705590] thunder_xcv, ver 1.0728test # [ 0.705628] thunder_bgx, ver 1.0729test # [ 0.705647] nicpf, ver 1.0730second # [ 0.720096] hid: raw HID events driver (C) Jiri Kosina731second # [ 0.720301] usbcore: registered new interface driver usbhid732second # [ 0.720306] usbhid: USB HID core driver733second # [ 0.721242] hub 1-0:1.0: USB hub found734second # [ 0.721317] hub 1-0:1.0: 6 ports detected735test # [ 0.706767] e1000: Intel(R) PRO/1000 Network Driver736test # [ 0.706782] e1000: Copyright (c) 1999-2006 Intel Corporation.737test # [ 0.706801] e1000e: Intel(R) PRO/1000 Network Driver738second # [ 0.723360] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available739test # [ 0.706809] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.740test # [ 0.706834] igb: Intel(R) Gigabit Ethernet Network Driver741second # [ 0.724186] drop_monitor: Initializing network drop monitor service742test # [ 0.706838] igb: Copyright (c) 2007-2014 Intel Corporation.743second # [ 0.724299] NET: Registered PF_INET6 protocol family744test # [ 0.706849] igbvf: Intel(R) Gigabit Virtual Function Network Driver745test # [ 0.706853] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.746second # [ 0.726737] Segment Routing with IPv6747test # [ 0.706923] sky2: driver version 1.30748second # [ 0.726766] In-situ OAM (IOAM) with IPv6749test # [ 0.707779] usbcore: registered new interface driver usb-storage750second # [ 0.726822] NET: Registered PF_PACKET protocol family751test # [ 0.707901] usbcore: registered new interface driver usbserial_generic752test # [ 0.707923] usbserial: USB Serial support registered for generic753test # [ 0.708220] hv_vmbus: registering driver hyperv_keyboard754test # [ 0.709227] ehci-pci 0000:00:0a.0: EHCI Host Controller755second # [ 0.727898] 9pnet: Installing 9P2000 support756test # [ 0.709263] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1757test # [ 0.709436] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000758test # [ 0.716725] rtc-pl031 9010000.pl031: registered as rtc0759test # [ 0.716787] rtc-pl031 9010000.pl031: setting system clock to 2026-08-20T05:08:13 UTC (1787202493)760second # [ 0.729852] Key type dns_resolver registered761test # [ 0.717010] i2c_dev: i2c /dev entries driver762second # [ 0.733100] registered taskstats version 1763second # [ 0.733290] Loading compiled-in X.509 certificates764test # [ 0.719036] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00765test # [ 0.719463] hub 1-0:1.0: USB hub found766test # [ 0.719492] hub 1-0:1.0: 6 ports detected767test # [ 0.721793] sdhci: Secure Digital Host Controller Interface driver768test # [ 0.721811] sdhci: Copyright(c) Pierre Ossman769test # [ 0.722845] Synopsys Designware Multimedia Card Interface Driver770second # [ 0.738752] Demotion targets for Node 0: null771test # [ 0.723032] sdhci-pltfm: SDHCI platform and OF driver helper772second # [ 0.738843] Key type .fscrypt registered773test # [ 0.724001] hid: raw HID events driver (C) Jiri Kosina774second # [ 0.738849] Key type fscrypt-provisioning registered775test # [ 0.724148] usbcore: registered new interface driver usbhid776second # [ 0.738961] ima: No TPM chip found, activating TPM-bypass!777test # [ 0.724153] usbhid: USB HID core driver778second # [ 0.738975] ima: Allocated hash algorithm: sha1779second # [ 0.739032] ima: No architecture policies found780second # [ 0.741788] input: gpio-keys as /devices/platform/gpio-keys/input/input0781test # [ 0.726902] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available782test # [ 0.727709] drop_monitor: Initializing network drop monitor service783test # [ 0.727892] NET: Registered PF_INET6 protocol family784test # [ 0.730241] Segment Routing with IPv6785test # [ 0.730269] In-situ OAM (IOAM) with IPv6786test # [ 0.730332] NET: Registered PF_PACKET protocol family787test # [ 0.731440] 9pnet: Installing 9P2000 support788test # [ 0.733268] Key type dns_resolver registered789test # [ 0.736951] registered taskstats version 1790test # [ 0.737116] Loading compiled-in X.509 certificates791second # [ 0.752918] clk: Disabling unused clocks792second # [ 0.752945] PM: genpd: Disabling unused power domains793second # [ 0.756227] Freeing unused kernel memory: 4736K794second # [ 0.756331] Run /init as init process795test # [ 0.742799] Demotion targets for Node 0: null796test # [ 0.742946] Key type .fscrypt registered797test # [ 0.742954] Key type fscrypt-provisioning registered798test # [ 0.743081] ima: No TPM chip found, activating TPM-bypass!799test # [ 0.743095] ima: Allocated hash algorithm: sha1800test # [ 0.743153] ima: No architecture policies found801test # [ 0.746275] input: gpio-keys as /devices/platform/gpio-keys/input/input0802test # [ 0.756824] clk: Disabling unused clocks803test # [ 0.756852] PM: genpd: Disabling unused power domains804test # [ 0.760120] Freeing unused kernel memory: 4736K805test # [ 0.760229] Run /init as init process806second # [ 0.776488] systemd[1]: Successfully made /usr/ read-only.807test # [ 0.780537] systemd[1]: Successfully made /usr/ read-only.808second # [ 0.969479] usb 1-1: new high-speed USB device number 2 using ehci-pci809test # [ 0.965862] usb 1-1: new high-speed USB device number 2 using ehci-pci810second # [ 1.111295] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)811second # [ 1.115126] systemd[1]: Detected virtualization qemu.812second # [ 1.115991] systemd[1]: Detected architecture arm64.813second # [ 1.116587] systemd[1]: Running in initrd.814second # [ 1.117762] systemd[1]: Initializing machine ID from random generator.815second # [ 1.119079] systemd[1]: Hostname set to <second>.816second # [ 1.122959] 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/input1817test # [ 1.113206] 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/input1818test # [ 1.115245] systemd[1]: systemd 261.1 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)819test # [ 1.115272] systemd[1]: Detected virtualization qemu.820test # [ 1.115303] systemd[1]: Detected architecture arm64.821test # [ 1.115311] systemd[1]: Running in initrd.822test # [ 1.115867] systemd[1]: Initializing machine ID from random generator.823test # [ 1.116081] systemd[1]: Hostname set to <test>.824second # [ 1.197582] 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.190008] 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.317472] usb 1-2: new high-speed USB device number 3 using ehci-pci827test # [ 1.309861] usb 1-2: new high-speed USB device number 3 using ehci-pci828second # [ 1.344785] systemd[1]: bpf-restrict-fs: LSM BPF program attached829test # [ 1.347363] systemd[1]: bpf-restrict-fs: LSM BPF program attached830second # [ 1.403256] systemd[1]: Queued start job for default target Initrd Default Target.831second # [ 1.411388] systemd[1]: Created slice Slice /system/modprobe.832second # [ 1.412155] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.833second # [ 1.412844] systemd[1]: Expecting device /dev/disk/by-label/nixos...834second # [ 1.413427] systemd[1]: Reached target Path Units.835second # [ 1.413891] systemd[1]: Reached target Slice Units.836second # [ 1.414319] systemd[1]: Reached target Swaps.837second # [ 1.414699] systemd[1]: Reached target Timer Units.838second # [ 1.415344] systemd[1]: Listening on D-Bus System Message Bus Socket.839second # [ 1.416073] systemd[1]: Listening on Journal Socket (/dev/log).840second # [ 1.416701] systemd[1]: Listening on Journal Sockets.841second # [ 1.417260] systemd[1]: Listening on udev Control Socket.842second # [ 1.417933] systemd[1]: Listening on udev Kernel Socket.843second # [ 1.418418] systemd[1]: Reached target Socket Units.844second # [ 1.420220] systemd[1]: Starting Create List of Static Device Nodes...845test # [ 1.410393] systemd[1]: Queued start job for default target Initrd Default Target.846second # [ 1.426062] systemd[1]: Starting Load Kernel Module 9pnet_virtio...847second # [ 1.426702] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs848second # [ 1.433647] systemd[1]: Mounting Kernel Configuration File System...849test # [ 1.420060] systemd[1]: Created slice Slice /system/modprobe.850test # [ 1.421069] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.851test # [ 1.421980] systemd[1]: Expecting device /dev/disk/by-label/nixos...852test # [ 1.422708] systemd[1]: Reached target Path Units.853test # [ 1.423153] systemd[1]: Reached target Slice Units.854test # [ 1.423612] systemd[1]: Reached target Swaps.855test # [ 1.424003] systemd[1]: Reached target Timer Units.856test # [ 1.424723] systemd[1]: Listening on D-Bus System Message Bus Socket.857test # [ 1.425502] systemd[1]: Listening on Journal Socket (/dev/log).858test # [ 1.426274] systemd[1]: Listening on Journal Sockets.859test # [ 1.426920] systemd[1]: Listening on udev Control Socket.860test # [ 1.427544] systemd[1]: Listening on udev Kernel Socket.861test # [ 1.428045] systemd[1]: Reached target Socket Units.862test # [ 1.429788] systemd[1]: Starting Create List of Static Device Nodes...863second # [ 1.447163] systemd[1]: Starting Journal Service...864test # [ 1.438013] systemd[1]: Starting Load Kernel Module 9pnet_virtio...865test # [ 1.438753] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs866second # [ 1.454269] systemd[1]: Starting Load Kernel Modules...867second # [ 1.454847] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os868test # [ 1.446041] systemd[1]: Mounting Kernel Configuration File System...869second # [ 1.471593] systemd[1]: Starting Coldplug All udev Devices...870second # [ 1.472542] 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/input2871second # [ 1.473874] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0872test # [ 1.462073] systemd[1]: Starting Journal Service...873second # [ 1.482848] systemd[1]: Finished Create List of Static Device Nodes.874second # [ 1.486706] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.875test # [ 1.473140] systemd[1]: Starting Load Kernel Modules...876test # [ 1.474081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os877second # [ 1.489941] systemd[1]: Finished Load Kernel Module 9pnet_virtio.878test # [ 1.476578] 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/input2879test # [ 1.477761] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0880second # [ 1.494153] systemd[1]: Mounted Kernel Configuration File System.881second # [ 1.501980] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...882test # [ 1.487458] systemd[1]: Starting Coldplug All udev Devices...883test # [ 1.506011] systemd[1]: Finished Create List of Static Device Nodes.884test # [ 1.507310] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.885test # [ 1.507545] systemd[1]: Finished Load Kernel Module 9pnet_virtio.886test # [ 1.507798] systemd[1]: Mounted Kernel Configuration File System.887second # [ 1.529201] systemd-journald[73]: Collecting audit messages is disabled.888test # [ 1.518674] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...889second # [ 1.539354] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.890second # [ 1.553605] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev891second # [ 1.561432] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0892second # [ 1.561699] [drm] features: -virgl +edid -resource_blob -host_visible893second # [ 1.561704] [drm] features: -context_init894second # [ 1.562208] [drm] number of scanouts: 1895second # [ 1.562224] [drm] number of cap sets: 0896second # [ 1.564990] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.897test # [ 1.554143] systemd-journald[73]: Collecting audit messages is disabled.898second # [ 1.573971] systemd[1]: Starting Create Static Device Nodes in /dev...899test # [ 1.564920] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.900test # [ 1.566792] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.901test # [ 1.568862] systemd[1]: Starting Create Static Device Nodes in /dev...902second # [ 1.586355] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic903second # [ 1.586380] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0904test # [ 1.582261] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev905test # [ 1.588211] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0906test # [ 1.588499] [drm] features: -virgl +edid -resource_blob -host_visible907test # [ 1.588506] [drm] features: -context_init908test # [ 1.589111] [drm] number of scanouts: 1909test # [ 1.589133] [drm] number of cap sets: 0910second # [ 1.611170] Console: switching to colour frame buffer device 160x50911second # [ 1.621997] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device912second # [ 1.628116] systemd[1]: Started Journal Service.913second # [ 1.627345] systemd-modules-load[74]: Inserted module 'dm_mod'914test # [ 1.618202] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic915second # [ 1.628308] systemd-modules-load[74]: Module 'virtio_balloon' is built in916test # [ 1.618222] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0917second # [ 1.629787] systemd-modules-load[74]: Module 'virtio_console' is built in918test # [ 1.626338] systemd[1]: Finished Create Static Device Nodes in /dev.919test # [ 1.626697] systemd[1]: Reached target Preparation for Local File Systems.920test # [ 1.626740] systemd[1]: Reached target Local File Systems.921test # [ 1.629491] systemd[1]: Starting Rule-based Manager for Device Events and Files...922second # [ 1.636389] systemd-modules-load[74]: Inserted module 'virtio_gpu'923second # [ 1.637106] systemd-modules-load[74]: Module 'virtio_rng' is built in924second # [ 1.637822] systemd[1]: Finished Load Kernel Modules.925second # [ 1.639260] systemd[1]: Starting Apply Kernel Variables...926second # [ 1.639927] systemd[1]: Finished Create Static Device Nodes in /dev.927second # [ 1.649789] systemd[1]: Reached target Preparation for Local File Systems.928test # [ 1.642212] Console: switching to colour frame buffer device 160x50929second # [ 1.650465] systemd[1]: Reached target Local File Systems.930test # [ 1.645253] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device931test # [ 1.654175] systemd[1]: Started Journal Service.932test # [ 1.650422] systemd-modules-load[74]: Inserted module 'dm_mod'933test # [ 1.651259] systemd-modules-load[74]: Module 'virtio_balloon' is built in934second # [ 1.661953] systemd[1]: Starting Create System Files and Directories...935test # [ 1.652127] systemd-modules-load[74]: Module 'virtio_console' is built in936test # [ 1.652903] systemd-modules-load[74]: Inserted module 'virtio_gpu'937second # [ 1.672626] systemd[1]: Starting Rule-based Manager for Device Events and Files...938test # [ 1.664297] systemd-modules-load[74]: Module 'virtio_rng' is built in939test # [ 1.665144] systemd[1]: Starting Create System Files and Directories...940test # [ 1.668242] systemd[1]: Finished Load Kernel Modules.941second # [ 1.680915] systemd[1]: Finished Apply Kernel Variables.942second # [ 1.704897] systemd[1]: Finished Create System Files and Directories.943test # [ 1.696158] systemd[1]: Starting Apply Kernel Variables...944test # [ 1.712839] systemd[1]: Finished Create System Files and Directories.945second # [ 1.729987] systemd-udevd[88]: Using default interface naming scheme 'v261'.946test # [ 1.719950] systemd-udevd[79]: Using default interface naming scheme 'v261'.947test # [ 1.724317] systemd[1]: Finished Apply Kernel Variables.948second # [ 1.752679] systemd[1]: Started Rule-based Manager for Device Events and Files.949test # [ 1.745142] systemd[1]: Started Rule-based Manager for Device Events and Files.950test # [ 1.805178] systemd[1]: Starting Virtual Console Setup...951second # [ 1.816142] systemd[1]: Starting Virtual Console Setup...952second # [ 1.860404] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.953second # [ 1.862886] systemd[1]: Finished Virtual Console Setup.954test # [ 1.856457] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.955test # [ 1.859075] systemd[1]: Finished Virtual Console Setup.956second # [ 2.054705] systemd[1]: Finished Coldplug All udev Devices.957second # [ 2.055303] systemd[1]: Reached target System Initialization.958second # [ 2.055841] systemd[1]: Reached target Basic System.959test # [ 2.074145] systemd[1]: Finished Coldplug All udev Devices.960test # [ 2.074743] systemd[1]: Reached target System Initialization.961test # [ 2.075249] systemd[1]: Reached target Basic System.962second # [ 2.156160] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.963second # [ 2.172242] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.964test # [ 2.191870] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.965test # [ 2.196295] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.966second # [ 2.255282] systemd[1]: Found device /dev/disk/by-label/nixos.967second # [ 2.258910] systemd[1]: Reached target Initrd Root Device.968second # [ 2.261470] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969test # [ 2.275375] systemd[1]: Found device /dev/disk/by-label/nixos.970test # [ 2.276166] systemd[1]: Reached target Initrd Root Device.971test # [ 2.280352] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...972second # [ 2.307266] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks973second # [ 2.312285] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.974test # [ 2.326980] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks975test # [ 2.331217] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.976second # [ 2.475345] systemd[1]: Mounting /sysroot...977second # [ 2.513001] EXT4-fs (vda): mounted filesystem 235ccac8-d358-4119-8253-4558ab49ee4a r/w with ordered data mode. Quota mode: none.978test # [ 2.494591] systemd[1]: Mounting /sysroot...979second # [ 2.510786] systemd[1]: Mounted /sysroot.980second # [ 2.511512] systemd[1]: Reached target Initrd Root File System.981second # [ 2.513127] systemd[1]: Starting Mountpoints Configured in the Real Root...982test # [ 2.527986] EXT4-fs (vda): mounted filesystem 13a5909b-75a1-46d8-91b8-51a5d8bc6041 r/w with ordered data mode. Quota mode: none.983second # [ 2.535072] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.984test # [ 2.528585] systemd[1]: Mounted /sysroot.985test # [ 2.529683] systemd[1]: Reached target Initrd Root File System.986second # [ 2.541169] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...987test # [ 2.533745] systemd[1]: Starting Mountpoints Configured in the Real Root...988second # [ 2.544123] systemd[1]: Reloading...989test # [ 2.555671] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.990test # [ 2.562574] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...991test # [ 2.566261] systemd[1]: Reloading...992second # [ 2.717119] systemd[1]: Reloading finished in 173 ms.993second # [ 2.743810] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...994second # [ 2.746545] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...995second # [ 2.749311] systemd[1]: initrd-parse-etc.service: Deactivated successfully.996test # [ 2.741440] systemd[1]: Reloading finished in 175 ms.997second # [ 2.752756] systemd[1]: Finished Mountpoints Configured in the Real Root.998second # [ 2.753396] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.999second # [ 2.757900] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1000test # [ 2.761266] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1001test # [ 2.764230] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1002test # [ 2.768206] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1003second # [ 2.778705] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1004second # [ 2.779434] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1005test # [ 2.769386] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1006test # [ 2.773566] systemd[1]: Finished Mountpoints Configured in the Real Root.1007test # [ 2.774723] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1008test # [ 2.794666] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1009test # [ 2.795727] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1010second # [ 3.054204] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory1011second # [ 3.057961] (udev-worker)[99]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1012second # [ 3.066845] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1013second # [ 3.068165] systemd[1]: Stopped Virtual Console Setup.1014second # [ 3.069503] systemd[1]: Stopping Virtual Console Setup...1015second # [ 3.071346] systemd[1]: Starting Virtual Console Setup...1016second # [ 3.099478] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones.1017second # [ 3.101994] systemd[1]: Finished Virtual Console Setup.1018test # [ 3.093848] (udev-worker)[100]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory1019test # [ 3.098215] (udev-worker)[100]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1020test # [ 3.111307] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1021test # [ 3.112357] systemd[1]: Stopped Virtual Console Setup.1022test # [ 3.113781] systemd[1]: Stopping Virtual Console Setup...1023test # [ 3.116362] systemd[1]: Starting Virtual Console Setup...1024test # [ 3.139584] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones.1025test # [ 3.142257] systemd[1]: Finished Virtual Console Setup.1026second # [ 3.477043] systemd[1]: Mounting /sysroot/nix/.ro-store...1027second # [ 3.484207] systemd[1]: Mounting /sysroot/nix/.rw-store...1028second # [ 3.492202] systemd[1]: Mounting /sysroot/run...1029second # [ 3.496179] systemd[1]: Mounting /sysroot/tmp/shared...1030test # [ 3.497622] systemd[1]: Mounting /sysroot/nix/.ro-store...1031test # [ 3.505448] systemd[1]: Mounting /sysroot/nix/.rw-store...1032second # [ 3.517589] systemd[1]: Mounting /sysroot/tmp/xchg...1033test # [ 3.520201] systemd[1]: Mounting /sysroot/run...1034second # [ 3.531834] systemd[1]: Mounted /sysroot/nix/.rw-store.1035test # [ 3.526599] systemd[1]: Mounting /sysroot/tmp/shared...1036second # [ 3.544559] systemd[1]: Starting rw-sysroot-nix-store.service...1037second # [ 3.550518] systemd[1]: Mounted /sysroot/nix/.ro-store.1038test # [ 3.540217] systemd[1]: Mounting /sysroot/tmp/xchg...1039second # [ 3.551273] systemd[1]: Mounted /sysroot/run.1040second # [ 3.551935] systemd[1]: Mounted /sysroot/tmp/shared.1041second # [ 3.559982] systemd[1]: Mounted /sysroot/tmp/xchg.1042test # [ 3.561276] systemd[1]: Mounted /sysroot/nix/.rw-store.1043second # [ 3.574484] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1044second # [ 3.575667] systemd[1]: Finished rw-sysroot-nix-store.service.1045test # [ 3.567424] systemd[1]: Mounted /sysroot/nix/.ro-store.1046second # [ 3.578285] systemd[1]: Mounting /sysroot/nix/store...1047test # [ 3.580274] systemd[1]: Mounted /sysroot/run.1048test # [ 3.582331] systemd[1]: Mounted /sysroot/tmp/shared.1049test # [ 3.582887] systemd[1]: Mounted /sysroot/tmp/xchg.1050test # [ 3.588140] systemd[1]: Starting rw-sysroot-nix-store.service...1051second # [ 3.616953] systemd[1]: Mounted /sysroot/nix/store.1052second # [ 3.618764] systemd[1]: Reached target Initrd File Systems.1053second # [ 3.621309] systemd[1]: Starting Find NixOS closure...1054test # [ 3.612949] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1055test # [ 3.614159] systemd[1]: Finished rw-sysroot-nix-store.service.1056second # [ 3.627864] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1057second # [ 3.648892] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1058second # [ 3.676140] systemd[1]: Finished Find NixOS closure.1059second # [ 3.677634] systemd[1]: Reached target Initrd Default Target.1060second # [ 3.680188] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1061second # [ 3.708467] systemd[1]: initrd-cleanup.service: Deactivated successfully.1062second # [ 3.709420] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1063second # [ 3.713653] systemd[1]: Stopped target Initrd Default Target.1064second # [ 3.714310] systemd[1]: Stopped target Basic System.1065second # [ 3.716113] systemd[1]: Stopped target Initrd Root Device.1066second # [ 3.716652] systemd[1]: Stopped target Path Units.1067second # [ 3.719444] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1068second # [ 3.720301] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1069second # [ 3.721005] systemd[1]: Stopped target Slice Units.1070second # [ 3.721456] systemd[1]: Stopped target Socket Units.1071second # [ 3.721909] systemd[1]: Stopped target System Initialization.1072second # [ 3.722420] systemd[1]: Stopped target Swaps.1073second # [ 3.722835] systemd[1]: Stopped target Timer Units.1074second # [ 3.723328] systemd[1]: dbus.socket: Deactivated successfully.1075second # [ 3.723876] systemd[1]: Closed D-Bus System Message Bus Socket.1076second # [ 3.728173] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1077second # [ 3.732102] systemd[1]: Stopped Find NixOS closure.1078second # [ 3.732603] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1079second # [ 3.733276] systemd[1]: Starting rw-sysroot-nix-store.service...1080second # [ 3.733928] systemd[1]: systemd-sysctl.service: Deactivated successfully.1081second # [ 3.734593] systemd[1]: Stopped Apply Kernel Variables.1082second # [ 3.735793] systemd[1]: systemd-modules-load.service: Deactivated successfully.1083second # [ 3.740219] systemd[1]: Stopped Load Kernel Modules.1084second # [ 3.740714] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1085second # [ 3.741414] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1086second # [ 3.742116] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1087second # [ 3.742761] systemd[1]: Stopped Create System Files and Directories.1088second # [ 3.743324] systemd[1]: Stopped target Local File Systems.1089second # [ 3.743846] systemd[1]: Stopped target Preparation for Local File Systems.1090second # [ 3.748670] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1091second # [ 3.749336] systemd[1]: Stopped Coldplug All udev Devices.1092second # [ 3.749859] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1093second # [ 3.750528] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1094second # [ 3.751195] systemd[1]: Stopped Virtual Console Setup.1095second # [ 3.763712] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1096second # [ 3.764940] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1097second # [ 3.766165] systemd[1]: systemd-udevd.service: Deactivated successfully.1098second # [ 3.767368] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1099second # [ 3.769605] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1100second # [ 3.770608] systemd[1]: Finished rw-sysroot-nix-store.service.1101second # [ 3.772214] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1102second # [ 3.773384] systemd[1]: Closed udev Control Socket.1103second # [ 3.776382] systemd[1]: Starting Cleanup udev Database...1104second # [ 3.776930] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1105second # [ 3.777645] systemd[1]: Stopped Create Static Device Nodes in /dev.1106second # [ 3.778243] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1107second # [ 3.779367] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1108second # [ 3.780245] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1109second # [ 3.780878] systemd[1]: Stopped Create List of Static Device Nodes.1110second # [ 3.805475] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1111second # [ 3.807185] systemd[1]: Finished Cleanup udev Database.1112second # [ 3.807729] systemd[1]: Reached target Switch Root.1113second # [ 3.811719] systemd[1]: Starting NixOS Activation...1114second # [ 3.997604] initrd-nixos-activation-start[178]: booting system configuration /nix/store/dkdgmkd0q0n8qvg06lvb9n9bhvw9pz66-nixos-system-second-test1115second # [ 4.076091] initrd-nixos-activation-start[178]: running activation script...1116test # [ 4.495355] systemd[1]: Mounting /sysroot/nix/store...1117test # [ 4.542281] systemd[1]: Mounted /sysroot/nix/store.1118second # [ 4.555096] initrd-nixos-activation-start[201]: setting up /etc...1119test # [ 4.544890] systemd[1]: Reached target Initrd File Systems.1120test # [ 4.548308] systemd[1]: Starting Find NixOS closure...1121test # [ 4.560379] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1122test # [ 4.603887] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1123test # [ 4.605811] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1124test # [ 4.621960] systemd[1]: Finished Find NixOS closure.1125test # [ 4.624328] systemd[1]: Reached target Initrd Default Target.1126test # [ 4.625860] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1127test # [ 4.653822] systemd[1]: Stopped target Initrd Default Target.1128test # [ 4.656306] systemd[1]: Stopped target Basic System.1129test # [ 4.660418] systemd[1]: Stopped target Initrd Root Device.1130test # [ 4.661578] systemd[1]: Stopped target Path Units.1131test # [ 4.662288] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1132test # [ 4.664300] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1133test # [ 4.668131] systemd[1]: Stopped target Slice Units.1134test # [ 4.668846] systemd[1]: Stopped target Socket Units.1135test # [ 4.670288] systemd[1]: Stopped target System Initialization.1136test # [ 4.671399] systemd[1]: Stopped target Swaps.1137test # [ 4.676164] systemd[1]: Stopped target Timer Units.1138test # [ 4.676791] systemd[1]: dbus.socket: Deactivated successfully.1139test # [ 4.677482] systemd[1]: Closed D-Bus System Message Bus Socket.1140test # [ 4.678172] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1141test # [ 4.679027] systemd[1]: Stopped Find NixOS closure.1142test # [ 4.679614] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1143test # [ 4.683796] systemd[1]: Starting rw-sysroot-nix-store.service...1144test # [ 4.685231] systemd[1]: systemd-sysctl.service: Deactivated successfully.1145test # [ 4.688129] systemd[1]: Stopped Apply Kernel Variables.1146test # [ 4.689168] systemd[1]: systemd-modules-load.service: Deactivated successfully.1147test # [ 4.693615] systemd[1]: Stopped Load Kernel Modules.1148test # [ 4.694169] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1149test # [ 4.696891] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1150test # [ 4.700416] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1151test # [ 4.701652] systemd[1]: Stopped Create System Files and Directories.1152test # [ 4.702306] systemd[1]: Stopped target Local File Systems.1153test # [ 4.702861] systemd[1]: Stopped target Preparation for Local File Systems.1154test # [ 4.703521] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1155test # [ 4.712684] systemd[1]: Stopped Coldplug All udev Devices.1156test # [ 4.713482] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1157test # [ 4.714242] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1158test # [ 4.714961] systemd[1]: Stopped Virtual Console Setup.1159test # [ 4.715438] systemd[1]: initrd-cleanup.service: Deactivated successfully.1160test # [ 4.722012] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1161test # [ 4.722857] systemd[1]: systemd-udevd.service: Deactivated successfully.1162test # [ 4.724134] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1163test # [ 4.725446] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1164test # [ 4.727128] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1165test # [ 4.728316] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1166test # [ 4.732418] systemd[1]: Finished rw-sysroot-nix-store.service.1167test # [ 4.732970] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1168test # [ 4.733583] systemd[1]: Closed udev Control Socket.1169test # [ 4.734026] systemd[1]: Starting Cleanup udev Database...1170test # [ 4.734503] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1171test # [ 4.735098] systemd[1]: Stopped Create Static Device Nodes in /dev.1172test # [ 4.735592] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1173test # [ 4.736884] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1174test # [ 4.737528] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1175test # [ 4.738124] systemd[1]: Stopped Create List of Static Device Nodes.1176test # [ 4.761393] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1177test # [ 4.763641] systemd[1]: Finished Cleanup udev Database.1178test # [ 4.764325] systemd[1]: Reached target Switch Root.1179test # [ 4.769288] systemd[1]: Starting NixOS Activation...1180second # [ 4.817709] initrd-nixos-activation-start[201]: setting up age secrets...1181test # [ 4.964599] initrd-nixos-activation-start[180]: booting system configuration /nix/store/5c74aq96g7d42fbjn35xjzh0pl7djmcj-nixos-system-test-test1182test # [ 5.013790] initrd-nixos-activation-start[180]: running activation script...1183second # [ 5.058831] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1184second # [ 5.060691] systemd[1]: Finished NixOS Activation.1185second # [ 5.061484] systemd[1]: Starting Switch Root...1186second # [ 5.077476] systemd[1]: Switching root.1187second # [ 5.260090] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1188test # [ 5.429800] initrd-nixos-activation-start[203]: setting up /etc...1189test # [ 5.645877] initrd-nixos-activation-start[203]: setting up age secrets...1190second # [ 5.867343] systemd[1]: systemd 261.1 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)1191second # [ 5.874945] systemd[1]: Detected virtualization qemu.1192second # [ 5.876880] systemd[1]: Detected architecture arm64.1193second # [ 5.879265] systemd[1]: Detected first boot.1194second # [ 5.884873] systemd[1]: Initializing machine ID from random generator.1195test # [ 5.869176] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1196test # [ 5.870981] systemd[1]: Finished NixOS Activation.1197test # [ 5.871751] systemd[1]: Starting Switch Root...1198test # [ 5.885879] systemd[1]: Switching root.1199test # [ 6.052351] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1200second # [ 6.188423] systemd[1]: bpf-restrict-fs: LSM BPF program attached1201second # [ 6.405053] systemd[1]: Applying preset policy.1202test # [ 6.615712] systemd[1]: systemd 261.1 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)1203test # [ 6.623001] systemd[1]: Detected virtualization qemu.1204test # [ 6.625027] systemd[1]: Detected architecture arm64.1205test # [ 6.627763] systemd[1]: Detected first boot.1206test # [ 6.634216] systemd[1]: Initializing machine ID from random generator.1207test # [ 6.800482] systemd[1]: bpf-restrict-fs: LSM BPF program attached1208test # [ 6.976793] systemd[1]: Applying preset policy.1209second # [ 7.009928] systemd[1]: Populated /etc with preset unit settings.1210test # [ 7.568942] systemd[1]: Populated /etc with preset unit settings.1211second # [ 7.617066] systemd[1]: initrd-switch-root.service: Deactivated successfully.1212second # [ 7.618153] systemd[1]: Stopped initrd-switch-root.service.1213second # [ 7.619358] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1214second # [ 7.622706] systemd[1]: Created slice Slice /system/getty.1215second # [ 7.623766] systemd[1]: Created slice User and Session Slice.1216second # [ 7.624412] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1217second # [ 7.626500] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1218second # [ 7.627190] systemd[1]: Expecting device /dev/hvc0...1219second # [ 7.628200] systemd[1]: Expecting device /dev/ttyAMA0...1220second # [ 7.629985] systemd[1]: Reached target Local Encrypted Volumes.1221second # [ 7.630470] systemd[1]: Stopped target initrd-fs.target.1222second # [ 7.631356] systemd[1]: Stopped target initrd-root-fs.target.1223second # [ 7.632345] systemd[1]: Stopped target initrd-switch-root.target.1224second # [ 7.633988] systemd[1]: Reached target Virtual Machines and Containers.1225second # [ 7.635524] systemd[1]: Reached target Path Units.1226second # [ 7.636934] systemd[1]: Reached target Remote File Systems.1227second # [ 7.638419] systemd[1]: Reached target Slice Units.1228second # [ 7.639829] systemd[1]: Reached target Swaps.1229second # [ 7.643941] systemd[1]: Listening on Query the User Interactively for a Password.1230second # [ 7.649138] systemd[1]: Listening on Process Core Dump Socket.1231second # [ 7.652893] systemd[1]: Listening on Credential Encryption/Decryption.1232second # [ 7.656642] systemd[1]: Listening on Factory Reset Management.1233second # [ 7.657755] systemd[1]: Listening on Hostname Service Socket.1234second # [ 7.662503] systemd[1]: Starting Journal Log Access Socket...1235second # [ 7.664176] systemd[1]: Listening on Journal Audit Socket.1236second # [ 7.668352] systemd[1]: Listening on Console Output Muting Service Socket.1237second # [ 7.669915] systemd[1]: Listening on Network Management Metrics Varlink Socket.1238second # [ 7.671162] systemd[1]: Listening on Network Management Varlink Socket.1239second # [ 7.672950] systemd[1]: Listening on Network Management Netlink Socket.1240second # [ 7.675036] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1241second # [ 7.677431] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1242second # [ 7.679206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1243second # [ 7.691181] systemd[1]: Listening on Disk Repartitioning Service Socket.1244second # [ 7.691686] systemd[1]: Listening on Resolve Monitor Varlink Socket.1245second # [ 7.692043] systemd[1]: Listening on Resolve Service Varlink Socket.1246second # [ 7.692372] systemd[1]: Listening on udev Control Socket.1247second # [ 7.692709] systemd[1]: Listening on udev Varlink Socket.1248second # [ 7.698170] systemd[1]: Mounting Huge Pages File System...1249second # [ 7.702555] systemd[1]: Mounting POSIX Message Queue File System...1250second # [ 7.713210] systemd[1]: Mounting Kernel Debug File System...1251second # [ 7.722196] systemd[1]: Mounting Kernel Trace File System...1252second # [ 7.733128] systemd[1]: Starting Create List of Static Device Nodes...1253second # [ 7.740918] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1254second # [ 7.745621] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1255second # [ 7.753123] systemd[1]: Mounting Kernel Configuration File System...1256second # [ 7.754775] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1257second # [ 7.756858] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1258second # [ 7.769414] systemd[1]: Starting Load Kernel Module fuse...1259second # [ 7.771901] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671260second # [ 7.851449] systemd[1]: Starting Journal Service...1261second # [ 7.884655] systemd[1]: Starting Load Kernel Modules...1262second # [ 7.922698] fuse: init (API version 7.45)1263second # [ 7.927709] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1264second # [ 7.958058] systemd[1]: Starting Remount Root and Kernel File Systems...1265second # [ 7.959940] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1266second # [ 7.973020] systemd[1]: Starting Coldplug All udev Devices...1267second # [ 7.983217] systemd[1]: Listening on Journal Log Access Socket.1268second # [ 8.003995] systemd[1]: Mounted Huge Pages File System.1269second # [ 8.008864] systemd[1]: Mounted POSIX Message Queue File System.1270second # [ 8.014004] systemd[1]: Mounted Kernel Debug File System.1271second # [ 8.016150] systemd[1]: Mounted Kernel Trace File System.1272second # [ 8.022850] systemd[1]: Finished Create List of Static Device Nodes.1273second # [ 8.025420] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1274second # [ 8.028019] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1275second # [ 8.031104] systemd[1]: Mounted Kernel Configuration File System.1276second # [ 8.033410] systemd[1]: modprobe@fuse.service: Deactivated successfully.1277second # [ 8.038488] systemd[1]: Finished Load Kernel Module fuse.1278second # [ 8.043804] systemd[1]: Finished Load Kernel Modules.1279second # [ 8.053315] systemd[1]: Mounting FUSE Control File System...1280second # [ 8.055999] systemd-journald[306]: Collecting audit messages is enabled.1281second # [ 8.071965] systemd[1]: Starting Firewall...1282second # [ 8.067453] systemd[1]: Queued start job for default target Multi-User System.1283second # [ 8.069105] systemd[1]: systemd-journald.service: Deactivated successfully.1284second # [ 8.073158] systemd-modules-load[307]: Module 'atkbd' is built in1285second # [ 8.077008] systemd-modules-load[307]: Module 'ctr' is built in1286second # [ 8.078340] systemd-modules-load[307]: Module 'loop' is built in1287second # [ 8.092899] systemd[1]: Starting Apply Kernel Variables...1288second # [ 8.101578] EXT4-fs (vda): re-mounted 235ccac8-d358-4119-8253-4558ab49ee4a.1289second # [ 8.097437] systemd-oomd[308]: No swap; memory pressure usage will be degraded1290second # [ 8.109140] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1291second # [ 8.129917] systemd[1]: Started Journal Service.1292second # [ 8.127260] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1293second # [ 8.133870] systemd[1]: Finished Remount Root and Kernel File Systems.1294test # [ 8.179157] systemd[1]: initrd-switch-root.service: Deactivated successfully.1295second # [ 8.184210] systemd[1]: Listening on Disk Image Download Service Socket.1296test # [ 8.180108] systemd[1]: Stopped initrd-switch-root.service.1297test # [ 8.182527] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1298test # [ 8.185749] systemd[1]: Created slice Slice /system/getty.1299test # [ 8.187535] systemd[1]: Created slice User and Session Slice.1300second # [ 8.194002] systemd[1]: Starting Flush Journal to Persistent Storage...1301test # [ 8.188859] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1302test # [ 8.190585] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1303test # [ 8.191356] systemd[1]: Expecting device /dev/hvc0...1304test # [ 8.192387] systemd[1]: Expecting device /dev/ttyAMA0...1305second # [ 8.196738] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1306test # [ 8.193443] systemd[1]: Reached target Local Encrypted Volumes.1307test # [ 8.195115] systemd[1]: Stopped target initrd-fs.target.1308test # [ 8.196156] systemd[1]: Stopped target initrd-root-fs.target.1309test # [ 8.197269] systemd[1]: Stopped target initrd-switch-root.target.1310test # [ 8.198485] systemd[1]: Reached target Virtual Machines and Containers.1311test # [ 8.200201] systemd[1]: Reached target Path Units.1312second # [ 8.203630] systemd[1]: Starting Load/Save OS Random Seed...1313test # [ 8.201661] systemd[1]: Reached target Remote File Systems.1314test # [ 8.203230] systemd[1]: Reached target Slice Units.1315second # [ 8.208823] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1316test # [ 8.204677] systemd[1]: Reached target Swaps.1317test # [ 8.209199] systemd[1]: Listening on Query the User Interactively for a Password.1318test # [ 8.214283] systemd[1]: Listening on Process Core Dump Socket.1319test # [ 8.218392] systemd[1]: Listening on Credential Encryption/Decryption.1320test # [ 8.222809] systemd[1]: Listening on Factory Reset Management.1321second # [ 8.228228] systemd[1]: Mounted FUSE Control File System.1322test # [ 8.224602] systemd[1]: Listening on Hostname Service Socket.1323test # [ 8.230476] systemd[1]: Starting Journal Log Access Socket...1324test # [ 8.232565] systemd[1]: Listening on Journal Audit Socket.1325test # [ 8.237328] systemd[1]: Listening on Console Output Muting Service Socket.1326test # [ 8.239474] systemd[1]: Listening on Network Management Metrics Varlink Socket.1327test # [ 8.241004] systemd[1]: Listening on Network Management Varlink Socket.1328test # [ 8.243122] systemd[1]: Listening on Network Management Netlink Socket.1329test # [ 8.244367] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1330test # [ 8.245723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1331test # [ 8.248568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1332second # [ 8.259729] systemd[1]: Finished Apply Kernel Variables.1333test # [ 8.260561] systemd[1]: Listening on Disk Repartitioning Service Socket.1334test # [ 8.261754] systemd[1]: Listening on Resolve Monitor Varlink Socket.1335test # [ 8.262934] systemd[1]: Listening on Resolve Service Varlink Socket.1336test # [ 8.264234] systemd[1]: Listening on udev Control Socket.1337test # [ 8.265338] systemd[1]: Listening on udev Varlink Socket.1338test # [ 8.269642] systemd[1]: Mounting Huge Pages File System...1339second # [ 8.273614] systemd[1]: Starting Network Name Resolution...1340test # [ 8.274263] systemd[1]: Mounting POSIX Message Queue File System...1341test # [ 8.283217] systemd[1]: Mounting Kernel Debug File System...1342test # [ 8.292517] systemd[1]: Mounting Kernel Trace File System...1343second # [ 8.302521] systemd[1]: Finished Load/Save OS Random Seed.1344second # [ 8.309107] systemd[1]: Reached target First Boot Complete.1345test # [ 8.304360] systemd[1]: Starting Create List of Static Device Nodes...1346test # [ 8.311423] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1347second # [ 8.317226] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1348test # [ 8.312975] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1349second # [ 8.323780] systemd[1]: Starting Create Static Device Nodes in /dev...1350second # [ 8.335678] systemd-journald[306]: Received client request to flush runtime journal.1351test # [ 8.326311] systemd[1]: Mounting Kernel Configuration File System...1352test # [ 8.327429] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1353test # [ 8.330801] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1354test # [ 8.340884] systemd[1]: Starting Load Kernel Module fuse...1355test # [ 8.346075] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671356test # [ 8.404656] systemd[1]: Starting Journal Service...1357second # [ 8.413118] systemd[1]: Finished Flush Journal to Persistent Storage.1358test # [ 8.441026] systemd[1]: Starting Load Kernel Modules...1359second # [ 8.473562] systemd[1]: Finished Create Static Device Nodes in /dev.1360second # [ 8.475919] systemd[1]: Reached target Preparation for Local File Systems.1361test # [ 8.475559] fuse: init (API version 7.45)1362second # [ 8.483687] systemd[1]: Starting Rule-based Manager for Device Events and Files...1363test # [ 8.480076] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1364second # [ 8.491217] systemd-resolved[335]: Positive Trust Anchors:1365second # [ 8.492704] systemd-resolved[335]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1366second # [ 8.498040] systemd-resolved[335]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161367test # [ 8.499099] systemd[1]: Starting Remount Root and Kernel File Systems...1368second # [ 8.504284] systemd-resolved[335]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test1369test # [ 8.510134] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1370test # [ 8.534120] systemd[1]: Starting Coldplug All udev Devices...1371test # [ 8.541464] systemd-journald[329]: Collecting audit messages is enabled.1372test # [ 8.548711] systemd[1]: Queued start job for default target Multi-User System.1373test # [ 8.550681] systemd[1]: systemd-journald.service: Deactivated successfully.1374test # [ 8.557788] systemd[1]: Started Journal Service.1375test # [ 8.555800] systemd-modules-load[330]: Module 'atkbd' is built in1376test # [ 8.558989] systemd-modules-load[330]: Module 'ctr' is built in1377test # [ 8.563777] systemd-modules-load[330]: Module 'loop' is built in1378test # [ 8.568749] systemd[1]: Listening on Journal Log Access Socket.1379test # [ 8.572716] systemd[1]: Mounted Huge Pages File System.1380test # [ 8.577921] systemd[1]: Mounted POSIX Message Queue File System.1381test # [ 8.582929] systemd[1]: Mounted Kernel Debug File System.1382test # [ 8.589095] systemd[1]: Mounted Kernel Trace File System.1383test # [ 8.590806] systemd[1]: Finished Create List of Static Device Nodes.1384test # [ 8.596817] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1385test # [ 8.599942] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1386second # [ 8.611646] systemd[1]: Mounting /run/wrappers...1387test # [ 8.604279] systemd[1]: Mounted Kernel Configuration File System.1388test # [ 8.605716] systemd[1]: modprobe@fuse.service: Deactivated successfully.1389test # [ 8.606855] systemd[1]: Finished Load Kernel Module fuse.1390test # [ 8.610490] systemd[1]: Finished Load Kernel Modules.1391test # [ 8.616227] systemd[1]: Mounting FUSE Control File System...1392test # [ 8.619681] systemd[1]: Starting Firewall...1393test # [ 8.625768] systemd[1]: Starting Apply Kernel Variables...1394second # [ 8.640921] systemd-udevd[349]: Using default interface naming scheme 'v261'.1395test # [ 8.649961] EXT4-fs (vda): re-mounted 13a5909b-75a1-46d8-91b8-51a5d8bc6041.1396test # [ 8.657553] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1397test # [ 8.664978] systemd-oomd[332]: No swap; memory pressure usage will be degraded1398second # [ 8.680373] systemd[1]: Mounted /run/wrappers.1399test # [ 8.670991] systemd[1]: Finished Remount Root and Kernel File Systems.1400second # [ 8.682791] systemd[1]: Reached target Local File Systems.1401second # [ 8.692424] systemd[1]: Listening on Boot Loader Control Service Socket.1402test # [ 8.685787] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1403test # [ 8.690061] systemd[1]: Listening on Disk Image Download Service Socket.1404second # [ 8.702826] systemd[1]: Starting register-nix-paths.service...1405second # [ 8.710397] systemd[1]: Starting Create SUID/SGID Wrappers...1406second # [ 8.712285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1407test # [ 8.706404] systemd[1]: Starting Flush Journal to Persistent Storage...1408test # [ 8.716585] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1409second # [ 8.732311] systemd[1]: Starting Save Transient machine-id to Disk...1410test # [ 8.734695] systemd[1]: Starting Load/Save OS Random Seed...1411test # [ 8.740158] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1412second # [ 8.770175] systemd[1]: Starting Create System Files and Directories...1413test # [ 8.810003] systemd[1]: Finished Apply Kernel Variables.1414test # [ 8.820367] systemd-journald[329]: Received client request to flush runtime journal.1415second # [ 8.831349] systemd-resolved[335]: Using system hostname 'second'.1416second # [ 8.847211] systemd[1]: Started Network Name Resolution.1417second # [ 8.908362] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1418test # [ 8.898398] systemd[1]: Mounted FUSE Control File System.1419second # [ 8.916069] systemd[1]: Finished Save Transient machine-id to Disk.1420test # [ 8.906059] systemd[1]: Starting Network Name Resolution...1421test # [ 8.910637] systemd[1]: Finished Load/Save OS Random Seed.1422test # [ 8.920991] systemd[1]: Reached target First Boot Complete.1423test # [ 8.921640] systemd[1]: Finished Flush Journal to Persistent Storage.1424test # [ 8.938385] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1425test # [ 8.943099] systemd[1]: Starting Create Static Device Nodes in /dev...1426second # [ 9.009928] systemd[1]: Finished Create System Files and Directories.1427test # [ 9.009875] systemd-resolved[358]: Positive Trust Anchors:1428test # [ 9.012280] systemd-resolved[358]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1429test # [ 9.019503] systemd-resolved[358]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161430second # [ 9.034122] systemd[1]: Starting Rebuild Journal Catalog...1431test # [ 9.020727] systemd-resolved[358]: 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 test1432second # [ 9.041554] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1433test # [ 9.078286] systemd[1]: Finished Create Static Device Nodes in /dev.1434test # [ 9.081099] systemd[1]: Reached target Preparation for Local File Systems.1435second # [ 9.092702] systemd[1]: Started Rule-based Manager for Device Events and Files.1436test # [ 9.086298] systemd[1]: Starting Rule-based Manager for Device Events and Files...1437second # [ 9.165153] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1438test # [ 9.182174] systemd[1]: Mounting /run/wrappers...1439test # [ 9.230134] systemd-udevd[374]: Using default interface naming scheme 'v261'.1440second # [ 9.271446] systemd[1]: Finished Rebuild Journal Catalog.1441test # [ 9.268086] systemd[1]: Mounted /run/wrappers.1442second # [ 9.280958] systemd[1]: Starting Update is Completed...1443test # [ 9.272786] systemd[1]: Reached target Local File Systems.1444test # [ 9.278405] systemd[1]: Listening on Boot Loader Control Service Socket.1445test # [ 9.288105] systemd[1]: Starting register-nix-paths.service...1446test # [ 9.296719] systemd[1]: Starting Create SUID/SGID Wrappers...1447test # [ 9.300674] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1448test # [ 9.318472] systemd[1]: Starting Save Transient machine-id to Disk...1449second # [ 9.333266] systemd[1]: Finished Coldplug All udev Devices.1450test # [ 9.335614] systemd-resolved[358]: Using system hostname 'test'.1451second # [ 9.357131] systemd[1]: Finished Update is Completed.1452test # [ 9.364961] systemd[1]: Starting Create System Files and Directories...1453test # [ 9.368617] systemd[1]: Started Network Name Resolution.1454test # [ 9.486088] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1455test # [ 9.499014] systemd[1]: Finished Save Transient machine-id to Disk.1456second # [ 9.576757] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1457test # [ 9.595679] systemd[1]: Finished Create System Files and Directories.1458test # [ 9.609291] systemd[1]: Starting Rebuild Journal Catalog...1459test # [ 9.620759] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1460test # [ 9.700445] systemd[1]: Started Rule-based Manager for Device Events and Files.1461test # [ 9.761344] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1462second # [ 9.782409] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1463second # [ 9.786214] systemd[1]: Finished Create SUID/SGID Wrappers.1464test # [ 9.832610] systemd[1]: Finished Coldplug All udev Devices.1465test # [ 9.838186] systemd[1]: Finished Rebuild Journal Catalog.1466second # [ 9.854061] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1467test # [ 9.847047] systemd[1]: Starting Update is Completed...1468second # [ 9.899174] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1469test # [ 9.917202] systemd[1]: Finished Update is Completed.1470second # [ 10.136795] systemd[1]: Finished register-nix-paths.service.1471second # [ 10.139795] systemd[1]: Reached target System Initialization.1472second # [ 10.142410] systemd[1]: Started Discard unused filesystem blocks once a week.1473second # [ 10.145466] systemd[1]: Started Daily Cleanup of Temporary Directories.1474second # [ 10.149175] systemd[1]: Reached target Timer Units.1475second # [ 10.149847] systemd[1]: Listening on D-Bus System Message Bus Socket.1476second # [ 10.152471] systemd[1]: Listening on Nix Daemon Socket.1477second # [ 10.159451] systemd[1]: Listening on Authorization Manager Agent Helper.1478second # [ 10.161663] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1479second # [ 10.162508] systemd[1]: Reached target Socket Units.1480second # [ 10.165345] systemd[1]: Starting D-Bus System Message Bus...1481test # [ 10.169647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1482second # [ 10.226357] (udev-worker)[447]: Network interface NamePolicy= disabled on kernel command line.1483second # [ 10.229582] (udev-worker)[454]: Network interface NamePolicy= disabled on kernel command line.1484second # [ 10.306454] systemd[1]: Finished Firewall.1485second # [ 10.310375] systemd[1]: Reached target Preparation for Network.1486second # [ 10.312293] systemd[1]: Listening on Network Management Resolve Hook Socket.1487second # [ 10.315490] systemd[1]: Starting Network Management...1488second # [ 10.369226] dbus-broker-launch[519]: Looking up NSS user entry for 'systemd-timesync'...1489test # [ 10.361014] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1490test # [ 10.365709] systemd[1]: Finished Create SUID/SGID Wrappers.1491second # [ 10.392505] dbus-broker-launch[519]: NSS returned no entry for 'systemd-timesync'1492second # [ 10.394219] dbus-broker-launch[519]: Invalid user-name in /nix/store/9bi1kkmb9432hp88ll5za3nqn4z3r8gi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1493second # [ 10.440296] mousedev: PS/2 mouse device common for all mice1494second # [ 10.457643] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1495second # [ 10.465519] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1496test # [ 10.455715] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1497second # [ 10.469918] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/0b4cs5a1w1cs0mxvnms62684qzblwipc-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1498second # [ 10.483265] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1499second # [ 10.488682] systemd[1]: Started D-Bus System Message Bus.1500second # [ 10.544612] dbus-broker-launch[519]: Ready1501test # [ 10.534975] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1502second # [ 10.549615] systemd[1]: Reached target Basic System.1503second # [ 10.554187] systemd[1]: Starting Network Manager Script Dispatcher Service...1504second # [ 10.573040] cfg80211: Loading compiled-in X.509 certificates for regulatory database1505second # [ 10.574841] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1506second # [ 10.589434] systemd[1]: Starting Network Manager...1507second # [ 10.608276] systemd[1]: Started backdoor.service.1508second # [ 10.647732] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1509second # [ 10.648255] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1510second # [ 10.651977] systemd[1]: Starting Import lastlog data into lastlog2 database...1511second # [ 10.690576] zsn6lh46yrf8f6yb2sf9bp8azbl2d0jg-wifi-secrets[537]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all1512second # [ 10.698031] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1513test # [ 10.697168] systemd[1]: Finished register-nix-paths.service.1514test # [ 10.699398] systemd[1]: Reached target System Initialization.1515test # [ 10.701053] systemd[1]: Started Discard unused filesystem blocks once a week.1516test # [ 10.703775] systemd[1]: Started Daily Cleanup of Temporary Directories.1517test # [ 10.707564] systemd[1]: Reached target Timer Units.1518test # [ 10.709961] systemd[1]: Listening on D-Bus System Message Bus Socket.1519test # [ 10.711915] systemd[1]: Listening on Nix Daemon Socket.1520test # [ 10.718595] systemd[1]: Listening on Authorization Manager Agent Helper.1521test # [ 10.719353] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1522test # [ 10.722994] systemd[1]: Reached target Socket Units.1523test # [ 10.728509] systemd[1]: Starting D-Bus System Message Bus...1524second # [ 10.746849] systemd[1]: Starting Post-Boot Actions...1525second # [ 10.752377] systemd-networkd[532]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1526second # [ 10.771198] systemd-networkd[532]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1527second # [ 10.785598] systemd-networkd[532]: lo: Link UP1528second # [ 10.793461] systemd-networkd[532]: lo: Gained carrier1529second # [ 10.803282] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1530second # [ 10.821982] systemd-networkd[532]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1531second # [ 10.833765] systemd[1]: Started Reset console on configuration changes.1532second # [ 10.841649] systemd[1]: Started Network Management.1533second # [ 10.844689] systemd-networkd[532]: eth1: Link UP1534second # [ 10.852944] systemd-networkd[532]: eth1: Gained carrier1535second # [ 10.859625] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1536test # [ 10.852767] (udev-worker)[481]: Network interface NamePolicy= disabled on kernel command line.1537test # [ 10.856299] (udev-worker)[472]: Network interface NamePolicy= disabled on kernel command line.1538second # [ 10.871448] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1539second # connecting to host...1540second # [ 10.878678] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1541test # [ 10.881098] systemd[1]: Finished Firewall.1542test # [ 10.884109] systemd[1]: Reached target Preparation for Network.1543test # [ 10.885805] systemd[1]: Listening on Network Management Resolve Hook Socket.1544test # [ 10.889156] systemd[1]: Starting Network Management...1545second # [ 10.909389] systemd[1]: Finished Post-Boot Actions.1546test # [ 10.934378] dbus-broker-launch[540]: Looking up NSS user entry for 'systemd-timesync'...1547second # [ 10.947423] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1548test # [ 10.955018] dbus-broker-launch[540]: NSS returned no entry for 'systemd-timesync'1549test # [ 10.957365] dbus-broker-launch[540]: Invalid user-name in /nix/store/9bi1kkmb9432hp88ll5za3nqn4z3r8gi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1550second # [ 10.997742] nsncd[548]: Aug 20 05:08:23.790 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1551second # [ 10.999009] systemd[1]: Finished Import lastlog data into lastlog2 database.1552second # [ 11.006590] systemd[1]: Started Name Service Cache Daemon (nsncd).1553second # [ 11.009784] systemd[1]: Started Network Manager Script Dispatcher Service.1554second # [ 11.012699] systemd[1]: Reached target Host and Network Name Lookups.1555second # [ 11.015481] systemd[1]: Reached target User and Group Name Lookups.1556second # [ 11.018773] systemd[1]: Starting User Login Management...1557test # [ 11.019896] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1558test # [ 11.026458] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1559test # [ 11.031887] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/0b4cs5a1w1cs0mxvnms62684qzblwipc-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1560test # [ 11.046085] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1561second # [ 11.057954] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1562test # [ 11.053638] mousedev: PS/2 mouse device common for all mice1563test # [ 11.052954] systemd[1]: Started D-Bus System Message Bus.1564test # [ 11.106445] dbus-broker-launch[540]: Ready1565second # [ 11.117509] systemd[1]: Starting Hostname Service...1566test # [ 11.110788] systemd[1]: Reached target Basic System.1567test # [ 11.128219] systemd[1]: Starting Network Manager Script Dispatcher Service...1568test # [ 11.131736] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1569test # [ 11.145684] cfg80211: Loading compiled-in X.509 certificates for regulatory database1570test # [ 11.148993] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1571second # [ 11.169995] systemd-logind[580]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1572second # [ 11.174830] systemd-logind[580]: Watching system buttons on /dev/input/event0 (gpio-keys)1573second # [ 11.175624] systemd-logind[580]: New seat seat0.1574test # [ 11.167571] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1575second # [ 11.182132] systemd[1]: Started User Login Management.1576second # [ 11.185945] systemd[1]: Starting linger-users.service...1577test # [ 11.205816] systemd[1]: Starting Network Manager...1578test # [ 11.235780] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1579test # [ 11.236309] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1580second # [ 11.255561] systemd[1]: Started Hostname Service.1581test # [ 11.245679] systemd[1]: Started backdoor.service.1582second # [ 11.268524] systemd[1]: linger-users.service: Deactivated successfully.1583second # [ 11.271518] systemd[1]: Finished linger-users.service.1584test # [ 11.277048] systemd[1]: Starting Import lastlog data into lastlog2 database...1585test # [ 11.308352] 3g5nyz1jngrkxdc2n9blgiwyahkpbd78-wifi-secrets[562]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-open1586test # [ 11.321196] zsn6lh46yrf8f6yb2sf9bp8azbl2d0jg-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all1587test # [ 11.334865] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1588second # [ 11.359475] systemd-networkd[532]: eth0: Link UP1589second # [ 11.360084] systemd-networkd[532]: eth0: Gained carrier1590second # [ 11.379748] systemd[1]: Started Network Manager.1591second # [ 11.382305] systemd[1]: Reached target Network.1592test # [ 11.372370] s26qgk2g28g5q546f1jwsyjwvcspvch9-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-one1593second # [ 11.389388] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1594test # [ 11.384532] systemd[1]: Starting Post-Boot Actions...1595second # [ 11.397435] systemd[1]: Starting Permit User Sessions...1596test # [ 11.409605] systemd-networkd[555]: /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.1597test # [ 11.430296] systemd[1]: Started Reset console on configuration changes.1598test # [ 11.439932] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1599test # [ 11.450344] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1600test # [ 11.453215] systemd-networkd[555]: /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.1601test # [ 11.469902] systemd-networkd[555]: lo: Link UP1602test # [ 11.475233] systemd-networkd[555]: lo: Gained carrier1603test # [ 11.485656] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1604test # [ 11.501239] systemd-networkd[555]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1605test # [ 11.509917] systemd[1]: Started Network Management.1606test # [ 11.514677] systemd-networkd[555]: eth1: Link UP1607test # [ 11.517775] systemd-networkd[555]: eth1: Gained carrier1608test # [ 11.523633] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1609test # connecting to host...1610test # [ 11.538240] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1611test # [ 11.547029] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1612test # [ 11.547700] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1613second # [ 11.563319] systemd[1]: Finished Permit User Sessions.1614test # [ 11.561914] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1615second # [ 11.579048] systemd[1]: Started Getty on tty1.1616second # [ 11.579619] systemd[1]: Reached target Login Prompts.1617second # [ 11.592807] systemd-resolved[335]: eth0: Bus client set default route setting: yes1618test # [ 11.587340] systemd[1]: Finished Post-Boot Actions.1619second # [ 11.599964] systemd-resolved[335]: eth0: Bus client set DNS server list to: 10.0.2.31620test # [ 11.604912] nsncd[578]: Aug 20 05:08:24.392 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1621test # [ 11.616646] systemd[1]: Started Name Service Cache Daemon (nsncd).1622test: Guest shell says: b'Spawning backdoor root shell...\n'1623test # [ 11.627513] systemd[1]: Finished Import lastlog data into lastlog2 database.1624test # [ 11.634985] systemd[1]: Reached target Host and Network Name Lookups.1625test # [ 11.640561] systemd[1]: Reached target User and Group Name Lookups.1626test # [ 11.650325] systemd[1]: Starting User Login Management...1627test: connected to guest root shell1628test: (connecting took 12.23 seconds)1629test: (finished: waiting for the VM to finish booting, in 12.23 seconds)1630test # [ 11.660576] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1631second # [ 11.691644] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1632second # [ 11.693202] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1633test # [ 11.705381] systemd[1]: Started Network Manager Script Dispatcher Service.1634test # [ 11.820160] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1635second # [ 11.836165] systemd[1]: Reached target Multi-User System.1636second # [ 11.840095] systemd[1]: Startup finished in 752ms (kernel) + 4.605s (initrd) + 6.481s (userspace) = 11.839s.1637test # [ 11.839656] systemd[1]: Starting Hostname Service...1638test # [ 11.859884] systemd-logind[610]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1639test # [ 11.865048] systemd-logind[610]: Watching system buttons on /dev/input/event0 (gpio-keys)1640test # [ 11.868998] systemd-logind[610]: New seat seat0.1641test # [ 11.869557] systemd[1]: Started User Login Management.1642test # [ 11.875250] systemd[1]: Starting linger-users.service...1643test # [ 11.956651] systemd[1]: linger-users.service: Deactivated successfully.1644test # [ 11.957881] systemd[1]: Finished linger-users.service.1645test # [ 11.979146] systemd[1]: Started Hostname Service.1646test # [ 12.078300] systemd-networkd[555]: eth0: Link UP1647test # [ 12.078815] systemd-networkd[555]: eth0: Gained carrier1648test # [ 12.097755] systemd[1]: Started Network Manager.1649test # [ 12.100156] systemd[1]: Reached target Network.1650test # [ 12.108314] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1651test # [ 12.122299] systemd[1]: Starting Permit User Sessions...1652second # [ 12.244265] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31653test # [ 12.270149] systemd[1]: Finished Permit User Sessions.1654test # [ 12.286019] systemd[1]: Started Getty on tty1.1655test # [ 12.286535] systemd[1]: Reached target Login Prompts.1656test # [ 12.294009] systemd-resolved[358]: eth0: Bus client set default route setting: yes1657test # [ 12.300990] systemd-resolved[358]: eth0: Bus client set DNS server list to: 10.0.2.31658test # [ 12.386206] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1659test # [ 12.387667] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1660second # [ 12.449293] systemd-networkd[532]: eth1: Gained IPv6LL1661second # [ 12.494101] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1662second # [ 12.534797] systemd[1]: Starting Virtual Console Setup...1663test # [ 12.537979] systemd[1]: Reached target Multi-User System.1664test # [ 12.539479] systemd[1]: Startup finished in 760ms (kernel) + 5.373s (initrd) + 6.405s (userspace) = 12.539s.1665second # [ 12.558215] systemd-logind[580]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1666second # [ 12.833923] systemd-networkd[532]: eth0: Gained IPv6LL1667test: (finished: waiting for unit NetworkManager.service, in 13.47 seconds)1668test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1669test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1670test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets-wg-test-open1671test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets-wg-test-open, in 0.05 seconds)1672test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1673second # [ 13.042633] systemd-vconsole-setup[642]: Configuration of first virtual console was skipped, ignoring remaining ones.1674second # [ 13.045458] systemd[1]: Finished Virtual Console Setup.1675test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds)1676(finished: run the VM test script, in 14.05 seconds)1677test # [ 13.057569] systemd-networkd[555]: eth1: Gained IPv6LL1678test script finished in 14.13s1679cleanup1680kill QemuMachine (pid 47)1681second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14)1682test # [ 13.153394] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31683kill QemuMachine (pid 48)1684test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14)1685(finished: cleanup, in 0.22 seconds)