nixbot

builds

succeeded vm-test-run-wifi default.checks.aarch64-linux.wifi · build #337 · 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: QEMU running (pid 48)14second # Disk image does not exist, creating the virtualisation disk image...15test: QEMU running (pid 47)16second # Formatting '/build/vm-state-second/tmp.0ClIzEfxWc', fmt=raw size=107374182417test # Disk image does not exist, creating the virtualisation disk image...18second # mke2fs 1.47.4 (6-Mar-2025)19test # Formatting '/build/vm-state-test/tmp.6kT7Uc2kPC', fmt=raw size=107374182420second # Discarding device blocks: 0/262144 done21(finished: start all VMs, in 0.42 seconds)22second # Creating filesystem with 262144 4k blocks and 65536 inodes23test: waiting for unit NetworkManager.service24test # mke2fs 1.47.4 (6-Mar-2025)25test: waiting for the VM to finish booting26test # Discarding device blocks: 0/262144 done27second # Filesystem UUID: 49e63f32-6a15-49fd-a4e9-a452f1063dc028test # Creating filesystem with 262144 4k blocks and 65536 inodes29second # Superblock backups stored on blocks:30test # Filesystem UUID: 2d8032a8-dcb0-49d8-80b2-8d4d34ef7e6e31second # 32768, 98304, 163840, 22937632test # Superblock backups stored on blocks:33second # 34test # 32768, 98304, 163840, 22937635second # Allocating group tables: 0/8 done36test # 37second # Writing inode tables: 0/8 done38test # Allocating group tables: 0/8 done39second # Creating journal (8192 blocks): done40test # Writing inode tables: 0/8 done41second # Writing superblocks and filesystem accounting information: 0/8 done42test # Creating journal (8192 blocks): done43second # 44test # Writing superblocks and filesystem accounting information: 0/8 done45second # Virtualisation disk image created.46test # 47test # Virtualisation disk image created.48test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]49test # [ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 9 18:25:30 UTC 202650test # [ 0.000000] KASLR enabled51test # [ 0.000000] random: crng init done52test # [ 0.000000] Machine model: linux,dummy-virt53test # [ 0.000000] efi: UEFI not found.54test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT55test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]56test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]57test # [ 0.000000] Zone ranges:58test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]59test # [ 0.000000] DMA32 empty60test # [ 0.000000] Normal empty61test # [ 0.000000] Device empty62test # [ 0.000000] Movable zone start for each node63test # [ 0.000000] Early memory node ranges64test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]65test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]66test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000067test # [ 0.000000] psci: probing for conduit method from DT.68test # [ 0.000000] psci: PSCIv1.3 detected in firmware.69test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs70test # [ 0.000000] psci: Trusted OS migration not required71test # [ 0.000000] psci: SMC Calling Convention v1.172test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)73test # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u31129674test # [ 0.000000] Detected PIPT I-cache on CPU075test # [ 0.000000] CPU features: detected: GICv3 CPU interface76test # [ 0.000000] CPU features: detected: Spectre-v477test # [ 0.000000] CPU features: detected: Spectre-BHB78test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR79test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)80test # [ 0.000000] CPU features: detected: ARM erratum 141804081test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion82test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing83test # [ 0.000000] alternatives: applying boot alternatives84test # [ 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/q5bj8kjfq9mvsyyc7wbk9ajv4b9mg4ly-nixos-system-test-test/init regInfo=/nix/store/n7cy0n1i3vpdzpqsqlgldbwr07x0cm1z-closure-info/registration console=ttyAMA0,115200n8 console=tty085test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/n7cy0n1i3vpdzpqsqlgldbwr07x0cm1z-closure-info/registration", will be passed to user space.86test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes87test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)88test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)89test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB90test # [ 0.000000] software IO TLB: area num 1.91test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)92test # [ 0.000000] Fallback order for Node 0: 093second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]94second # [ 0.000000] Linux version 6.18.44 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Aug 9 18:25:30 UTC 202695second # [ 0.000000] KASLR enabled96second # [ 0.000000] random: crng init done97second # [ 0.000000] Machine model: linux,dummy-virt98second # [ 0.000000] efi: UEFI not found.99test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144100test # [ 0.000000] Policy zone: DMA101test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off102test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1103test # [ 0.000000] allocated 2097152 bytes of page_ext104test # [ 0.000000] ftrace: allocating 74867 entries in 294 pages105test # [ 0.000000] ftrace: allocated 294 pages with 4 groups106test # [ 0.000000] rcu: Hierarchical RCU implementation.107test # [ 0.000000] rcu: RCU event tracing is enabled.108second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT109second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]110second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]111second # [ 0.000000] Zone ranges:112second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]113second # [ 0.000000] DMA32 empty114second # [ 0.000000] Normal empty115second # [ 0.000000] Device empty116second # [ 0.000000] Movable zone start for each node117second # [ 0.000000] Early memory node ranges118second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]119test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.120test # [ 0.000000] Trampoline variant of Tasks RCU enabled.121test # [ 0.000000] Rude variant of Tasks RCU enabled.122test # [ 0.000000] Tracing variant of Tasks RCU enabled.123test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.124test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1125second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]126test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.127test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.128test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.129second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000130test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0131second # [ 0.000000] psci: probing for conduit method from DT.132test # [ 0.000000] GICv3: 256 SPIs implemented133second # [ 0.000000] psci: PSCIv1.3 detected in firmware.134test # [ 0.000000] GICv3: 0 Extended SPIs implemented135second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs136test # [ 0.000000] Root IRQ handler: gic_handle_irq137test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI138second # [ 0.000000] psci: Trusted OS migration not required139test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0140second # [ 0.000000] psci: SMC Calling Convention v1.1141test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000142second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)143test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]144second # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296145second # [ 0.000000] Detected PIPT I-cache on CPU0146test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)147second # [ 0.000000] CPU features: detected: GICv3 CPU interface148second # [ 0.000000] CPU features: detected: Spectre-v4149test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)150second # [ 0.000000] CPU features: detected: Spectre-BHB151test # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000152second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR153test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000154second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)155test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.156second # [ 0.000000] CPU features: detected: ARM erratum 1418040157test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns158second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion159second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing160test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040161second # [ 0.000000] alternatives: applying boot alternatives162test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).163test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns164test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns165test # [ 0.000068] arm-pv: using stolen time PV166second # [ 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/z1x7nl7l4ihg876a3xsmw51a9f6bnxqx-nixos-system-second-test/init regInfo=/nix/store/9d8h5s2kvn3vr9z2di2xmcmi6yql0ffg-closure-info/registration console=ttyAMA0,115200n8 console=tty0167test # [ 0.000385] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)168test # [ 0.000637] Console: colour dummy device 80x25169test # [ 0.000654] printk: legacy console [tty0] enabled170second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/9d8h5s2kvn3vr9z2di2xmcmi6yql0ffg-closure-info/registration", will be passed to user space.171second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes172second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)173test # [ 0.000866] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)174test # [ 0.000872] pid_max: default: 32768 minimum: 301175test # [ 0.000967] LSM: initializing lsm=capability,landlock,yama,bpf,ima176test # [ 0.001087] landlock: Up and running.177second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)178test # [ 0.001089] Yama: becoming mindful.179test # [ 0.001453] LSM support for eBPF active180second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB181second # [ 0.000000] software IO TLB: area num 1.182test # [ 0.001635] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)183second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)184test # [ 0.001653] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)185second # [ 0.000000] Fallback order for Node 0: 0186test # [ 0.003438] cacheinfo: Unable to detect cache hierarchy for CPU 0187second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144188test # [ 0.004259] rcu: Hierarchical SRCU implementation.189second # [ 0.000000] Policy zone: DMA190test # [ 0.004264] rcu: Max phase no-delay instances is 1000.191second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off192test # [ 0.005145] fsl-mc MSI: its@8080000 domain created193second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1194test # [ 0.005304] EFI services will not be available.195test # [ 0.005383] smp: Bringing up secondary CPUs ...196second # [ 0.000000] allocated 2097152 bytes of page_ext197test # [ 0.005408] smp: Brought up 1 node, 1 CPU198second # [ 0.000000] ftrace: allocating 74867 entries in 294 pages199test # [ 0.005413] SMP: Total of 1 processors activated.200second # [ 0.000000] ftrace: allocated 294 pages with 4 groups201test # [ 0.005415] CPU: All CPU(s) started at EL1202second # [ 0.000000] rcu: Hierarchical RCU implementation.203test # [ 0.005427] CPU features: detected: 32-bit EL0 Support204second # [ 0.000000] rcu: RCU event tracing is enabled.205test # [ 0.005430] CPU features: detected: Data cache clean to the PoU not required for I/D coherence206second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.207second # [ 0.000000] Trampoline variant of Tasks RCU enabled.208test # [ 0.005433] CPU features: detected: Common not Private translations209second # [ 0.000000] Rude variant of Tasks RCU enabled.210test # [ 0.005435] CPU features: detected: CRC32 instructions211second # [ 0.000000] Tracing variant of Tasks RCU enabled.212test # [ 0.005437] CPU features: detected: Data cache clean to Point of Persistence213second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.214test # [ 0.005440] CPU features: detected: Enhanced Virtualization Traps215second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1216test # [ 0.005449] CPU features: detected: RCpc load-acquire (LDAPR)217test # [ 0.005452] CPU features: detected: LSE atomic instructions218second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.219test # [ 0.005454] CPU features: detected: Privileged Access Never220test # [ 0.005455] CPU features: detected: PMUv3221second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.222test # [ 0.005457] CPU features: detected: RAS Extension Support223second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.224test # [ 0.005460] CPU features: detected: Speculative Store Bypassing Safe (SSBS)225second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0226test # [ 0.005481] alternatives: applying system-wide alternatives227second # [ 0.000000] GICv3: 256 SPIs implemented228test # [ 0.006962] CPU features: detected: Hardware dirty bit management on CPU0229second # [ 0.000000] GICv3: 0 Extended SPIs implemented230second # [ 0.000000] Root IRQ handler: gic_handle_irq231second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI232test # [ 0.007200] Memory: 891520K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115796K reserved, 32768K cma-reserved)233second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0234test # [ 0.007637] devtmpfs: initialized235second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000236test # [ 0.009075] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)237second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]238test # [ 0.009097] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).239second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)240test # [ 0.009234] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL241test # [ 0.009237] 0 pages in range for non-PLT usage242second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)243test # [ 0.009238] 508288 pages in range for PLT usage244second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000245test # [ 0.009352] pinctrl core: initialized pinctrl subsystem246test # [ 0.010086] DMI not present or invalid.247second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000248test # [ 0.013208] NET: Registered PF_NETLINK/PF_ROUTE protocol family249second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.250test # [ 0.015454] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations251second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns252test # [ 0.015588] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations253second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040254test # [ 0.015738] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations255second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).256second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns257second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns258second # [ 0.000063] arm-pv: using stolen time PV259second # [ 0.000376] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)260second # [ 0.000634] Console: colour dummy device 80x25261second # [ 0.000650] printk: legacy console [tty0] enabled262test # [ 0.015754] audit: initializing netlink subsys (disabled)263test # [ 0.016120] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1264test # [ 0.016389] thermal_sys: Registered thermal governor 'fair_share'265test # [ 0.016390] thermal_sys: Registered thermal governor 'bang_bang'266test # [ 0.016393] thermal_sys: Registered thermal governor 'step_wise'267test # [ 0.016395] thermal_sys: Registered thermal governor 'user_space'268test # [ 0.016397] thermal_sys: Registered thermal governor 'power_allocator'269test # [ 0.016424] cpuidle: using governor ladder270test # [ 0.016430] cpuidle: using governor menu271test # [ 0.016538] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.272second # [ 0.000859] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)273second # [ 0.000864] pid_max: default: 32768 minimum: 301274test # [ 0.016558] ASID allocator initialised with 32768 entries275test # [ 0.017219] Serial: AMBA PL011 UART driver276second # [ 0.000939] LSM: initializing lsm=capability,landlock,yama,bpf,ima277second # [ 0.001054] landlock: Up and running.278second # [ 0.001056] Yama: becoming mindful.279test # [ 0.020371] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1280second # [ 0.001413] LSM support for eBPF active281test # [ 0.020512] printk: console [ttyAMA0] enabled282second # [ 0.001578] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)283second # [ 0.001596] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)284second # [ 0.003248] cacheinfo: Unable to detect cache hierarchy for CPU 0285second # [ 0.003948] rcu: Hierarchical SRCU implementation.286second # [ 0.003952] rcu: Max phase no-delay instances is 1000.287second # [ 0.004920] fsl-mc MSI: its@8080000 domain created288second # [ 0.005069] EFI services will not be available.289second # [ 0.005160] smp: Bringing up secondary CPUs ...290second # [ 0.005185] smp: Brought up 1 node, 1 CPU291second # [ 0.005190] SMP: Total of 1 processors activated.292second # [ 0.005192] CPU: All CPU(s) started at EL1293second # [ 0.005204] CPU features: detected: 32-bit EL0 Support294second # [ 0.005206] CPU features: detected: Data cache clean to the PoU not required for I/D coherence295second # [ 0.005209] CPU features: detected: Common not Private translations296second # [ 0.005212] CPU features: detected: CRC32 instructions297second # [ 0.005214] CPU features: detected: Data cache clean to Point of Persistence298test # [ 0.087290] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages299test # [ 0.087315] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page300test # [ 0.087320] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages301test # [ 0.087326] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page302test # [ 0.087329] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages303test # [ 0.087332] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page304test # [ 0.087335] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages305second # [ 0.005217] CPU features: detected: Enhanced Virtualization Traps306test # [ 0.087338] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page307second # [ 0.005227] CPU features: detected: RCpc load-acquire (LDAPR)308second # [ 0.005230] CPU features: detected: LSE atomic instructions309second # [ 0.005231] CPU features: detected: Privileged Access Never310second # [ 0.005233] CPU features: detected: PMUv3311second # [ 0.005235] CPU features: detected: RAS Extension Support312second # [ 0.005240] CPU features: detected: Speculative Store Bypassing Safe (SSBS)313second # [ 0.005261] alternatives: applying system-wide alternatives314second # [ 0.006676] CPU features: detected: Hardware dirty bit management on CPU0315second # [ 0.006877] Memory: 891460K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115792K reserved, 32768K cma-reserved)316second # [ 0.007289] devtmpfs: initialized317second # [ 0.008763] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)318second # [ 0.008785] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).319second # [ 0.008911] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL320second # [ 0.008915] 0 pages in range for non-PLT usage321second # [ 0.008915] 508288 pages in range for PLT usage322second # [ 0.009016] pinctrl core: initialized pinctrl subsystem323test # [ 0.091980] fbcon: Taking over console324test # [ 0.092003] ACPI: Interpreter disabled.325test # [ 0.093187] iommu: Default domain type: Translated326second # [ 0.009752] DMI not present or invalid.327test # [ 0.093197] iommu: DMA domain TLB invalidation policy: strict mode328test # [ 0.094217] SCSI subsystem initialized329test # [ 0.094698] usbcore: registered new interface driver usbfs330test # [ 0.094736] usbcore: registered new interface driver hub331test # [ 0.094745] usbcore: registered new device driver usb332test # [ 0.094952] pps_core: LinuxPPS API ver. 1 registered333second # [ 0.013028] NET: Registered PF_NETLINK/PF_ROUTE protocol family334second # [ 0.015262] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations335second # [ 0.015392] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations336test # [ 0.094960] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>337second # [ 0.015542] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations338test # [ 0.094966] PTP clock support registered339second # [ 0.015559] audit: initializing netlink subsys (disabled)340test # [ 0.094994] EDAC MC: Ver: 3.0.0341second # [ 0.016113] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1342test # [ 0.097797] scmi_core: SCMI protocol bus registered343second # [ 0.016175] thermal_sys: Registered thermal governor 'fair_share'344second # [ 0.016176] thermal_sys: Registered thermal governor 'bang_bang'345second # [ 0.016179] thermal_sys: Registered thermal governor 'step_wise'346second # [ 0.016181] thermal_sys: Registered thermal governor 'user_space'347second # [ 0.016183] thermal_sys: Registered thermal governor 'power_allocator'348second # [ 0.016210] cpuidle: using governor ladder349second # [ 0.016216] cpuidle: using governor menu350second # [ 0.016331] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.351second # [ 0.016351] ASID allocator initialised with 32768 entries352second # [ 0.017001] Serial: AMBA PL011 UART driver353second # [ 0.020032] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1354second # [ 0.020180] printk: console [ttyAMA0] enabled355test # [ 0.103256] FPGA manager framework356test # [ 0.104201] vgaarb: loaded357test # [ 0.104619] clocksource: Switched to clocksource arch_sys_counter358test # [ 0.105175] VFS: Disk quotas dquot_6.6.0359test # [ 0.105207] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360test # [ 0.106693] netfs: FS-Cache loaded361test # [ 0.106798] pnp: PnP ACPI: disabled362second # [ 0.089351] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages363second # [ 0.089376] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page364second # [ 0.089380] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages365second # [ 0.089386] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page366second # [ 0.089389] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages367second # [ 0.089392] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page368second # [ 0.089395] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages369test # [ 0.109294] NET: Registered PF_INET protocol family370second # [ 0.089398] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page371test # [ 0.109477] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)372second # [ 0.101762] fbcon: Taking over console373second # [ 0.101785] ACPI: Interpreter disabled.374second # [ 0.102986] iommu: Default domain type: Translated375second # [ 0.102997] iommu: DMA domain TLB invalidation policy: strict mode376second # [ 0.104109] SCSI subsystem initialized377second # [ 0.104634] usbcore: registered new interface driver usbfs378second # [ 0.104674] usbcore: registered new interface driver hub379second # [ 0.104684] usbcore: registered new device driver usb380second # [ 0.104881] pps_core: LinuxPPS API ver. 1 registered381second # [ 0.104886] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>382second # [ 0.104893] PTP clock support registered383second # [ 0.104923] EDAC MC: Ver: 3.0.0384second # [ 0.107812] scmi_core: SCMI protocol bus registered385second # [ 0.108489] FPGA manager framework386second # [ 0.109562] vgaarb: loaded387second # [ 0.115305] clocksource: Switched to clocksource arch_sys_counter388second # [ 0.115938] VFS: Disk quotas dquot_6.6.0389second # [ 0.115969] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390second # [ 0.117529] netfs: FS-Cache loaded391second # [ 0.117657] pnp: PnP ACPI: disabled392second # [ 0.120159] NET: Registered PF_INET protocol family393second # [ 0.120375] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)394test # [ 0.141959] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)395test # [ 0.141991] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)396test # [ 0.142005] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)397test # [ 0.142045] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)398test # [ 0.142113] TCP: Hash tables configured (established 8192 bind 8192)399test # [ 0.142210] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)400test # [ 0.142239] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)401test # [ 0.142293] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)402test # [ 0.142434] NET: Registered PF_UNIX/PF_LOCAL protocol family403test # [ 0.142475] NET: Registered PF_XDP protocol family404test # [ 0.142492] PCI: CLS 0 bytes, default 64405test # [ 0.147508] Trying to unpack rootfs image as initramfs...406test # [ 0.153148] kvm [1]: HYP mode not available407second # [ 0.145221] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)408second # [ 0.145253] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)409second # [ 0.145267] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)410second # [ 0.145304] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)411second # [ 0.145372] TCP: Hash tables configured (established 8192 bind 8192)412second # [ 0.145472] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)413second # [ 0.145530] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)414second # [ 0.145554] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)415second # [ 0.145668] NET: Registered PF_UNIX/PF_LOCAL protocol family416second # [ 0.145709] NET: Registered PF_XDP protocol family417second # [ 0.145725] PCI: CLS 0 bytes, default 64418second # [ 0.145934] Trying to unpack rootfs image as initramfs...419second # [ 0.159895] kvm [1]: HYP mode not available420test # [ 0.216993] Initialise system trusted keyrings421test # [ 0.217459] workingset: timestamp_bits=42 max_order=18 bucket_order=0422test # [ 0.218359] squashfs: version 4.0 (2009/01/31) Phillip Lougher423test # [ 0.218846] 9p: Installing v9fs 9p2000 file system support424test # [ 0.241887] Key type asymmetric registered425test # [ 0.241914] Asymmetric key parser 'x509' registered426second # [ 0.222315] Initialise system trusted keyrings427test # [ 0.241974] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)428second # [ 0.222800] workingset: timestamp_bits=42 max_order=18 bucket_order=0429test # [ 0.243226] io scheduler mq-deadline registered430test # [ 0.243237] io scheduler kyber registered431second # [ 0.223745] squashfs: version 4.0 (2009/01/31) Phillip Lougher432second # [ 0.224232] 9p: Installing v9fs 9p2000 file system support433test # [ 0.252863] pl061_gpio 9030000.pl061: PL061 GPIO chip registered434test # [ 0.253686] ledtrig-cpu: registered to indicate activity on CPUs435test # [ 0.254100] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:436test # [ 0.254133] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000437test # [ 0.254171] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000438test # [ 0.254177] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000439test # [ 0.254222] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits440test # [ 0.254268] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]441test # [ 0.254375] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00442test # [ 0.254412] pci_bus 0000:00: root bus resource [bus 00-ff]443test # [ 0.254417] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]444test # [ 0.254421] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]445test # [ 0.254425] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]446test # [ 0.254555] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint447second # [ 0.247171] Key type asymmetric registered448second # [ 0.247195] Asymmetric key parser 'x509' registered449second # [ 0.247253] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)450second # [ 0.248562] io scheduler mq-deadline registered451second # [ 0.248571] io scheduler kyber registered452test # [ 0.255182] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint453test # [ 0.255308] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]454test # [ 0.255319] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]455test # [ 0.255340] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]456test # [ 0.255351] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]457test # [ 0.255649] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint458test # [ 0.255769] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]459test # [ 0.255780] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]460test # [ 0.255799] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]461test # [ 0.256093] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint462test # [ 0.256213] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]463test # [ 0.256224] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]464test # [ 0.256245] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]465test # [ 0.256533] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint466test # [ 0.256672] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]467test # [ 0.256684] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]468test # [ 0.256704] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]469test # [ 0.257001] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint470test # [ 0.257118] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]471test # [ 0.257130] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]472test # [ 0.257149] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]473test # [ 0.257437] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint474test # [ 0.257557] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]475test # [ 0.257568] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]476test # [ 0.257589] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]477test # [ 0.257891] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint478test # [ 0.258011] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]479test # [ 0.258022] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]480test # [ 0.258043] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]481test # [ 0.258058] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]482test # [ 0.258348] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint483test # [ 0.258469] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]484test # [ 0.258489] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]485test # [ 0.258807] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint486test # [ 0.258933] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]487test # [ 0.258953] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]488test # [ 0.259206] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint489test # [ 0.259321] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]490test # [ 0.259495] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint491test # [ 0.259703] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]492test # [ 0.259718] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]493second # [ 0.258142] pl061_gpio 9030000.pl061: PL061 GPIO chip registered494second # [ 0.258461] ledtrig-cpu: registered to indicate activity on CPUs495test # [ 0.259738] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]496second # [ 0.258860] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:497second # [ 0.258883] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000498second # [ 0.258902] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000499second # [ 0.258908] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000500test # [ 0.260049] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint501test # [ 0.260169] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]502test # [ 0.260180] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]503test # [ 0.260201] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]504test # [ 0.260597] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned505second # [ 0.258933] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits506test # [ 0.260607] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned507second # [ 0.258960] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]508test # [ 0.260612] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned509second # [ 0.259029] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00510second # [ 0.259047] pci_bus 0000:00: root bus resource [bus 00-ff]511second # [ 0.259051] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]512second # [ 0.259055] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]513second # [ 0.259059] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]514second # [ 0.259154] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint515second # [ 0.259563] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint516second # [ 0.259694] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]517second # [ 0.259707] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]518second # [ 0.259727] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]519second # [ 0.259738] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]520second # [ 0.260037] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint521second # [ 0.260159] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]522second # [ 0.260171] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]523second # [ 0.260195] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]524second # [ 0.260488] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint525second # [ 0.260610] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]526second # [ 0.260621] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]527second # [ 0.260643] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]528test # [ 0.296717] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned529second # [ 0.260946] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint530second # [ 0.261067] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]531second # [ 0.261079] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]532second # [ 0.261099] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]533second # [ 0.261403] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint534second # [ 0.261522] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]535second # [ 0.261534] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]536test # [ 0.296761] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned537second # [ 0.261554] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]538test # [ 0.296795] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned539test # [ 0.296827] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned540test # [ 0.296859] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned541test # [ 0.296890] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned542test # [ 0.296923] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned543test # [ 0.296954] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned544test # [ 0.296987] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned545test # [ 0.297047] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned546test # [ 0.297078] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned547test # [ 0.297177] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned548test # [ 0.297193] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned549test # [ 0.297207] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned550second # [ 0.261844] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint551second # [ 0.261964] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]552second # [ 0.261994] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]553second # [ 0.262014] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]554second # [ 0.262311] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint555test # [ 0.297221] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned556second # [ 0.262433] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]557second # [ 0.262444] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]558second # [ 0.262465] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559second # [ 0.262478] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]560test # [ 0.297234] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned561second # [ 0.262794] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint562test # [ 0.297249] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned563second # [ 0.262920] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]564test # [ 0.297263] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned565second # [ 0.262939] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]566test # [ 0.297277] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned567second # [ 0.263251] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint568test # [ 0.297291] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned569second # [ 0.263374] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]570test # [ 0.297305] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned571second # [ 0.263395] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]572test # [ 0.297319] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned573second # [ 0.263658] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint574test # [ 0.297333] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned575second # [ 0.263776] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]576test # [ 0.297347] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned577second # [ 0.263960] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint578test # [ 0.297360] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned579second # [ 0.264252] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]580test # [ 0.297374] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned581second # [ 0.264265] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]582test # [ 0.297388] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned583second # [ 0.264285] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]584test # [ 0.297408] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned585test # [ 0.297422] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned586second # [ 0.264596] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint587test # [ 0.297436] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned588second # [ 0.264718] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]589test # [ 0.297449] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned590second # [ 0.264730] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]591test # [ 0.297469] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]592second # [ 0.264750] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]593test # [ 0.297476] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]594second # [ 0.265136] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned595test # [ 0.297480] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]596second # [ 0.265147] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned597test # [ 0.298203] pci 0000:00:0a.0: enabling device (0000 -> 0002)598second # [ 0.265152] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned599second # [ 0.265184] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned600second # [ 0.265215] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned601second # [ 0.265245] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned602second # [ 0.265275] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned603second # [ 0.265305] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned604second # [ 0.265335] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned605second # [ 0.265366] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned606second # [ 0.265396] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned607second # [ 0.265427] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned608second # [ 0.265513] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned609second # [ 0.265550] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned610second # [ 0.265565] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned611second # [ 0.265579] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned612second # [ 0.265592] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned613second # [ 0.265606] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned614second # [ 0.265619] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned615second # [ 0.265633] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned616second # [ 0.265647] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned617second # [ 0.265660] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned618second # [ 0.265674] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned619second # [ 0.265688] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned620second # [ 0.265702] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned621second # [ 0.265715] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned622second # [ 0.265729] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned623second # [ 0.265742] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned624second # [ 0.265756] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned625second # [ 0.265769] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned626second # [ 0.265787] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned627second # [ 0.265801] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned628second # [ 0.265814] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned629second # [ 0.265828] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned630second # [ 0.265846] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]631second # [ 0.265852] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]632second # [ 0.265856] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]633test # [ 0.329235] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)634test # [ 0.331025] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)635test # [ 0.332844] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)636test # [ 0.334690] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)637second # [ 0.318749] pci 0000:00:0a.0: enabling device (0000 -> 0002)638test # [ 0.336564] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)639second # [ 0.325104] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)640test # [ 0.345719] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)641test # [ 0.347511] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)642second # [ 0.335025] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)643second # [ 0.337799] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)644test # [ 0.357546] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)645test # [ 0.359928] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)646test # [ 0.365625] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)647second # [ 0.346954] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)648second # [ 0.348959] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)649test # [ 0.367667] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)650second # [ 0.352245] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)651second # [ 0.353938] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)652test # [ 0.379235] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled653test # [ 0.380613] msm_serial: driver initialized654test # [ 0.380720] SuperH (H)SCI(F) driver initialized655test # [ 0.380757] STM32 USART driver initialized656second # [ 0.367022] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)657second # [ 0.368990] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)658second # [ 0.371454] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)659second # [ 0.373354] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)660test # [ 0.402759] loop: module loaded661test # [ 0.402952] virtio_blk virtio5: 1/0/0 default/read/poll queues662test # [ 0.403521] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)663second # [ 0.386680] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled664second # [ 0.388073] msm_serial: driver initialized665second # [ 0.388175] SuperH (H)SCI(F) driver initialized666second # [ 0.388209] STM32 USART driver initialized667test # [ 0.408971] megasas: 07.734.00.00-rc1668test # [ 0.409436] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]669test # [ 0.421522] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000670test # [ 0.421559] Intel/Sharp Extended Query Table at 0x0031671test # [ 0.423189] Using buffer write method672test # [ 0.423226] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]673test # [ 0.432639] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000674test # [ 0.432664] Intel/Sharp Extended Query Table at 0x0031675test # [ 0.434182] Using buffer write method676second # [ 0.414166] loop: module loaded677test # [ 0.434206] Concatenating MTD devices:678second # [ 0.414299] virtio_blk virtio5: 1/0/0 default/read/poll queues679test # [ 0.434209] (0): "0.flash"680second # [ 0.414843] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)681test # [ 0.434212] (1): "0.flash"682test # [ 0.434215] into device "0.flash"683second # [ 0.418403] megasas: 07.734.00.00-rc1684second # [ 0.418866] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]685second # [ 0.425446] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000686second # [ 0.425482] Intel/Sharp Extended Query Table at 0x0031687second # [ 0.431546] Using buffer write method688second # [ 0.431615] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]689second # [ 0.433202] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000690second # [ 0.433222] Intel/Sharp Extended Query Table at 0x0031691second # [ 0.443770] Using buffer write method692second # [ 0.443801] Concatenating MTD devices:693second # [ 0.443804] (0): "0.flash"694second # [ 0.443807] (1): "0.flash"695second # [ 0.443810] into device "0.flash"696test # [ 0.641545] Freeing initrd memory: 26996K697test # [ 0.648256] tun: Universal TUN/TAP device driver, 1.6698test # [ 0.650857] thunder_xcv, ver 1.0699test # [ 0.650882] thunder_bgx, ver 1.0700test # [ 0.650893] nicpf, ver 1.0701test # [ 0.651180] e1000: Intel(R) PRO/1000 Network Driver702test # [ 0.651187] e1000: Copyright (c) 1999-2006 Intel Corporation.703test # [ 0.651201] e1000e: Intel(R) PRO/1000 Network Driver704test # [ 0.651207] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.705test # [ 0.651220] igb: Intel(R) Gigabit Ethernet Network Driver706test # [ 0.651223] igb: Copyright (c) 2007-2014 Intel Corporation.707test # [ 0.651238] igbvf: Intel(R) Gigabit Virtual Function Network Driver708test # [ 0.651241] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.709test # [ 0.651302] sky2: driver version 1.30710test # [ 0.652083] usbcore: registered new interface driver usb-storage711test # [ 0.652127] usbcore: registered new interface driver usbserial_generic712test # [ 0.652135] usbserial: USB Serial support registered for generic713test # [ 0.652413] hv_vmbus: registering driver hyperv_keyboard714test # [ 0.659256] ehci-pci 0000:00:0a.0: EHCI Host Controller715test # [ 0.659294] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1716test # [ 0.659563] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000717test # [ 0.661084] rtc-pl031 9010000.pl031: registered as rtc0718test # [ 0.661123] rtc-pl031 9010000.pl031: setting system clock to 2026-08-13T05:09:23 UTC (1786597763)719test # [ 0.661296] i2c_dev: i2c /dev entries driver720test # [ 0.663975] sdhci: Secure Digital Host Controller Interface driver721test # [ 0.663990] sdhci: Copyright(c) Pierre Ossman722test # [ 0.664122] Synopsys Designware Multimedia Card Interface Driver723test # [ 0.664285] sdhci-pltfm: SDHCI platform and OF driver helper724test # [ 0.666843] hid: raw HID events driver (C) Jiri Kosina725test # [ 0.666993] usbcore: registered new interface driver usbhid726test # [ 0.666998] usbhid: USB HID core driver727test # [ 0.668690] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00728second # [ 0.646302] Freeing initrd memory: 26992K729test # [ 0.669102] hub 1-0:1.0: USB hub found730test # [ 0.669175] hub 1-0:1.0: 6 ports detected731test # [ 0.670479] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available732test # [ 0.671266] drop_monitor: Initializing network drop monitor service733test # [ 0.671380] NET: Registered PF_INET6 protocol family734second # [ 0.653230] tun: Universal TUN/TAP device driver, 1.6735test # [ 0.673448] Segment Routing with IPv6736test # [ 0.673474] In-situ OAM (IOAM) with IPv6737test # [ 0.673531] NET: Registered PF_PACKET protocol family738test # [ 0.674541] 9pnet: Installing 9P2000 support739test # [ 0.676032] Key type dns_resolver registered740second # [ 0.655790] thunder_xcv, ver 1.0741second # [ 0.655817] thunder_bgx, ver 1.0742second # [ 0.655829] nicpf, ver 1.0743second # [ 0.656112] e1000: Intel(R) PRO/1000 Network Driver744second # [ 0.656119] e1000: Copyright (c) 1999-2006 Intel Corporation.745second # [ 0.656133] e1000e: Intel(R) PRO/1000 Network Driver746second # [ 0.656139] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.747test # [ 0.679541] registered taskstats version 1748test # [ 0.679689] Loading compiled-in X.509 certificates749second # [ 0.656152] igb: Intel(R) Gigabit Ethernet Network Driver750second # [ 0.656155] igb: Copyright (c) 2007-2014 Intel Corporation.751second # [ 0.656170] igbvf: Intel(R) Gigabit Virtual Function Network Driver752second # [ 0.656174] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.753second # [ 0.656234] sky2: driver version 1.30754second # [ 0.656981] usbcore: registered new interface driver usb-storage755second # [ 0.657092] usbcore: registered new interface driver usbserial_generic756second # [ 0.657101] usbserial: USB Serial support registered for generic757second # [ 0.657381] hv_vmbus: registering driver hyperv_keyboard758second # [ 0.658327] ehci-pci 0000:00:0a.0: EHCI Host Controller759second # [ 0.658357] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1760test # [ 0.684969] Demotion targets for Node 0: null761second # [ 0.658574] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000762test # [ 0.685044] Key type .fscrypt registered763test # [ 0.685050] Key type fscrypt-provisioning registered764second # [ 0.665927] rtc-pl031 9010000.pl031: registered as rtc0765test # [ 0.685148] ima: No TPM chip found, activating TPM-bypass!766test # [ 0.685161] ima: Allocated hash algorithm: sha1767second # [ 0.665967] rtc-pl031 9010000.pl031: setting system clock to 2026-08-13T05:09:23 UTC (1786597763)768test # [ 0.685206] ima: No architecture policies found769second # [ 0.667185] i2c_dev: i2c /dev entries driver770test # [ 0.687703] input: gpio-keys as /devices/platform/gpio-keys/input/input0771second # [ 0.668833] sdhci: Secure Digital Host Controller Interface driver772second # [ 0.668849] sdhci: Copyright(c) Pierre Ossman773second # [ 0.668978] Synopsys Designware Multimedia Card Interface Driver774second # [ 0.669137] sdhci-pltfm: SDHCI platform and OF driver helper775second # [ 0.670027] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00776second # [ 0.672421] hub 1-0:1.0: USB hub found777second # [ 0.672447] hub 1-0:1.0: 6 ports detected778second # [ 0.673367] hid: raw HID events driver (C) Jiri Kosina779second # [ 0.673516] usbcore: registered new interface driver usbhid780second # [ 0.673521] usbhid: USB HID core driver781second # [ 0.675269] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available782second # [ 0.675981] drop_monitor: Initializing network drop monitor service783second # [ 0.676093] NET: Registered PF_INET6 protocol family784second # [ 0.678204] Segment Routing with IPv6785second # [ 0.678230] In-situ OAM (IOAM) with IPv6786second # [ 0.678276] NET: Registered PF_PACKET protocol family787test # [ 0.697900] clk: Disabling unused clocks788test # [ 0.697926] PM: genpd: Disabling unused power domains789test # [ 0.700977] Freeing unused kernel memory: 4736K790test # [ 0.701059] Run /init as init process791second # [ 0.679374] 9pnet: Installing 9P2000 support792second # [ 0.680918] Key type dns_resolver registered793second # [ 0.684479] registered taskstats version 1794second # [ 0.684652] Loading compiled-in X.509 certificates795second # [ 0.689927] Demotion targets for Node 0: null796second # [ 0.690606] Key type .fscrypt registered797second # [ 0.690618] Key type fscrypt-provisioning registered798second # [ 0.690769] ima: No TPM chip found, activating TPM-bypass!799second # [ 0.690783] ima: Allocated hash algorithm: sha1800second # [ 0.690834] ima: No architecture policies found801second # [ 0.693025] input: gpio-keys as /devices/platform/gpio-keys/input/input0802test # [ 0.718976] systemd[1]: Successfully made /usr/ read-only.803second # [ 0.703114] clk: Disabling unused clocks804second # [ 0.703137] PM: genpd: Disabling unused power domains805second # [ 0.706209] Freeing unused kernel memory: 4736K806second # [ 0.706286] Run /init as init process807second # [ 0.724466] systemd[1]: Successfully made /usr/ read-only.808test # [ 0.920681] usb 1-1: new high-speed USB device number 2 using ehci-pci809second # [ 0.918023] usb 1-1: new high-speed USB device number 2 using ehci-pci810test # [ 1.053339] 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)811test # [ 1.059910] systemd[1]: Detected virtualization qemu.812test # [ 1.061082] systemd[1]: Detected architecture arm64.813test # [ 1.062137] systemd[1]: Running in initrd.814test # [ 1.063754] systemd[1]: Initializing machine ID from random generator.815test # [ 1.065501] systemd[1]: Hostname set to <test>.816test # [ 1.076035] 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/input1817second # [ 1.059133] 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)818second # [ 1.065996] systemd[1]: Detected virtualization qemu.819second # [ 1.067517] systemd[1]: Detected architecture arm64.820second # [ 1.068512] systemd[1]: Running in initrd.821second # [ 1.070467] systemd[1]: Initializing machine ID from random generator.822second # [ 1.072431] systemd[1]: Hostname set to <second>.823second # [ 1.082214] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1824test # [ 1.152809] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0825second # [ 1.170187] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0826test # [ 1.272665] usb 1-2: new high-speed USB device number 3 using ehci-pci827second # [ 1.290017] usb 1-2: new high-speed USB device number 3 using ehci-pci828test # [ 1.341786] systemd[1]: bpf-restrict-fs: LSM BPF program attached829second # [ 1.346878] systemd[1]: bpf-restrict-fs: LSM BPF program attached830test # [ 1.431485] 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/input2831test # [ 1.436762] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0832test # [ 1.438949] systemd[1]: Queued start job for default target Initrd Default Target.833second # [ 1.421317] systemd[1]: Queued start job for default target Initrd Default Target.834test # [ 1.451505] systemd[1]: Created slice Slice /system/modprobe.835second # [ 1.432094] systemd[1]: Created slice Slice /system/modprobe.836second # [ 1.433076] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.837test # [ 1.452692] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.838test # [ 1.453967] systemd[1]: Expecting device /dev/disk/by-label/nixos...839second # [ 1.434125] systemd[1]: Expecting device /dev/disk/by-label/nixos...840second # [ 1.435036] systemd[1]: Reached target Path Units.841test # [ 1.454899] systemd[1]: Reached target Path Units.842second # [ 1.435720] systemd[1]: Reached target Slice Units.843test # [ 1.456204] systemd[1]: Reached target Slice Units.844test # [ 1.457103] systemd[1]: Reached target Swaps.845test # [ 1.457635] systemd[1]: Reached target Timer Units.846second # [ 1.436331] systemd[1]: Reached target Swaps.847second # [ 1.436879] systemd[1]: Reached target Timer Units.848second # [ 1.437673] systemd[1]: Listening on D-Bus System Message Bus Socket.849test # [ 1.458506] systemd[1]: Listening on D-Bus System Message Bus Socket.850second # [ 1.439114] systemd[1]: Listening on Journal Socket (/dev/log).851test # [ 1.459446] systemd[1]: Listening on Journal Socket (/dev/log).852second # [ 1.440026] systemd[1]: Listening on Journal Sockets.853test # [ 1.460279] systemd[1]: Listening on Journal Sockets.854second # [ 1.440783] systemd[1]: Listening on udev Control Socket.855second # [ 1.441870] systemd[1]: Listening on udev Kernel Socket.856test # [ 1.461185] systemd[1]: Listening on udev Control Socket.857test # [ 1.461335] systemd[1]: Listening on udev Kernel Socket.858second # [ 1.442698] systemd[1]: Reached target Socket Units.859test # [ 1.461372] systemd[1]: Reached target Socket Units.860test # [ 1.464574] systemd[1]: Starting Create List of Static Device Nodes...861second # [ 1.445067] systemd[1]: Starting Create List of Static Device Nodes...862second # [ 1.449183] systemd[1]: Starting Load Kernel Module 9pnet_virtio...863test # [ 1.472751] systemd[1]: Starting Load Kernel Module 9pnet_virtio...864second # [ 1.449252] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs865test # [ 1.472817] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs866second # [ 1.454149] 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/input2867second # [ 1.454303] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0868test # [ 1.480302] systemd[1]: Mounting Kernel Configuration File System...869second # [ 1.462336] systemd[1]: Mounting Kernel Configuration File System...870test # [ 1.493053] systemd[1]: Starting Journal Service...871test # [ 1.504766] systemd[1]: Starting Load Kernel Modules...872test # [ 1.505432] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os873second # [ 1.490565] systemd[1]: Starting Journal Service...874second # [ 1.495123] systemd[1]: Starting Load Kernel Modules...875test # [ 1.515568] systemd[1]: Starting Coldplug All udev Devices...876second # [ 1.495775] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os877second # [ 1.501265] systemd[1]: Starting Coldplug All udev Devices...878test # [ 1.532966] systemd[1]: Finished Create List of Static Device Nodes.879test # [ 1.533864] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.880test # [ 1.534060] systemd[1]: Finished Load Kernel Module 9pnet_virtio.881test # [ 1.534273] systemd[1]: Mounted Kernel Configuration File System.882second # [ 1.518123] systemd[1]: Finished Create List of Static Device Nodes.883second # [ 1.519531] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.884second # [ 1.519761] systemd[1]: Finished Load Kernel Module 9pnet_virtio.885second # [ 1.526358] systemd[1]: Mounted Kernel Configuration File System.886test # [ 1.545032] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...887second # [ 1.533962] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...888test # [ 1.567820] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.889test # [ 1.576276] systemd-journald[73]: Collecting audit messages is disabled.890second # [ 1.564707] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.891second # [ 1.566986] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.892second # [ 1.570297] systemd[1]: Starting Create Static Device Nodes in /dev...893test # [ 1.591167] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev894second # [ 1.575222] systemd-journald[73]: Collecting audit messages is disabled.895second # [ 1.575759] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev896test # [ 1.597088] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.897test # [ 1.600891] systemd[1]: Starting Create Static Device Nodes in /dev...898second # [ 1.585289] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0899second # [ 1.585498] [drm] features: -virgl +edid -resource_blob -host_visible900second # [ 1.585504] [drm] features: -context_init901second # [ 1.585937] [drm] number of scanouts: 1902second # [ 1.585951] [drm] number of cap sets: 0903test # [ 1.610495] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0904test # [ 1.610704] [drm] features: -virgl +edid -resource_blob -host_visible905test # [ 1.610709] [drm] features: -context_init906test # [ 1.611157] [drm] number of scanouts: 1907test # [ 1.611172] [drm] number of cap sets: 0908second # [ 1.605381] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic909second # [ 1.605397] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0910test # [ 1.623250] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic911second # [ 1.611527] systemd[1]: Finished Create Static Device Nodes in /dev.912test # [ 1.623266] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0913second # [ 1.611705] systemd[1]: Reached target Preparation for Local File Systems.914second # [ 1.611734] systemd[1]: Reached target Local File Systems.915test # [ 1.634178] systemd[1]: Finished Create Static Device Nodes in /dev.916test # [ 1.634480] systemd[1]: Reached target Preparation for Local File Systems.917test # [ 1.634514] systemd[1]: Reached target Local File Systems.918second # [ 1.618219] systemd[1]: Starting Rule-based Manager for Device Events and Files...919test # [ 1.640930] systemd[1]: Starting Rule-based Manager for Device Events and Files...920second # [ 1.626615] Console: switching to colour frame buffer device 160x50921second # [ 1.629615] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device922test # [ 1.651603] Console: switching to colour frame buffer device 160x50923test # [ 1.652148] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device924test # [ 1.668838] systemd[1]: Finished Load Kernel Modules.925second # [ 1.649399] systemd[1]: Finished Load Kernel Modules.926test # [ 1.671040] systemd[1]: Starting Apply Kernel Variables...927second # [ 1.650558] systemd[1]: Starting Apply Kernel Variables...928test # [ 1.672397] systemd-modules-load[74]: Inserted module 'dm_mod'929test # [ 1.673237] systemd-modules-load[74]: Module 'virtio_balloon' is built in930test # [ 1.673891] systemd-modules-load[74]: Module 'virtio_console' is built in931test # [ 1.674559] systemd-modules-load[74]: Inserted module 'virtio_gpu'932test # [ 1.675191] systemd-modules-load[74]: Module 'virtio_rng' is built in933test # [ 1.680826] systemd[1]: Started Journal Service.934second # [ 1.665949] systemd[1]: Started Journal Service.935second # [ 1.661576] systemd-modules-load[74]: Inserted module 'dm_mod'936second # [ 1.662425] systemd-modules-load[74]: Module 'virtio_balloon' is built in937second # [ 1.663066] systemd-modules-load[74]: Module 'virtio_console' is built in938second # [ 1.663684] systemd-modules-load[74]: Inserted module 'virtio_gpu'939second # [ 1.676381] systemd-modules-load[74]: Module 'virtio_rng' is built in940second # [ 1.677066] systemd[1]: Starting Create System Files and Directories...941test # [ 1.700117] systemd[1]: Starting Create System Files and Directories...942second # [ 1.687656] systemd[1]: Finished Apply Kernel Variables.943test # [ 1.712698] systemd[1]: Finished Apply Kernel Variables.944second # [ 1.698812] systemd-udevd[80]: Using default interface naming scheme 'v261'.945test # [ 1.725376] systemd-udevd[79]: Using default interface naming scheme 'v261'.946test # [ 1.735737] systemd[1]: Finished Create System Files and Directories.947second # [ 1.717038] systemd[1]: Finished Create System Files and Directories.948second # [ 1.727989] systemd[1]: Started Rule-based Manager for Device Events and Files.949test # [ 1.752501] systemd[1]: Started Rule-based Manager for Device Events and Files.950test # [ 1.799766] systemd[1]: Starting Virtual Console Setup...951second # [ 1.783823] systemd[1]: Starting Virtual Console Setup...952test # [ 1.836960] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.953test # [ 1.838710] systemd[1]: Finished Virtual Console Setup.954second # [ 1.828349] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.955second # [ 1.830640] systemd[1]: Finished Virtual Console Setup.956test # [ 2.036947] systemd[1]: Finished Coldplug All udev Devices.957test # [ 2.037499] systemd[1]: Reached target System Initialization.958test # [ 2.037969] systemd[1]: Reached target Basic System.959second # [ 2.036555] systemd[1]: Finished Coldplug All udev Devices.960second # [ 2.037132] systemd[1]: Reached target System Initialization.961second # [ 2.037590] systemd[1]: Reached target Basic System.962test # [ 2.130356] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.963test # [ 2.157573] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.964second # [ 2.135962] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.965second # [ 2.155655] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.966test # [ 2.232108] systemd[1]: Found device /dev/disk/by-label/nixos.967test # [ 2.233751] systemd[1]: Reached target Initrd Root Device.968test # [ 2.236494] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969second # [ 2.231604] systemd[1]: Found device /dev/disk/by-label/nixos.970second # [ 2.235523] systemd[1]: Reached target Initrd Root Device.971second # [ 2.239571] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...972test # [ 2.271565] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks973test # [ 2.277342] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.974second # [ 2.267042] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks975second # [ 2.274327] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.976test # [ 2.527018] systemd[1]: Mounting /sysroot...977second # [ 2.506861] systemd[1]: Mounting /sysroot...978test # [ 2.554270] EXT4-fs (vda): mounted filesystem 2d8032a8-dcb0-49d8-80b2-8d4d34ef7e6e r/w with ordered data mode. Quota mode: none.979test # [ 2.554453] systemd[1]: Mounted /sysroot.980second # [ 2.538429] EXT4-fs (vda): mounted filesystem 49e63f32-6a15-49fd-a4e9-a452f1063dc0 r/w with ordered data mode. Quota mode: none.981test # [ 2.555802] systemd[1]: Reached target Initrd Root File System.982second # [ 2.535654] systemd[1]: Mounted /sysroot.983second # [ 2.536661] systemd[1]: Reached target Initrd Root File System.984test # [ 2.560822] systemd[1]: Mounting /sysroot/nix/.ro-store...985second # [ 2.539688] systemd[1]: Starting Mountpoints Configured in the Real Root...986test # [ 2.572121] systemd[1]: Mounting /sysroot/nix/.rw-store...987second # [ 2.558631] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.988test # [ 2.583131] systemd[1]: Mounting /sysroot/run...989second # [ 2.563619] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...990second # [ 2.566818] systemd[1]: Reloading...991test # [ 2.609482] systemd[1]: Mounting /sysroot/tmp/shared...992test # [ 2.622909] systemd[1]: Mounting /sysroot/tmp/xchg...993test # [ 2.628944] systemd[1]: Starting Mountpoints Configured in the Real Root...994test # [ 2.638008] systemd[1]: Mounted /sysroot/nix/.ro-store.995test # [ 2.638509] systemd[1]: Mounted /sysroot/nix/.rw-store.996test # [ 2.639395] systemd[1]: Mounted /sysroot/run.997test # [ 2.661758] systemd[1]: Starting rw-sysroot-nix-store.service...998test # [ 2.667918] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.999test # [ 2.673750] systemd[1]: Mounted /sysroot/tmp/shared.1000test # [ 2.675172] systemd[1]: Mounted /sysroot/tmp/xchg.1001test # [ 2.682411] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...1002test # [ 2.688121] systemd[1]: Reloading...1003second # [ 2.728243] systemd[1]: Reloading finished in 162 ms.1004second # [ 2.751809] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1005second # [ 2.754061] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1006second # [ 2.757511] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1007second # [ 2.760449] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1008second # [ 2.761815] systemd[1]: Finished Mountpoints Configured in the Real Root.1009second # [ 2.763298] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1010second # [ 2.776248] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1011second # [ 2.777817] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1012test # [ 2.863811] systemd[1]: Reloading finished in 179 ms.1013test # [ 2.884736] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...1014test # [ 2.887158] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1015test # [ 2.890852] systemd[1]: Finished rw-sysroot-nix-store.service.1016test # [ 2.891377] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...1017test # [ 2.898961] systemd[1]: Starting rw-sysroot-nix-store.service...1018test # [ 2.902333] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019test # [ 2.904126] systemd[1]: Finished Mountpoints Configured in the Real Root.1020test # [ 2.906486] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1021test # [ 2.921601] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1022test # [ 2.922456] systemd[1]: Finished rw-sysroot-nix-store.service.1023second # [ 2.955909] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory1024second # [ 2.960231] (udev-worker)[102]: 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 directory1025second # [ 2.973403] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1026second # [ 2.974584] systemd[1]: Stopped Virtual Console Setup.1027second # [ 2.976452] systemd[1]: Stopping Virtual Console Setup...1028second # [ 2.980065] systemd[1]: Starting Virtual Console Setup...1029second # [ 2.998756] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones.1030second # [ 3.000397] systemd[1]: Finished Virtual Console Setup.1031test # [ 3.058640] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory1032test # [ 3.062630] (udev-worker)[102]: 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 directory1033test # [ 3.076916] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1034test # [ 3.078619] systemd[1]: Stopped Virtual Console Setup.1035test # [ 3.079129] systemd[1]: Stopping Virtual Console Setup...1036test # [ 3.082502] systemd[1]: Starting Virtual Console Setup...1037test # [ 3.104815] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.1038test # [ 3.107227] systemd[1]: Finished Virtual Console Setup.1039test # [ 3.526619] systemd[1]: Mounting /sysroot/nix/store...1040second # [ 3.508072] systemd[1]: Mounting /sysroot/nix/.ro-store...1041second # [ 3.517155] systemd[1]: Mounting /sysroot/nix/.rw-store...1042second # [ 3.523314] systemd[1]: Mounting /sysroot/run...1043test # [ 3.551918] systemd[1]: Mounted /sysroot/nix/store.1044test # [ 3.553191] systemd[1]: Reached target Initrd File Systems.1045second # [ 3.532108] systemd[1]: Mounting /sysroot/tmp/shared...1046test # [ 3.554903] systemd[1]: Starting Find NixOS closure...1047test # [ 3.560249] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1048second # [ 3.543517] systemd[1]: Mounting /sysroot/tmp/xchg...1049second # [ 3.546910] systemd[1]: Mounted /sysroot/run.1050second # [ 3.551283] systemd[1]: Mounted /sysroot/nix/.ro-store.1051second # [ 3.554037] systemd[1]: Mounted /sysroot/nix/.rw-store.1052test # [ 3.583164] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1053test # [ 3.583844] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1054second # [ 3.567262] systemd[1]: Starting rw-sysroot-nix-store.service...1055test # [ 3.593493] systemd[1]: Finished Find NixOS closure.1056second # [ 3.571929] systemd[1]: Mounted /sysroot/tmp/xchg.1057test # [ 3.594570] systemd[1]: Reached target Initrd Default Target.1058test # [ 3.596351] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1059second # [ 3.578311] systemd[1]: Mounted /sysroot/tmp/shared.1060second # [ 3.581176] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1061second # [ 3.582076] systemd[1]: Finished rw-sysroot-nix-store.service.1062test # [ 3.619622] systemd[1]: initrd-cleanup.service: Deactivated successfully.1063test # [ 3.620601] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1064test # [ 3.622969] systemd[1]: Stopped target Initrd Default Target.1065test # [ 3.623464] systemd[1]: Stopped target Basic System.1066test # [ 3.623859] systemd[1]: Stopped target Initrd Root Device.1067test # [ 3.624655] systemd[1]: Stopped target Path Units.1068test # [ 3.626470] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1069test # [ 3.627083] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1070test # [ 3.627821] systemd[1]: Stopped target Slice Units.1071test # [ 3.629062] systemd[1]: Stopped target Socket Units.1072test # [ 3.632171] systemd[1]: Stopped target System Initialization.1073test # [ 3.632672] systemd[1]: Stopped target Swaps.1074test # [ 3.633032] systemd[1]: Stopped target Timer Units.1075test # [ 3.633423] systemd[1]: dbus.socket: Deactivated successfully.1076test # [ 3.633876] systemd[1]: Closed D-Bus System Message Bus Socket.1077test # [ 3.634429] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1078test # [ 3.636134] systemd[1]: Stopped Find NixOS closure.1079test # [ 3.636569] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1080test # [ 3.639477] systemd[1]: Starting rw-sysroot-nix-store.service...1081test # [ 3.640089] systemd[1]: systemd-sysctl.service: Deactivated successfully.1082test # [ 3.640689] systemd[1]: Stopped Apply Kernel Variables.1083test # [ 3.641210] systemd[1]: systemd-modules-load.service: Deactivated successfully.1084test # [ 3.643419] systemd[1]: Stopped Load Kernel Modules.1085test # [ 3.649892] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1086test # [ 3.650640] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1087test # [ 3.651322] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1088test # [ 3.651888] systemd[1]: Stopped Create System Files and Directories.1089test # [ 3.657968] systemd[1]: Stopped target Local File Systems.1090test # [ 3.659151] systemd[1]: Stopped target Preparation for Local File Systems.1091test # [ 3.661615] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1092test # [ 3.662878] systemd[1]: Stopped Coldplug All udev Devices.1093test # [ 3.663357] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1094test # [ 3.663924] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1095test # [ 3.667622] systemd[1]: Stopped Virtual Console Setup.1096test # [ 3.668295] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1097test # [ 3.669347] systemd[1]: Finished rw-sysroot-nix-store.service.1098test # [ 3.672214] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1099test # [ 3.672799] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1100test # [ 3.673252] systemd[1]: systemd-udevd.service: Deactivated successfully.1101test # [ 3.673744] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1102test # [ 3.674389] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1103test # [ 3.674924] systemd[1]: Closed udev Control Socket.1104test # [ 3.675304] systemd[1]: Starting Cleanup udev Database...1105test # [ 3.675710] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1106test # [ 3.677743] systemd[1]: Stopped Create Static Device Nodes in /dev.1107test # [ 3.678298] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1108test # [ 3.678902] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1109test # [ 3.679436] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1110test # [ 3.679956] systemd[1]: Stopped Create List of Static Device Nodes.1111test # [ 3.700507] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1112test # [ 3.701159] systemd[1]: Finished Cleanup udev Database.1113test # [ 3.701590] systemd[1]: Reached target Switch Root.1114test # [ 3.704836] systemd[1]: Starting NixOS Activation...1115test # [ 3.819887] initrd-nixos-activation-start[179]: booting system configuration /nix/store/q5bj8kjfq9mvsyyc7wbk9ajv4b9mg4ly-nixos-system-test-test1116test # [ 3.870270] initrd-nixos-activation-start[179]: running activation script...1117test # [ 4.314095] initrd-nixos-activation-start[202]: setting up /etc...1118second # [ 4.508065] systemd[1]: Mounting /sysroot/nix/store...1119test # [ 4.549884] initrd-nixos-activation-start[202]: setting up age secrets...1120second # [ 4.553145] systemd[1]: Mounted /sysroot/nix/store.1121second # [ 4.554312] systemd[1]: Reached target Initrd File Systems.1122second # [ 4.556467] systemd[1]: Starting Find NixOS closure...1123second # [ 4.563623] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1124second # [ 4.587828] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1125second # [ 4.591403] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1126second # [ 4.601665] systemd[1]: Finished Find NixOS closure.1127second # [ 4.603582] systemd[1]: Reached target Initrd Default Target.1128second # [ 4.607819] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1129second # [ 4.625407] systemd[1]: Stopped target Initrd Default Target.1130second # [ 4.626563] systemd[1]: Stopped target Basic System.1131second # [ 4.627305] systemd[1]: Stopped target Initrd Root Device.1132second # [ 4.628737] systemd[1]: Stopped target Path Units.1133second # [ 4.629677] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1134second # [ 4.632200] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1135second # [ 4.632909] systemd[1]: Stopped target Slice Units.1136second # [ 4.633553] systemd[1]: Stopped target Socket Units.1137second # [ 4.634942] systemd[1]: Stopped target System Initialization.1138second # [ 4.636119] systemd[1]: Stopped target Swaps.1139second # [ 4.636548] systemd[1]: Stopped target Timer Units.1140second # [ 4.640089] systemd[1]: dbus.socket: Deactivated successfully.1141second # [ 4.640611] systemd[1]: Closed D-Bus System Message Bus Socket.1142second # [ 4.641116] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1143second # [ 4.641724] systemd[1]: Stopped Find NixOS closure.1144second # [ 4.642131] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1145second # [ 4.644425] systemd[1]: Starting rw-sysroot-nix-store.service...1146second # [ 4.645568] systemd[1]: systemd-sysctl.service: Deactivated successfully.1147second # [ 4.649490] systemd[1]: Stopped Apply Kernel Variables.1148second # [ 4.651284] systemd[1]: systemd-modules-load.service: Deactivated successfully.1149second # [ 4.654131] systemd[1]: Stopped Load Kernel Modules.1150second # [ 4.654600] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1151second # [ 4.656251] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1152second # [ 4.658192] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1153second # [ 4.659032] systemd[1]: Stopped Create System Files and Directories.1154second # [ 4.664948] systemd[1]: Stopped target Local File Systems.1155second # [ 4.669670] systemd[1]: Stopped target Preparation for Local File Systems.1156second # [ 4.670390] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1157second # [ 4.671051] systemd[1]: Stopped Coldplug All udev Devices.1158second # [ 4.671518] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1159second # [ 4.675698] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1160second # [ 4.678089] systemd[1]: Stopped Virtual Console Setup.1161second # [ 4.678548] systemd[1]: systemd-udevd.service: Deactivated successfully.1162second # [ 4.679420] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1163second # [ 4.681447] systemd[1]: initrd-cleanup.service: Deactivated successfully.1164second # [ 4.682578] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1165second # [ 4.684291] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1166second # [ 4.687213] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1167second # [ 4.687739] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1168second # [ 4.688441] systemd[1]: Finished rw-sysroot-nix-store.service.1169second # [ 4.688950] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1170second # [ 4.689487] systemd[1]: Closed udev Control Socket.1171second # [ 4.689861] systemd[1]: Starting Cleanup udev Database...1172second # [ 4.690275] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1173second # [ 4.690880] systemd[1]: Stopped Create Static Device Nodes in /dev.1174second # [ 4.691379] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1175second # [ 4.692152] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1176second # [ 4.692763] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1177second # [ 4.693329] systemd[1]: Stopped Create List of Static Device Nodes.1178second # [ 4.716210] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1179second # [ 4.718404] systemd[1]: Finished Cleanup udev Database.1180second # [ 4.718909] systemd[1]: Reached target Switch Root.1181second # [ 4.719703] systemd[1]: Starting NixOS Activation...1182test # [ 4.789780] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1183test # [ 4.791480] systemd[1]: Finished NixOS Activation.1184test # [ 4.795254] systemd[1]: Starting Switch Root...1185test # [ 4.808668] systemd[1]: Switching root.1186second # [ 4.888175] initrd-nixos-activation-start[180]: booting system configuration /nix/store/z1x7nl7l4ihg876a3xsmw51a9f6bnxqx-nixos-system-second-test1187second # [ 4.955928] initrd-nixos-activation-start[180]: running activation script...1188test # [ 4.983189] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1189second # [ 5.414406] initrd-nixos-activation-start[203]: setting up /etc...1190test # [ 5.577082] 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)1191test # [ 5.580640] systemd[1]: Detected virtualization qemu.1192test # [ 5.581813] systemd[1]: Detected architecture arm64.1193test # [ 5.582976] systemd[1]: Detected first boot.1194test # [ 5.587321] systemd[1]: Initializing machine ID from random generator.1195second # [ 5.630551] initrd-nixos-activation-start[203]: setting up age secrets...1196test # [ 5.770902] systemd[1]: bpf-restrict-fs: LSM BPF program attached1197second # [ 5.799311] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1198second # [ 5.801102] systemd[1]: Finished NixOS Activation.1199second # [ 5.801862] systemd[1]: Starting Switch Root...1200second # [ 5.817058] systemd[1]: Switching root.1201test # [ 5.916315] systemd[1]: Applying preset policy.1202second # [ 5.992717] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1203test # [ 6.501374] systemd[1]: Populated /etc with preset unit settings.1204second # [ 6.701497] 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)1205second # [ 6.705212] systemd[1]: Detected virtualization qemu.1206second # [ 6.706488] systemd[1]: Detected architecture arm64.1207second # [ 6.707686] systemd[1]: Detected first boot.1208second # [ 6.711963] systemd[1]: Initializing machine ID from random generator.1209second # [ 6.876130] systemd[1]: bpf-restrict-fs: LSM BPF program attached1210test # [ 7.013167] systemd[1]: initrd-switch-root.service: Deactivated successfully.1211test # [ 7.014014] systemd[1]: Stopped initrd-switch-root.service.1212test # [ 7.015872] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1213test # [ 7.018609] systemd[1]: Created slice Slice /system/getty.1214test # [ 7.019611] systemd[1]: Created slice User and Session Slice.1215test # [ 7.020796] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1216test # [ 7.020894] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1217test # [ 7.020940] systemd[1]: Expecting device /dev/hvc0...1218test # [ 7.020959] systemd[1]: Expecting device /dev/ttyAMA0...1219test # [ 7.021362] systemd[1]: Reached target Local Encrypted Volumes.1220test # [ 7.021659] systemd[1]: Stopped target initrd-fs.target.1221test # [ 7.021945] systemd[1]: Stopped target initrd-root-fs.target.1222test # [ 7.022215] systemd[1]: Stopped target initrd-switch-root.target.1223test # [ 7.022485] systemd[1]: Reached target Virtual Machines and Containers.1224test # [ 7.022782] systemd[1]: Reached target Path Units.1225test # [ 7.023043] systemd[1]: Reached target Remote File Systems.1226test # [ 7.023293] systemd[1]: Reached target Slice Units.1227test # [ 7.023547] systemd[1]: Reached target Swaps.1228second # [ 7.008764] systemd[1]: Applying preset policy.1229test # [ 7.031998] systemd[1]: Listening on Query the User Interactively for a Password.1230test # [ 7.035924] systemd[1]: Listening on Process Core Dump Socket.1231test # [ 7.038984] systemd[1]: Listening on Credential Encryption/Decryption.1232test # [ 7.042201] systemd[1]: Listening on Factory Reset Management.1233test # [ 7.043166] systemd[1]: Listening on Hostname Service Socket.1234test # [ 7.047170] systemd[1]: Starting Journal Log Access Socket...1235test # [ 7.048758] systemd[1]: Listening on Journal Audit Socket.1236test # [ 7.051984] systemd[1]: Listening on Console Output Muting Service Socket.1237test # [ 7.053335] systemd[1]: Listening on Network Management Metrics Varlink Socket.1238test # [ 7.054548] systemd[1]: Listening on Network Management Varlink Socket.1239test # [ 7.056126] systemd[1]: Listening on Network Management Netlink Socket.1240test # [ 7.058285] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1241test # [ 7.059720] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1242test # [ 7.061321] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1243test # [ 7.069561] systemd[1]: Listening on Disk Repartitioning Service Socket.1244test # [ 7.070025] systemd[1]: Listening on Resolve Monitor Varlink Socket.1245test # [ 7.070372] systemd[1]: Listening on Resolve Service Varlink Socket.1246test # [ 7.070724] systemd[1]: Listening on udev Control Socket.1247test # [ 7.071063] systemd[1]: Listening on udev Varlink Socket.1248test # [ 7.075898] systemd[1]: Mounting Huge Pages File System...1249test # [ 7.079334] systemd[1]: Mounting POSIX Message Queue File System...1250test # [ 7.085358] systemd[1]: Mounting Kernel Debug File System...1251test # [ 7.091482] systemd[1]: Mounting Kernel Trace File System...1252test # [ 7.105804] systemd[1]: Starting Create List of Static Device Nodes...1253test # [ 7.114966] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1254test # [ 7.116842] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1255test # [ 7.134167] systemd[1]: Mounting Kernel Configuration File System...1256test # [ 7.137677] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1257test # [ 7.139926] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1258test # [ 7.201694] systemd[1]: Starting Load Kernel Module fuse...1259test # [ 7.207801] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671260test # [ 7.236291] systemd[1]: Starting Journal Service...1261test # [ 7.257136] systemd[1]: Starting Load Kernel Modules...1262test # [ 7.270919] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1263test # [ 7.283278] systemd[1]: Starting Remount Root and Kernel File Systems...1264test # [ 7.285812] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1265test # [ 7.294189] systemd[1]: Starting Coldplug All udev Devices...1266test # [ 7.328091] fuse: init (API version 7.45)1267test # [ 7.336367] systemd[1]: Listening on Journal Log Access Socket.1268test # [ 7.336941] systemd[1]: Mounted Huge Pages File System.1269test # [ 7.337513] systemd[1]: Mounted POSIX Message Queue File System.1270test # [ 7.337905] systemd[1]: Mounted Kernel Debug File System.1271test # [ 7.338267] systemd[1]: Mounted Kernel Trace File System.1272test # [ 7.350044] systemd[1]: Finished Create List of Static Device Nodes.1273test # [ 7.355572] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1274test # [ 7.360834] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1275test # [ 7.361526] systemd[1]: Mounted Kernel Configuration File System.1276test # [ 7.362042] systemd[1]: modprobe@fuse.service: Deactivated successfully.1277test # [ 7.371277] systemd[1]: Finished Load Kernel Module fuse.1278test # [ 7.383296] systemd[1]: Mounting FUSE Control File System...1279test # [ 7.387279] systemd-journald[327]: Collecting audit messages is enabled.1280test # [ 7.401845] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1281test # [ 7.405345] systemd[1]: Queued start job for default target Multi-User System.1282test # [ 7.412793] systemd[1]: Finished Load Kernel Modules.1283test # [ 7.413339] systemd[1]: Started Journal Service.1284test # [ 7.407968] systemd[1]: systemd-journald.service: Deactivated successfully.1285test # [ 7.415161] systemd-modules-load[328]: Module 'atkbd' is built in1286test # [ 7.420441] systemd-modules-load[328]: Module 'ctr' is built in1287test # [ 7.421061] systemd-modules-load[328]: Module 'loop' is built in1288test # [ 7.426897] EXT4-fs (vda): re-mounted 2d8032a8-dcb0-49d8-80b2-8d4d34ef7e6e.1289test # [ 7.442557] systemd[1]: Finished Remount Root and Kernel File Systems.1290test # [ 7.443475] systemd-oomd[329]: No swap; memory pressure usage will be degraded1291test # [ 7.453258] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1292test # [ 7.477411] systemd[1]: Listening on Disk Image Download Service Socket.1293test # [ 7.485953] systemd[1]: Starting Firewall...1294test # [ 7.490178] systemd[1]: Starting Flush Journal to Persistent Storage...1295test # [ 7.492589] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1296second # [ 7.491942] systemd[1]: Populated /etc with preset unit settings.1297test # [ 7.508299] systemd[1]: Starting Load/Save OS Random Seed...1298test # [ 7.545737] systemd[1]: Starting Apply Kernel Variables...1299test # [ 7.546708] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1300test # [ 7.567163] systemd[1]: Mounted FUSE Control File System.1301test # [ 7.593654] systemd-journald[327]: Received client request to flush runtime journal.1302test # [ 7.669756] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1303test # [ 7.677760] systemd[1]: Starting Create Static Device Nodes in /dev...1304test # [ 7.684333] systemd[1]: Finished Load/Save OS Random Seed.1305test # [ 7.685733] systemd[1]: Reached target First Boot Complete.1306test # [ 7.686521] systemd[1]: Finished Flush Journal to Persistent Storage.1307test # [ 7.706373] systemd[1]: Finished Apply Kernel Variables.1308test # [ 7.715375] systemd[1]: Starting Network Name Resolution...1309test # [ 7.750995] systemd[1]: Finished Create Static Device Nodes in /dev.1310test # [ 7.751710] systemd[1]: Reached target Preparation for Local File Systems.1311test # [ 7.759342] systemd[1]: Starting Rule-based Manager for Device Events and Files...1312test # [ 7.883169] systemd-resolved[362]: Positive Trust Anchors:1313test # [ 7.883942] systemd-resolved[362]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1314test # [ 7.888561] systemd-resolved[362]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161315test # [ 7.893271] systemd-resolved[362]: 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 test1316test # [ 7.942842] systemd-udevd[366]: Using default interface naming scheme 'v261'.1317test # [ 8.018159] systemd[1]: Mounting /run/wrappers...1318second # [ 8.049100] systemd[1]: initrd-switch-root.service: Deactivated successfully.1319second # [ 8.050055] systemd[1]: Stopped initrd-switch-root.service.1320second # [ 8.052363] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1321second # [ 8.055133] systemd[1]: Created slice Slice /system/getty.1322second # [ 8.056743] systemd[1]: Created slice User and Session Slice.1323second # [ 8.058104] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1324second # [ 8.059674] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1325second # [ 8.060942] systemd[1]: Expecting device /dev/hvc0...1326second # [ 8.061945] systemd[1]: Expecting device /dev/ttyAMA0...1327second # [ 8.062953] systemd[1]: Reached target Local Encrypted Volumes.1328second # [ 8.064002] systemd[1]: Stopped target initrd-fs.target.1329second # [ 8.064936] systemd[1]: Stopped target initrd-root-fs.target.1330second # [ 8.065915] systemd[1]: Stopped target initrd-switch-root.target.1331second # [ 8.067499] systemd[1]: Reached target Virtual Machines and Containers.1332second # [ 8.069019] systemd[1]: Reached target Path Units.1333second # [ 8.070851] systemd[1]: Reached target Remote File Systems.1334second # [ 8.071753] systemd[1]: Reached target Slice Units.1335second # [ 8.072706] systemd[1]: Reached target Swaps.1336second # [ 8.076496] systemd[1]: Listening on Query the User Interactively for a Password.1337second # [ 8.081176] systemd[1]: Listening on Process Core Dump Socket.1338test # [ 8.098154] systemd[1]: Mounted /run/wrappers.1339second # [ 8.085194] systemd[1]: Listening on Credential Encryption/Decryption.1340test # [ 8.103113] systemd[1]: Reached target Local File Systems.1341second # [ 8.088994] systemd[1]: Listening on Factory Reset Management.1342second # [ 8.090423] systemd[1]: Listening on Hostname Service Socket.1343second # [ 8.095343] systemd[1]: Starting Journal Log Access Socket...1344test # [ 8.111638] systemd[1]: Listening on Boot Loader Control Service Socket.1345second # [ 8.097025] systemd[1]: Listening on Journal Audit Socket.1346test # [ 8.114731] systemd[1]: Starting register-nix-paths.service...1347second # [ 8.101059] systemd[1]: Listening on Console Output Muting Service Socket.1348second # [ 8.102775] systemd[1]: Listening on Network Management Metrics Varlink Socket.1349second # [ 8.104293] systemd[1]: Listening on Network Management Varlink Socket.1350second # [ 8.106092] systemd[1]: Listening on Network Management Netlink Socket.1351second # [ 8.108550] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1352second # [ 8.110276] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1353second # [ 8.112015] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1354test # [ 8.134041] systemd[1]: Starting Create SUID/SGID Wrappers...1355test # [ 8.139008] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1356second # [ 8.122182] systemd[1]: Listening on Disk Repartitioning Service Socket.1357second # [ 8.122736] systemd[1]: Listening on Resolve Monitor Varlink Socket.1358second # [ 8.123079] systemd[1]: Listening on Resolve Service Varlink Socket.1359second # [ 8.123427] systemd[1]: Listening on udev Control Socket.1360second # [ 8.123785] systemd[1]: Listening on udev Varlink Socket.1361second # [ 8.129326] systemd[1]: Mounting Huge Pages File System...1362second # [ 8.133195] systemd[1]: Mounting POSIX Message Queue File System...1363second # [ 8.137225] systemd[1]: Mounting Kernel Debug File System...1364test # [ 8.160728] systemd[1]: Starting Save Transient machine-id to Disk...1365second # [ 8.147571] systemd[1]: Mounting Kernel Trace File System...1366second # [ 8.164962] systemd[1]: Starting Create List of Static Device Nodes...1367test # [ 8.183946] systemd-resolved[362]: Using system hostname 'test'.1368second # [ 8.176978] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1369test # [ 8.196531] systemd[1]: Starting Create System Files and Directories...1370second # [ 8.179976] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1371test # [ 8.199890] systemd[1]: Started Network Name Resolution.1372second # [ 8.192260] systemd[1]: Mounting Kernel Configuration File System...1373second # [ 8.194727] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1374second # [ 8.196723] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1375second # [ 8.219763] systemd[1]: Starting Load Kernel Module fuse...1376second # [ 8.221239] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671377test # [ 8.282289] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1378test # [ 8.292818] systemd[1]: Finished Save Transient machine-id to Disk.1379test # [ 8.368715] systemd[1]: Finished Create System Files and Directories.1380test # [ 8.390469] systemd[1]: Starting Rebuild Journal Catalog...1381test # [ 8.394604] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1382test # [ 8.431809] systemd[1]: Started Rule-based Manager for Device Events and Files.1383second # [ 8.444283] systemd[1]: Starting Journal Service...1384second # [ 8.487841] systemd[1]: Starting Load Kernel Modules...1385test # [ 8.521371] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1386second # [ 8.537371] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1387test # [ 8.566397] systemd[1]: Finished Coldplug All udev Devices.1388second # [ 8.564049] systemd[1]: Starting Remount Root and Kernel File Systems...1389second # [ 8.568330] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1390test # [ 8.606717] systemd[1]: Finished Rebuild Journal Catalog.1391second # [ 8.596501] fuse: init (API version 7.45)1392test # [ 8.617715] systemd[1]: Starting Update is Completed...1393second # [ 8.608843] systemd[1]: Starting Coldplug All udev Devices...1394second # [ 8.614409] systemd-journald[308]: Collecting audit messages is enabled.1395second # [ 8.618107] systemd[1]: Queued start job for default target Multi-User System.1396second # [ 8.621191] systemd[1]: systemd-journald.service: Deactivated successfully.1397second # [ 8.636804] systemd[1]: Started Journal Service.1398second # [ 8.637175] systemd[1]: Listening on Journal Log Access Socket.1399second # [ 8.642857] systemd[1]: Mounted Huge Pages File System.1400second # [ 8.650753] systemd[1]: Mounted POSIX Message Queue File System.1401second # [ 8.656337] systemd-modules-load[309]: Module 'atkbd' is built in1402test # [ 8.680468] systemd[1]: Finished Update is Completed.1403second # [ 8.659930] systemd[1]: Mounted Kernel Debug File System.1404second # [ 8.664681] systemd[1]: Mounted Kernel Trace File System.1405second # [ 8.667281] systemd-modules-load[309]: Module 'ctr' is built in1406second # [ 8.672673] systemd-modules-load[309]: Module 'loop' is built in1407second # [ 8.675287] systemd[1]: Finished Create List of Static Device Nodes.1408second # [ 8.678670] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1409second # [ 8.684914] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1410second # [ 8.685471] systemd[1]: Mounted Kernel Configuration File System.1411second # [ 8.685989] systemd[1]: modprobe@fuse.service: Deactivated successfully.1412second # [ 8.686548] systemd[1]: Finished Load Kernel Module fuse.1413second # [ 8.687017] systemd[1]: Finished Load Kernel Modules.1414second # [ 8.693987] systemd[1]: Mounting FUSE Control File System...1415second # [ 8.703817] EXT4-fs (vda): re-mounted 49e63f32-6a15-49fd-a4e9-a452f1063dc0.1416second # [ 8.704459] systemd[1]: Starting Firewall...1417second # [ 8.724204] systemd[1]: Starting Apply Kernel Variables...1418second # [ 8.751176] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1419second # [ 8.778653] systemd-oomd[311]: No swap; memory pressure usage will be degraded1420second # [ 8.789523] systemd[1]: Finished Remount Root and Kernel File Systems.1421second # [ 8.796793] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1422second # [ 8.817964] systemd[1]: Listening on Disk Image Download Service Socket.1423second # [ 8.824787] systemd[1]: Starting Flush Journal to Persistent Storage...1424second # [ 8.827559] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1425second # [ 8.846459] systemd[1]: Starting Load/Save OS Random Seed...1426second # [ 8.849484] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1427second # [ 8.873024] systemd[1]: Mounted FUSE Control File System.1428test # [ 8.906576] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1429second # [ 8.904854] systemd[1]: Finished Apply Kernel Variables.1430second # [ 8.916723] systemd[1]: Starting Network Name Resolution...1431second # [ 8.951849] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1432second # [ 8.962215] systemd[1]: Starting Create Static Device Nodes in /dev...1433second # [ 8.974356] systemd-journald[308]: Received client request to flush runtime journal.1434second # [ 9.054484] systemd[1]: Finished Load/Save OS Random Seed.1435second # [ 9.068529] systemd[1]: Reached target First Boot Complete.1436second # [ 9.069071] systemd[1]: Finished Flush Journal to Persistent Storage.1437test # [ 9.105284] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1438test # [ 9.109207] systemd[1]: Finished Create SUID/SGID Wrappers.1439second # [ 9.104742] systemd-resolved[338]: Positive Trust Anchors:1440second # [ 9.108312] systemd-resolved[338]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1441second # [ 9.109413] systemd-resolved[338]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161442second # [ 9.110732] systemd-resolved[338]: 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 test1443second # [ 9.137128] systemd[1]: Finished Create Static Device Nodes in /dev.1444second # [ 9.137848] systemd[1]: Reached target Preparation for Local File Systems.1445second # [ 9.138452] systemd[1]: Mounting /run/wrappers...1446second # [ 9.153024] systemd[1]: Starting Rule-based Manager for Device Events and Files...1447test # [ 9.197243] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1448test # [ 9.259310] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1449second # [ 9.241439] systemd[1]: Mounted /run/wrappers.1450second # [ 9.246090] systemd[1]: Reached target Local File Systems.1451second # [ 9.251550] systemd[1]: Listening on Boot Loader Control Service Socket.1452second # [ 9.261398] systemd[1]: Starting register-nix-paths.service...1453second # [ 9.268132] systemd[1]: Starting Create SUID/SGID Wrappers...1454second # [ 9.272627] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1455second # [ 9.277112] systemd[1]: Starting Save Transient machine-id to Disk...1456second # [ 9.314548] systemd[1]: Starting Create System Files and Directories...1457second # [ 9.356624] systemd-udevd[353]: Using default interface naming scheme 'v261'.1458test # [ 9.430305] systemd[1]: Finished register-nix-paths.service.1459test # [ 9.433456] systemd[1]: Reached target System Initialization.1460test # [ 9.437367] systemd[1]: Started Discard unused filesystem blocks once a week.1461test # [ 9.441023] systemd[1]: Started Daily Cleanup of Temporary Directories.1462test # [ 9.443674] systemd[1]: Reached target Timer Units.1463test # [ 9.446984] systemd[1]: Listening on D-Bus System Message Bus Socket.1464test # [ 9.450443] systemd[1]: Listening on Nix Daemon Socket.1465test # [ 9.452739] systemd[1]: Listening on Authorization Manager Agent Helper.1466test # [ 9.455297] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1467test # [ 9.455999] systemd[1]: Reached target Socket Units.1468test # [ 9.462085] systemd[1]: Starting D-Bus System Message Bus...1469second # [ 9.483262] systemd-resolved[338]: Using system hostname 'second'.1470second # [ 9.494088] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1471second # [ 9.503007] systemd[1]: Finished Save Transient machine-id to Disk.1472second # [ 9.512363] systemd[1]: Started Network Name Resolution.1473test # [ 9.564219] systemd[1]: Finished Firewall.1474test # [ 9.564819] systemd[1]: Reached target Preparation for Network.1475test # [ 9.565347] systemd[1]: Listening on Network Management Resolve Hook Socket.1476test # [ 9.572876] systemd[1]: Starting Network Management...1477test # [ 9.595484] (udev-worker)[471]: Network interface NamePolicy= disabled on kernel command line.1478second # [ 9.586772] systemd[1]: Finished Create System Files and Directories.1479test # [ 9.608352] (udev-worker)[473]: Network interface NamePolicy= disabled on kernel command line.1480second # [ 9.598104] systemd[1]: Starting Rebuild Journal Catalog...1481second # [ 9.608698] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1482test # [ 9.665232] dbus-broker-launch[542]: Looking up NSS user entry for 'systemd-timesync'...1483test # [ 9.685375] dbus-broker-launch[542]: NSS returned no entry for 'systemd-timesync'1484test # [ 9.688538] dbus-broker-launch[542]: Invalid user-name in /nix/store/ws7l2kcz90216f184y6h6c7gvkrc462x-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1485test # [ 9.744666] dbus-broker-launch[542]: 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'1486test # [ 9.750854] dbus-broker-launch[542]: 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'1487test # [ 9.761551] dbus-broker-launch[542]: 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'1488test # [ 9.770936] dbus-broker-launch[542]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1489test # [ 9.776765] systemd[1]: Started D-Bus System Message Bus.1490second # [ 9.763282] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1491test # [ 9.832291] dbus-broker-launch[542]: Ready1492test # [ 9.845402] systemd[1]: Reached target Basic System.1493test # [ 9.850626] systemd[1]: Starting Network Manager Script Dispatcher Service...1494test # [ 9.860129] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1495second # [ 9.843870] systemd[1]: Finished Rebuild Journal Catalog.1496test # [ 9.871194] cfg80211: Loading compiled-in X.509 certificates for regulatory database1497test # [ 9.875872] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1498second # [ 9.864255] systemd[1]: Starting Update is Completed...1499second # [ 9.871457] systemd[1]: Started Rule-based Manager for Device Events and Files.1500test # [ 9.905085] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1501test # [ 9.913780] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1502test # [ 9.914300] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1503test # [ 9.945137] systemd[1]: Starting Network Manager...1504test # [ 9.999810] systemd[1]: Started backdoor.service.1505second # [ 9.991408] systemd[1]: Finished Update is Completed.1506test # [ 10.025933] mousedev: PS/2 mouse device common for all mice1507test # [ 10.027848] systemd-networkd[551]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1508test # [ 10.044404] systemd-networkd[551]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section.1509test # [ 10.046001] systemd-networkd[551]: lo: Link UP1510test # [ 10.046502] systemd-networkd[551]: lo: Gained carrier1511test # [ 10.083584] systemd[1]: Starting Import lastlog data into lastlog2 database...1512test # [ 10.095530] njj6p721srdv39sq0fzcg6liqbqc29b2-wifi-secrets[558]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1513test # [ 10.109806] systemd-networkd[551]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1514test # [ 10.111181] systemd-networkd[551]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1515test # [ 10.121860] systemd-networkd[551]: eth1: Link UP1516test # [ 10.136735] systemd-networkd[551]: eth1: Gained carrier1517test # [ 10.137322] systemd-networkd[551]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1518second # [ 10.132264] systemd[1]: Finished Coldplug All udev Devices.1519test # [ 10.147332] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1520test # [ 10.203491] 70sc928b0djf43jwhz60x0xlmvfjgh4w-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1521test # [ 10.211666] systemd[1]: Starting Post-Boot Actions...1522test # [ 10.222399] 1sgjllrmgsn324qc8kxxgj3jy20sj9h8-wifi-secrets[562]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1523test # [ 10.261355] systemd[1]: Started Reset console on configuration changes.1524test # [ 10.266985] systemd[1]: Started Network Management.1525test # [ 10.320782] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1526test # [ 10.329745] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1527test # [ 10.336529] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1528test # [ 10.342821] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1529test # [ 10.353442] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1530test # [ 10.354278] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1531test # connecting to host...1532test # [ 10.383285] systemd[1]: Finished Post-Boot Actions.1533test: Guest shell says: b'Spawning backdoor root shell...\n'1534test: connected to guest root shell1535test: (connecting took 10.69 seconds)1536test: (finished: waiting for the VM to finish booting, in 10.69 seconds)1537test # [ 10.458977] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1538second # [ 10.441267] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1539test # [ 10.478480] nsncd[571]: Aug 13 05:09:33.320 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1540test # [ 10.490055] systemd[1]: Started Name Service Cache Daemon (nsncd).1541test # [ 10.498095] systemd[1]: Started Network Manager Script Dispatcher Service.1542test # [ 10.504399] systemd[1]: Reached target Host and Network Name Lookups.1543test # [ 10.510436] systemd[1]: Reached target User and Group Name Lookups.1544test # [ 10.519908] systemd[1]: Starting User Login Management...1545test # [ 10.526995] systemd[1]: Finished Import lastlog data into lastlog2 database.1546second # [ 10.510569] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1547second # [ 10.514493] systemd[1]: Finished Create SUID/SGID Wrappers.1548test # [ 10.652264] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1549test # [ 10.674694] systemd[1]: Starting Hostname Service...1550test # [ 10.700759] systemd-logind[616]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1551test # [ 10.706223] systemd-logind[616]: Watching system buttons on /dev/input/event0 (gpio-keys)1552test # [ 10.706915] systemd-logind[616]: New seat seat0.1553test # [ 10.707323] systemd[1]: Started User Login Management.1554test # [ 10.713452] systemd[1]: Starting linger-users.service...1555second # [ 10.708988] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1556test # [ 10.787373] systemd[1]: linger-users.service: Deactivated successfully.1557test # [ 10.793679] systemd[1]: Finished linger-users.service.1558second # [ 10.786255] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1559test # [ 10.815081] systemd[1]: Started Hostname Service.1560test # [ 10.908099] systemd-networkd[551]: eth0: Link UP1561test # [ 10.908636] systemd-networkd[551]: eth0: Gained carrier1562test # [ 10.929312] systemd[1]: Started Network Manager.1563second # [ 10.908132] systemd[1]: Finished register-nix-paths.service.1564test # [ 10.930516] systemd[1]: Reached target Network.1565second # [ 10.909383] systemd[1]: Reached target System Initialization.1566second # [ 10.912662] systemd[1]: Started Discard unused filesystem blocks once a week.1567test # [ 10.937255] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1568second # [ 10.915283] systemd[1]: Started Daily Cleanup of Temporary Directories.1569second # [ 10.919143] systemd[1]: Reached target Timer Units.1570second # [ 10.921431] systemd[1]: Listening on D-Bus System Message Bus Socket.1571test # [ 10.944253] systemd[1]: Starting Permit User Sessions...1572second # [ 10.926559] systemd[1]: Listening on Nix Daemon Socket.1573second # [ 10.928848] systemd[1]: Listening on Authorization Manager Agent Helper.1574second # [ 10.929453] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1575second # [ 10.930180] systemd[1]: Reached target Socket Units.1576second # [ 10.933602] systemd[1]: Starting D-Bus System Message Bus...1577test # [ 11.067041] systemd[1]: Finished Permit User Sessions.1578second # [ 11.055912] systemd[1]: Finished Firewall.1579second # [ 11.056608] systemd[1]: Reached target Preparation for Network.1580second # [ 11.058435] systemd[1]: Listening on Network Management Resolve Hook Socket.1581second # [ 11.061799] systemd[1]: Starting Network Management...1582test # [ 11.084708] systemd[1]: Started Getty on tty1.1583test # [ 11.086576] systemd[1]: Reached target Login Prompts.1584second # [ 11.082300] (udev-worker)[466]: Network interface NamePolicy= disabled on kernel command line.1585second # [ 11.091347] (udev-worker)[467]: Network interface NamePolicy= disabled on kernel command line.1586test # [ 11.114615] NetworkManager[563]: <warn> [1786597773.9563] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1587test # [ 11.137447] systemd-networkd[551]: eth1: Gained IPv6LL1588test # [ 11.145851] systemd-resolved[362]: eth0: Bus client set default route setting: yes1589test # [ 11.147915] systemd-resolved[362]: eth0: Bus client set DNS server list to: 10.0.2.31590second # [ 11.135550] dbus-broker-launch[520]: Looking up NSS user entry for 'systemd-timesync'...1591second # [ 11.151762] dbus-broker-launch[520]: NSS returned no entry for 'systemd-timesync'1592second # [ 11.154371] dbus-broker-launch[520]: Invalid user-name in /nix/store/ws7l2kcz90216f184y6h6c7gvkrc462x-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1593test # [ 11.183055] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1594test # [ 11.185148] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1595second # [ 11.216196] dbus-broker-launch[520]: 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'1596second # [ 11.221861] dbus-broker-launch[520]: 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'1597second # [ 11.228779] dbus-broker-launch[520]: 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'1598second # [ 11.239539] dbus-broker-launch[520]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1599second # [ 11.247806] systemd[1]: Started D-Bus System Message Bus.1600test # [ 11.331927] systemd[1]: Reached target Multi-User System.1601second # [ 11.313403] dbus-broker-launch[520]: Ready1602test # [ 11.333429] systemd[1]: Startup finished in 701ms (kernel) + 4.379s (initrd) + 6.252s (userspace) = 11.333s.1603second # [ 11.315045] systemd[1]: Reached target Basic System.1604second # [ 11.322487] systemd[1]: Starting Network Manager Script Dispatcher Service...1605second # [ 11.327592] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1606second # [ 11.336331] cfg80211: Loading compiled-in X.509 certificates for regulatory database1607second # [ 11.335627] systemd[1]: Starting Network Manager...1608second # [ 11.369460] mousedev: PS/2 mouse device common for all mice1609second # [ 11.368474] systemd[1]: Started backdoor.service.1610second # [ 11.385859] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1611second # [ 11.388051] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1612second # [ 11.402598] systemd[1]: Starting Import lastlog data into lastlog2 database...1613second # [ 11.445787] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1614second # [ 11.483431] systemd[1]: Starting Post-Boot Actions...1615second # [ 11.494342] systemd-networkd[531]: /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.1616second # [ 11.508654] systemd[1]: Started Reset console on configuration changes.1617second # [ 11.519702] njj6p721srdv39sq0fzcg6liqbqc29b2-wifi-secrets[538]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1618second # [ 11.527490] systemd-networkd[531]: /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.1619second # [ 11.546008] systemd-networkd[531]: lo: Link UP1620second # [ 11.552134] systemd-networkd[531]: lo: Gained carrier1621second # [ 11.557000] systemd-networkd[531]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1622second # [ 11.562524] systemd-networkd[531]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1623second # [ 11.573323] systemd[1]: Started Network Management.1624second # [ 11.578305] systemd-networkd[531]: eth1: Link UP1625second # [ 11.582805] systemd-networkd[531]: eth1: Gained carrier1626second # [ 11.586502] systemd-networkd[531]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1627second # [ 11.597936] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1628second # [ 11.607323] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1629second # connecting to host...1630second # [ 11.671970] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1631second # [ 11.689141] systemd[1]: Finished Post-Boot Actions.1632test: (finished: waiting for unit NetworkManager.service, in 11.98 seconds)1633test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1634second # [ 11.744772] systemd[1]: Finished Import lastlog data into lastlog2 database.1635test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1636test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets1637second # [ 11.770472] systemd[1]: Started Name Service Cache Daemon (nsncd).1638second # [ 11.776960] nsncd[547]: Aug 13 05:09:34.612 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1639second # [ 11.778253] systemd[1]: Reached target Host and Network Name Lookups.1640second # [ 11.778792] systemd[1]: Reached target User and Group Name Lookups.1641second # [ 11.795558] systemd[1]: Starting User Login Management...1642test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds)1643test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection1644second # [ 11.810829] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1645second # [ 11.819221] systemd[1]: Started Network Manager Script Dispatcher Service.1646test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.03 seconds)1647(finished: run the VM test script, in 12.51 seconds)1648test script finished in 12.57s1649cleanup1650kill QemuMachine (pid 48)1651second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14)1652test # [ 11.978650] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31653kill QemuMachine (pid 47)1654test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14)1655(finished: cleanup, in 0.25 seconds)