Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script additionally exposed symbols: second, test, vlan1, 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_ssh start all VMs second: starting vm test: starting vm second: QEMU running (pid 47) second # Disk image does not exist, creating the virtualisation disk image... test # Disk image does not exist, creating the virtualisation disk image... second # Formatting '/build/vm-state-second/tmp.YUbI4kFpaM', fmt=raw size=1073741824 test # Formatting '/build/vm-state-test/tmp.3iIgiD5zQW', fmt=raw size=1073741824 second # mke2fs 1.47.4 (6-Mar-2025) test # mke2fs 1.47.4 (6-Mar-2025) second # Discarding device blocks: 0/262144 done test # Discarding device blocks: 0/262144 done second # Creating filesystem with 262144 4k blocks and 65536 inodes test # Creating filesystem with 262144 4k blocks and 65536 inodes second # Filesystem UUID: d0a8f9ce-00dd-4a0d-a529-643bea45ea6b test # Filesystem UUID: 43eb4e23-cf37-4731-a75e-3ba96593425c second # Superblock backups stored on blocks: test # Superblock backups stored on blocks: second # 32768, 98304, 163840, 229376 test # 32768, 98304, 163840, 229376 second # test # second # Allocating group tables: 0/8 done test # Allocating group tables: 0/8 done second # Writing inode tables: 0/8 done test # Writing inode tables: 0/8 done second # Creating journal (8192 blocks): done test # Creating journal (8192 blocks): done second # Writing superblocks and filesystem accounting information: 0/8 done test # Writing superblocks and filesystem accounting information: 0/8 done second # test # second # Virtualisation disk image created. test # Virtualisation disk image created. test: QEMU running (pid 48) (finished: start all VMs, in 0.40 seconds) test: waiting for unit NetworkManager.service test: waiting for the VM to finish booting second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] second # [ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Thu Jul 30 11:05:57 UTC 2026 second # [ 0.000000] KASLR enabled second # [ 0.000000] random: crng init done second # [ 0.000000] Machine model: linux,dummy-virt second # [ 0.000000] efi: UEFI not found. second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf] second # [ 0.000000] Zone ranges: second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] DMA32 empty second # [ 0.000000] Normal empty second # [ 0.000000] Device empty second # [ 0.000000] Movable zone start for each node second # [ 0.000000] Early memory node ranges second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 second # [ 0.000000] psci: probing for conduit method from DT. second # [ 0.000000] psci: PSCIv1.3 detected in firmware. second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs second # [ 0.000000] psci: Trusted OS migration not required second # [ 0.000000] psci: SMC Calling Convention v1.1 second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) second # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 second # [ 0.000000] Detected PIPT I-cache on CPU0 second # [ 0.000000] CPU features: detected: GICv3 CPU interface second # [ 0.000000] CPU features: detected: Spectre-v4 second # [ 0.000000] CPU features: detected: Spectre-BHB second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) second # [ 0.000000] CPU features: detected: ARM erratum 1418040 second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing second # [ 0.000000] alternatives: applying boot alternatives second # [ 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/8h45q4iq7g1vs9x170gs07j7xsslbz2y-nixos-system-second-test/init regInfo=/nix/store/n8hn9075sf6lv0s0ssaakpymyx5idwai-closure-info/registration console=ttyAMA0,115200n8 console=tty0 test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/n8hn9075sf6lv0s0ssaakpymyx5idwai-closure-info/registration", will be passed to user space. second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB second # [ 0.000000] software IO TLB: area num 1. second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) second # [ 0.000000] Fallback order for Node 0: 0 second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 second # [ 0.000000] Policy zone: DMA second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] allocated 2097152 bytes of page_ext second # [ 0.000000] ftrace: allocating 74844 entries in 294 pages second # [ 0.000000] ftrace: allocated 294 pages with 4 groups test # [ 0.000000] Linux version 6.18.41 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Thu Jul 30 11:05:57 UTC 2026 test # [ 0.000000] KASLR enabled test # [ 0.000000] random: crng init done test # [ 0.000000] Machine model: linux,dummy-virt second # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.000000] efi: UEFI not found. test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT second # [ 0.000000] rcu: RCU event tracing is enabled. second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] Trampoline variant of Tasks RCU enabled. test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf] test # [ 0.000000] Zone ranges: test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] DMA32 empty test # [ 0.000000] Normal empty test # [ 0.000000] Device empty test # [ 0.000000] Movable zone start for each node test # [ 0.000000] Early memory node ranges test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 test # [ 0.000000] psci: probing for conduit method from DT. test # [ 0.000000] psci: PSCIv1.3 detected in firmware. test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs second # [ 0.000000] Rude variant of Tasks RCU enabled. test # [ 0.000000] psci: Trusted OS migration not required test # [ 0.000000] psci: SMC Calling Convention v1.1 test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) test # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 test # [ 0.000000] Detected PIPT I-cache on CPU0 test # [ 0.000000] CPU features: detected: GICv3 CPU interface second # [ 0.000000] Tracing variant of Tasks RCU enabled. test # [ 0.000000] CPU features: detected: Spectre-v4 second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. test # [ 0.000000] CPU features: detected: Spectre-BHB second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] CPU features: detected: ARM erratum 1418040 second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] alternatives: applying boot alternatives second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 second # [ 0.000000] GICv3: 256 SPIs implemented second # [ 0.000000] GICv3: 0 Extended SPIs implemented second # [ 0.000000] Root IRQ handler: gic_handle_irq second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 test # [ 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/sn1vcypf8wfjwz7k1hw3av6y5n03s2j3-nixos-system-test-test/init regInfo=/nix/store/cbj2yj8sdpvrf97k5g1yd53j3bjrkv15-closure-info/registration console=ttyAMA0,115200n8 console=tty0 second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/cbj2yj8sdpvrf97k5g1yd53j3bjrkv15-closure-info/registration", will be passed to user space. second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.000000] software IO TLB: area num 1. second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) test # [ 0.000000] Fallback order for Node 0: 0 second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). test # [ 0.000000] Policy zone: DMA test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns test # [ 0.000000] allocated 2097152 bytes of page_ext second # [ 0.000053] arm-pv: using stolen time PV test # [ 0.000000] ftrace: allocating 74844 entries in 294 pages second # [ 0.000379] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.000653] Console: colour dummy device 80x25 test # [ 0.000000] ftrace: allocated 294 pages with 4 groups second # [ 0.000671] printk: legacy console [tty0] enabled test # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.000000] rcu: RCU event tracing is enabled. second # [ 0.000871] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. second # [ 0.000876] pid_max: default: 32768 minimum: 301 test # [ 0.000000] Trampoline variant of Tasks RCU enabled. second # [ 0.000965] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.000000] Rude variant of Tasks RCU enabled. second # [ 0.001093] landlock: Up and running. test # [ 0.000000] Tracing variant of Tasks RCU enabled. second # [ 0.001095] Yama: becoming mindful. second # [ 0.001419] LSM support for eBPF active test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. second # [ 0.001562] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 second # [ 0.001580] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.003276] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.003969] rcu: Hierarchical SRCU implementation. test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.003974] rcu: Max phase no-delay instances is 1000. test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.004921] fsl-mc MSI: its@8080000 domain created second # [ 0.005071] EFI services will not be available. test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 test # [ 0.000000] GICv3: 256 SPIs implemented second # [ 0.005155] smp: Bringing up secondary CPUs ... test # [ 0.000000] GICv3: 0 Extended SPIs implemented second # [ 0.005187] smp: Brought up 1 node, 1 CPU test # [ 0.000000] Root IRQ handler: gic_handle_irq second # [ 0.005191] SMP: Total of 1 processors activated. second # [ 0.005193] CPU: All CPU(s) started at EL1 test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 second # [ 0.005204] CPU features: detected: 32-bit EL0 Support test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 second # [ 0.005207] CPU features: detected: Data cache clean to the PoU not required for I/D coherence test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] second # [ 0.005210] CPU features: detected: Common not Private translations second # [ 0.005212] CPU features: detected: CRC32 instructions test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) second # [ 0.005214] CPU features: detected: Data cache clean to Point of Persistence test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) second # [ 0.005216] CPU features: detected: Enhanced Virtualization Traps test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 second # [ 0.005226] CPU features: detected: RCpc load-acquire (LDAPR) test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 second # [ 0.005228] CPU features: detected: LSE atomic instructions second # [ 0.005230] CPU features: detected: Privileged Access Never test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.005232] CPU features: detected: PMUv3 second # [ 0.005234] CPU features: detected: RAS Extension Support test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns second # [ 0.005237] CPU features: detected: Speculative Store Bypassing Safe (SSBS) test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 second # [ 0.005256] alternatives: applying system-wide alternatives test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). second # [ 0.006661] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns second # [ 0.006868] Memory: 891496K/1048576K available (24384K kernel code, 7090K rwdata, 26336K rodata, 4736K init, 1106K bss, 115776K reserved, 32768K cma-reserved) test # [ 0.000049] arm-pv: using stolen time PV second # [ 0.007286] devtmpfs: initialized second # [ 0.008708] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.000376] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.000650] Console: colour dummy device 80x25 second # [ 0.008728] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.000668] printk: legacy console [tty0] enabled second # [ 0.008857] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL second # [ 0.008860] 0 pages in range for non-PLT usage test # [ 0.000867] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) second # [ 0.008861] 508304 pages in range for PLT usage test # [ 0.000872] pid_max: default: 32768 minimum: 301 second # [ 0.008968] pinctrl core: initialized pinctrl subsystem test # [ 0.000959] LSM: initializing lsm=capability,landlock,yama,bpf,ima second # [ 0.009646] DMI not present or invalid. test # [ 0.001078] landlock: Up and running. second # [ 0.012683] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.001081] Yama: becoming mindful. test # [ 0.001408] LSM support for eBPF active second # [ 0.014898] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.001544] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.015023] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations test # [ 0.001562] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.015173] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations test # [ 0.003203] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.015188] audit: initializing netlink subsys (disabled) test # [ 0.004088] rcu: Hierarchical SRCU implementation. second # [ 0.015746] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.004093] rcu: Max phase no-delay instances is 1000. second # [ 0.015748] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.004957] fsl-mc MSI: its@8080000 domain created test # [ 0.005111] EFI services will not be available. second # [ 0.015751] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.005192] smp: Bringing up secondary CPUs ... second # [ 0.015753] thermal_sys: Registered thermal governor 'user_space' test # [ 0.005219] smp: Brought up 1 node, 1 CPU test # [ 0.005223] SMP: Total of 1 processors activated. second # [ 0.015755] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.005225] CPU: All CPU(s) started at EL1 second # [ 0.015786] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 test # [ 0.005236] CPU features: detected: 32-bit EL0 Support second # [ 0.015803] cpuidle: using governor ladder second # [ 0.015808] cpuidle: using governor menu test # [ 0.005239] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.015923] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. test # [ 0.005242] CPU features: detected: Common not Private translations second # [ 0.015943] ASID allocator initialised with 32768 entries test # [ 0.005244] CPU features: detected: CRC32 instructions second # [ 0.016600] Serial: AMBA PL011 UART driver test # [ 0.005246] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.019641] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 test # [ 0.005248] CPU features: detected: Enhanced Virtualization Traps second # [ 0.019773] printk: console [ttyAMA0] enabled test # [ 0.005258] CPU features: detected: RCpc load-acquire (LDAPR) test # [ 0.005260] CPU features: detected: LSE atomic instructions test # [ 0.005262] CPU features: detected: Privileged Access Never test # [ 0.005264] CPU features: detected: PMUv3 test # [ 0.005266] CPU features: detected: RAS Extension Support test # [ 0.005269] CPU features: detected: Speculative Store Bypassing Safe (SSBS) test # [ 0.005288] alternatives: applying system-wide alternatives test # [ 0.006682] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.006877] Memory: 891500K/1048576K available (24384K kernel code, 7090K rwdata, 26336K rodata, 4736K init, 1106K bss, 115772K reserved, 32768K cma-reserved) test # [ 0.007308] devtmpfs: initialized test # [ 0.008665] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.008685] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.008807] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL test # [ 0.008810] 0 pages in range for non-PLT usage test # [ 0.008811] 508304 pages in range for PLT usage test # [ 0.008906] pinctrl core: initialized pinctrl subsystem test # [ 0.009612] DMI not present or invalid. test # [ 0.012619] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.014744] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations second # [ 0.087849] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages test # [ 0.014866] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.087872] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.015016] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.087876] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages test # [ 0.015032] audit: initializing netlink subsys (disabled) second # [ 0.087882] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page test # [ 0.015579] thermal_sys: Registered thermal governor 'fair_share' second # [ 0.087885] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.015581] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.087888] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.087891] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages test # [ 0.015584] thermal_sys: Registered thermal governor 'step_wise' second # [ 0.087894] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page test # [ 0.015586] thermal_sys: Registered thermal governor 'user_space' test # [ 0.015588] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.015620] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1 test # [ 0.015634] cpuidle: using governor ladder test # [ 0.015639] cpuidle: using governor menu second # [ 0.092456] fbcon: Taking over console second # [ 0.092474] ACPI: Interpreter disabled. test # [ 0.015751] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. test # [ 0.015771] ASID allocator initialised with 32768 entries second # [ 0.093664] iommu: Default domain type: Translated test # [ 0.016432] Serial: AMBA PL011 UART driver second # [ 0.093674] iommu: DMA domain TLB invalidation policy: strict mode test # [ 0.019525] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 second # [ 0.094742] SCSI subsystem initialized test # [ 0.019679] printk: console [ttyAMA0] enabled second # [ 0.095248] usbcore: registered new interface driver usbfs second # [ 0.095283] usbcore: registered new interface driver hub second # [ 0.095299] usbcore: registered new device driver usb second # [ 0.095494] pps_core: LinuxPPS API ver. 1 registered second # [ 0.095501] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti second # [ 0.095513] PTP clock support registered second # [ 0.095540] EDAC MC: Ver: 3.0.0 second # [ 0.098324] scmi_core: SCMI protocol bus registered second # [ 0.098990] FPGA manager framework test # [ 0.088072] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages test # [ 0.088094] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.088098] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages test # [ 0.088104] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page test # [ 0.088107] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.088110] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.088113] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages test # [ 0.088116] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page second # [ 0.107690] vgaarb: loaded test # [ 0.092717] fbcon: Taking over console second # [ 0.108115] clocksource: Switched to clocksource arch_sys_counter test # [ 0.092733] ACPI: Interpreter disabled. second # [ 0.108512] VFS: Disk quotas dquot_6.6.0 test # [ 0.093937] iommu: Default domain type: Translated second # [ 0.108539] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.093945] iommu: DMA domain TLB invalidation policy: strict mode second # [ 0.109932] netfs: FS-Cache loaded test # [ 0.094991] SCSI subsystem initialized second # [ 0.110037] pnp: PnP ACPI: disabled test # [ 0.095493] usbcore: registered new interface driver usbfs test # [ 0.095524] usbcore: registered new interface driver hub test # [ 0.095541] usbcore: registered new device driver usb test # [ 0.095727] pps_core: LinuxPPS API ver. 1 registered test # [ 0.095733] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti test # [ 0.095739] PTP clock support registered test # [ 0.095771] EDAC MC: Ver: 3.0.0 test # [ 0.098509] scmi_core: SCMI protocol bus registered test # [ 0.099168] FPGA manager framework second # [ 0.112535] NET: Registered PF_INET protocol family second # [ 0.112718] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.107957] vgaarb: loaded test # [ 0.108389] clocksource: Switched to clocksource arch_sys_counter test # [ 0.108800] VFS: Disk quotas dquot_6.6.0 test # [ 0.108826] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.110212] netfs: FS-Cache loaded test # [ 0.110301] pnp: PnP ACPI: disabled test # [ 0.112748] NET: Registered PF_INET protocol family test # [ 0.112925] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) second # [ 0.140881] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.140913] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) second # [ 0.140926] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.140994] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.141063] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.141175] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) second # [ 0.141227] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.141278] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.141391] NET: Registered PF_UNIX/PF_LOCAL protocol family second # [ 0.141460] NET: Registered PF_XDP protocol family second # [ 0.141483] PCI: CLS 0 bytes, default 64 second # [ 0.147407] Trying to unpack rootfs image as initramfs... test # [ 0.140030] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.140060] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.140074] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.140115] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) test # [ 0.140183] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.140284] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.140358] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.144104] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.144242] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.144331] NET: Registered PF_XDP protocol family test # [ 0.144353] PCI: CLS 0 bytes, default 64 test # [ 0.145960] Trying to unpack rootfs image as initramfs... second # [ 0.156139] kvm [1]: HYP mode not available test # [ 0.156494] kvm [1]: HYP mode not available second # [ 0.220639] Initialise system trusted keyrings second # [ 0.221134] workingset: timestamp_bits=42 max_order=18 bucket_order=0 second # [ 0.222039] squashfs: version 4.0 (2009/01/31) Phillip Lougher second # [ 0.222508] 9p: Installing v9fs 9p2000 file system support test # [ 0.221374] Initialise system trusted keyrings test # [ 0.221859] workingset: timestamp_bits=42 max_order=18 bucket_order=0 test # [ 0.222758] squashfs: version 4.0 (2009/01/31) Phillip Lougher test # [ 0.223217] 9p: Installing v9fs 9p2000 file system support second # [ 0.241856] Key type asymmetric registered second # [ 0.241880] Asymmetric key parser 'x509' registered second # [ 0.241943] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.248172] io scheduler mq-deadline registered second # [ 0.248191] io scheduler kyber registered second # [ 0.250983] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.251727] ledtrig-cpu: registered to indicate activity on CPUs second # [ 0.252026] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: second # [ 0.252047] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 second # [ 0.252061] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 second # [ 0.252067] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 second # [ 0.252094] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits second # [ 0.255617] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] second # [ 0.255717] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 second # [ 0.255736] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.255741] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.242497] Key type asymmetric registered test # [ 0.242520] Asymmetric key parser 'x509' registered second # [ 0.255745] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.242585] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.255748] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] second # [ 0.255825] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint test # [ 0.248443] io scheduler mq-deadline registered test # [ 0.248460] io scheduler kyber registered test # [ 0.251239] pl061_gpio 9030000.pl061: PL061 GPIO chip registered test # [ 0.251993] ledtrig-cpu: registered to indicate activity on CPUs test # [ 0.252287] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: test # [ 0.252309] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 test # [ 0.252323] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.252329] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 test # [ 0.252358] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits test # [ 0.255878] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] test # [ 0.255982] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 second # [ 0.264301] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.256002] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.264434] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] test # [ 0.256007] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] second # [ 0.264445] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.256011] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] second # [ 0.264466] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.264476] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.256015] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] second # [ 0.264782] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.256128] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint second # [ 0.264900] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] second # [ 0.264911] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.264930] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.265220] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.265338] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] second # [ 0.265349] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.265369] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.265657] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.265774] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] second # [ 0.265784] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.265804] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.266095] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.266212] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] second # [ 0.266223] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.266244] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.266559] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.266678] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] second # [ 0.266689] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.266709] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.264615] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.266999] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.264752] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] second # [ 0.267120] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] test # [ 0.264764] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.267131] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.264784] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.267151] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.264796] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.267165] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.265090] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.267459] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint test # [ 0.265210] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] second # [ 0.267581] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.265221] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.267601] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.265241] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.267910] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.265539] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.268034] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.265661] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] second # [ 0.268054] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.265671] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.265692] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.268316] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.268432] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] test # [ 0.265990] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.266110] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] second # [ 0.268601] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint test # [ 0.266121] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.268867] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] test # [ 0.266142] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.268881] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.268900] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.266437] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.266557] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] second # [ 0.269213] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.266567] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.269334] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.269344] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.266587] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.269364] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.266876] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.266995] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] second # [ 0.269759] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned test # [ 0.267005] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.269769] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned test # [ 0.267025] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.269774] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned test # [ 0.267311] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.269807] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned test # [ 0.267432] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] second # [ 0.269838] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned test # [ 0.267443] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.267463] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.269869] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned test # [ 0.267478] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.269900] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned test # [ 0.267803] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint second # [ 0.269931] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned test # [ 0.267927] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.269962] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned test # [ 0.267947] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.269994] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned test # [ 0.268247] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.268380] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.270025] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned test # [ 0.284257] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.270056] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned second # [ 0.270147] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned second # [ 0.270179] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned second # [ 0.270193] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned second # [ 0.270207] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned second # [ 0.270221] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned second # [ 0.270235] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned second # [ 0.270250] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned second # [ 0.270264] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned test # [ 0.285044] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint test # [ 0.285169] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.270278] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned second # [ 0.270292] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned test # [ 0.285342] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint test # [ 0.285548] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] second # [ 0.270306] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned test # [ 0.285561] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.270320] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned test # [ 0.285587] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.270334] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned test # [ 0.285892] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.270348] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.286015] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.270361] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.286026] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.270375] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.286047] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.270389] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned second # [ 0.270402] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned test # [ 0.286449] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned second # [ 0.270422] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.286460] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned second # [ 0.270435] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned test # [ 0.286465] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned second # [ 0.270449] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned test # [ 0.286499] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned second # [ 0.270463] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.270481] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] test # [ 0.286530] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned second # [ 0.270488] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] test # [ 0.286561] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.270491] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] test # [ 0.286592] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned second # [ 0.271225] pci 0000:00:0a.0: enabling device (0000 -> 0002) test # [ 0.286623] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned test # [ 0.286656] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned test # [ 0.286688] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned test # [ 0.286719] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned test # [ 0.286750] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned test # [ 0.286805] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned test # [ 0.286865] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned test # [ 0.286881] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned test # [ 0.286894] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned test # [ 0.286908] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned test # [ 0.286922] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned test # [ 0.286935] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned test # [ 0.286949] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned test # [ 0.286963] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned test # [ 0.286977] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned test # [ 0.286991] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned test # [ 0.287005] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned test # [ 0.287018] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned test # [ 0.287032] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.287046] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.287059] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.287073] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned test # [ 0.287087] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned test # [ 0.287106] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.287120] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned test # [ 0.287133] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned test # [ 0.287147] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned test # [ 0.287165] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] test # [ 0.287171] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] test # [ 0.287175] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] test # [ 0.287888] pci 0000:00:0a.0: enabling device (0000 -> 0002) second # [ 0.325105] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.326999] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) test # [ 0.321936] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) test # [ 0.324028] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) second # [ 0.337306] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) second # [ 0.338975] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) test # [ 0.333429] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) test # [ 0.335777] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) second # [ 0.348588] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) second # [ 0.350370] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.352074] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) second # [ 0.354021] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.355886] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) test # [ 0.345382] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) test # [ 0.347782] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.365273] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) second # [ 0.367375] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) test # [ 0.357408] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.359833] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.379842] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.362649] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) test # [ 0.364149] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) second # [ 0.384774] msm_serial: driver initialized second # [ 0.384907] SuperH (H)SCI(F) driver initialized second # [ 0.384943] STM32 USART driver initialized test # [ 0.373574] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) test # [ 0.380942] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.382412] msm_serial: driver initialized test # [ 0.382504] SuperH (H)SCI(F) driver initialized test # [ 0.382540] STM32 USART driver initialized second # [ 0.403486] loop: module loaded second # [ 0.403619] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 0.408281] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) test # [ 0.401731] loop: module loaded test # [ 0.401863] virtio_blk virtio5: 1/0/0 default/read/poll queues test # [ 0.402431] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 0.412535] megasas: 07.734.00.00-rc1 second # [ 0.413000] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] test # [ 0.412795] megasas: 07.734.00.00-rc1 test # [ 0.413253] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] second # [ 0.429090] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.429130] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.414986] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.430976] Using buffer write method test # [ 0.415043] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.431046] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] test # [ 0.418540] Using buffer write method test # [ 0.418576] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] test # [ 0.424416] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.424435] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.426976] Using buffer write method second # [ 0.440750] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.426998] Concatenating MTD devices: test # [ 0.427001] (0): "0.flash" second # [ 0.440777] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.427004] (1): "0.flash" test # [ 0.427006] into device "0.flash" second # [ 0.443009] Using buffer write method second # [ 0.443034] Concatenating MTD devices: second # [ 0.443037] (0): "0.flash" second # [ 0.443040] (1): "0.flash" second # [ 0.443042] into device "0.flash" second # [ 0.650383] Freeing initrd memory: 27040K test # [ 0.637153] Freeing initrd memory: 27036K second # [ 0.658198] tun: Universal TUN/TAP device driver, 1.6 test # [ 0.644980] tun: Universal TUN/TAP device driver, 1.6 second # [ 0.660921] thunder_xcv, ver 1.0 second # [ 0.660950] thunder_bgx, ver 1.0 second # [ 0.660962] nicpf, ver 1.0 test # [ 0.647455] thunder_xcv, ver 1.0 second # [ 0.661250] e1000: Intel(R) PRO/1000 Network Driver test # [ 0.647481] thunder_bgx, ver 1.0 test # [ 0.647493] nicpf, ver 1.0 second # [ 0.661257] e1000: Copyright (c) 1999-2006 Intel Corporation. test # [ 0.647788] e1000: Intel(R) PRO/1000 Network Driver second # [ 0.661277] e1000e: Intel(R) PRO/1000 Network Driver test # [ 0.647794] e1000: Copyright (c) 1999-2006 Intel Corporation. second # [ 0.661282] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. test # [ 0.647812] e1000e: Intel(R) PRO/1000 Network Driver second # [ 0.661295] igb: Intel(R) Gigabit Ethernet Network Driver test # [ 0.647817] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. second # [ 0.661299] igb: Copyright (c) 2007-2014 Intel Corporation. test # [ 0.647830] igb: Intel(R) Gigabit Ethernet Network Driver second # [ 0.661309] igbvf: Intel(R) Gigabit Virtual Function Network Driver test # [ 0.647833] igb: Copyright (c) 2007-2014 Intel Corporation. second # [ 0.661313] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. test # [ 0.647843] igbvf: Intel(R) Gigabit Virtual Function Network Driver second # [ 0.661372] sky2: driver version 1.30 test # [ 0.647847] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. second # [ 0.662132] usbcore: registered new interface driver usb-storage test # [ 0.647908] sky2: driver version 1.30 second # [ 0.662266] usbcore: registered new interface driver usbserial_generic second # [ 0.662275] usbserial: USB Serial support registered for generic second # [ 0.662544] hv_vmbus: registering driver hyperv_keyboard test # [ 0.652774] usbcore: registered new interface driver usb-storage test # [ 0.652869] usbcore: registered new interface driver usbserial_generic test # [ 0.652877] usbserial: USB Serial support registered for generic second # [ 0.669423] ehci-pci 0000:00:0a.0: EHCI Host Controller test # [ 0.653159] hv_vmbus: registering driver hyperv_keyboard second # [ 0.669463] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 second # [ 0.669646] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 test # [ 0.655722] ehci-pci 0000:00:0a.0: EHCI Host Controller test # [ 0.655760] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 second # [ 0.671145] rtc-pl031 9010000.pl031: registered as rtc0 test # [ 0.655985] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 second # [ 0.671179] rtc-pl031 9010000.pl031: setting system clock to 2026-08-01T20:09:10 UTC (1785614950) second # [ 0.671346] i2c_dev: i2c /dev entries driver test # [ 0.657516] rtc-pl031 9010000.pl031: registered as rtc0 test # [ 0.657550] rtc-pl031 9010000.pl031: setting system clock to 2026-08-01T20:09:10 UTC (1785614950) test # [ 0.657711] i2c_dev: i2c /dev entries driver second # [ 0.674061] sdhci: Secure Digital Host Controller Interface driver second # [ 0.674076] sdhci: Copyright(c) Pierre Ossman second # [ 0.674201] Synopsys Designware Multimedia Card Interface Driver second # [ 0.674358] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.675175] hid: raw HID events driver (C) Jiri Kosina test # [ 0.660459] sdhci: Secure Digital Host Controller Interface driver test # [ 0.660471] sdhci: Copyright(c) Pierre Ossman second # [ 0.675335] usbcore: registered new interface driver usbhid second # [ 0.675340] usbhid: USB HID core driver test # [ 0.660603] Synopsys Designware Multimedia Card Interface Driver test # [ 0.660765] sdhci-pltfm: SDHCI platform and OF driver helper test # [ 0.661622] hid: raw HID events driver (C) Jiri Kosina test # [ 0.661763] usbcore: registered new interface driver usbhid test # [ 0.661768] usbhid: USB HID core driver second # [ 0.678661] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available second # [ 0.679432] drop_monitor: Initializing network drop monitor service test # [ 0.664966] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 second # [ 0.679550] NET: Registered PF_INET6 protocol family test # [ 0.665302] hub 1-0:1.0: USB hub found test # [ 0.665334] hub 1-0:1.0: 6 ports detected second # [ 0.681240] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 second # [ 0.681560] hub 1-0:1.0: USB hub found second # [ 0.681594] hub 1-0:1.0: 6 ports detected test # [ 0.666576] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available second # [ 0.683277] Segment Routing with IPv6 test # [ 0.667337] drop_monitor: Initializing network drop monitor service second # [ 0.683302] In-situ OAM (IOAM) with IPv6 test # [ 0.667483] NET: Registered PF_INET6 protocol family second # [ 0.683350] NET: Registered PF_PACKET protocol family test # [ 0.669576] Segment Routing with IPv6 test # [ 0.669610] In-situ OAM (IOAM) with IPv6 test # [ 0.669659] NET: Registered PF_PACKET protocol family test # [ 0.670659] 9pnet: Installing 9P2000 support test # [ 0.672093] Key type dns_resolver registered second # [ 0.684420] 9pnet: Installing 9P2000 support second # [ 0.686000] Key type dns_resolver registered test # [ 0.675470] registered taskstats version 1 test # [ 0.675611] Loading compiled-in X.509 certificates second # [ 0.689421] registered taskstats version 1 second # [ 0.689563] Loading compiled-in X.509 certificates second # [ 0.694661] Demotion targets for Node 0: null second # [ 0.694738] Key type .fscrypt registered second # [ 0.694744] Key type fscrypt-provisioning registered second # [ 0.694836] ima: No TPM chip found, activating TPM-bypass! test # [ 0.680767] Demotion targets for Node 0: null second # [ 0.694848] ima: Allocated hash algorithm: sha1 test # [ 0.680865] Key type .fscrypt registered second # [ 0.694905] ima: No architecture policies found test # [ 0.680870] Key type fscrypt-provisioning registered test # [ 0.681005] ima: No TPM chip found, activating TPM-bypass! test # [ 0.681018] ima: Allocated hash algorithm: sha1 second # [ 0.697691] input: gpio-keys as /devices/platform/gpio-keys/input/input0 test # [ 0.681073] ima: No architecture policies found test # [ 0.683502] input: gpio-keys as /devices/platform/gpio-keys/input/input0 second # [ 0.707510] clk: Disabling unused clocks second # [ 0.707536] PM: genpd: Disabling unused power domains test # [ 0.693638] clk: Disabling unused clocks test # [ 0.693661] PM: genpd: Disabling unused power domains second # [ 0.710769] Freeing unused kernel memory: 4736K second # [ 0.710862] Run /init as init process test # [ 0.696753] Freeing unused kernel memory: 4736K test # [ 0.696841] Run /init as init process second # [ 0.730522] systemd[1]: Successfully made /usr/ read-only. test # [ 0.718772] systemd[1]: Successfully made /usr/ read-only. test # [ 0.916436] usb 1-1: new high-speed USB device number 2 using ehci-pci second # [ 0.932165] usb 1-1: new high-speed USB device number 2 using ehci-pci second # [ 1.065094] systemd[1]: systemd 261 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) second # [ 1.071573] systemd[1]: Detected virtualization qemu. second # [ 1.072713] systemd[1]: Detected architecture arm64. second # [ 1.073771] systemd[1]: Running in initrd. test # [ 1.053159] systemd[1]: systemd 261 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) test # [ 1.059592] systemd[1]: Detected virtualization qemu. second # [ 1.075386] systemd[1]: Initializing machine ID from random generator. test # [ 1.060789] systemd[1]: Detected architecture arm64. test # [ 1.062273] systemd[1]: Running in initrd. second # [ 1.077408] systemd[1]: Hostname set to . test # [ 1.064340] systemd[1]: Initializing machine ID from random generator. test # [ 1.066245] systemd[1]: Hostname set to . second # [ 1.084854] 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/input1 test # [ 1.072910] 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/input1 second # [ 1.164296] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 test # [ 1.152593] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 second # [ 1.284135] usb 1-2: new high-speed USB device number 3 using ehci-pci test # [ 1.272427] usb 1-2: new high-speed USB device number 3 using ehci-pci second # [ 1.332894] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 1.337735] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.389110] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.397796] systemd[1]: Created slice Slice /system/modprobe. second # [ 1.398505] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 1.399301] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.399870] systemd[1]: Reached target Path Units. second # [ 1.400342] systemd[1]: Reached target Slice Units. second # [ 1.400779] systemd[1]: Reached target Swaps. second # [ 1.401171] systemd[1]: Reached target Timer Units. second # [ 1.401744] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.402443] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.403052] systemd[1]: Listening on Journal Sockets. second # [ 1.403599] systemd[1]: Listening on udev Control Socket. second # [ 1.404340] systemd[1]: Listening on udev Kernel Socket. second # [ 1.404997] systemd[1]: Reached target Socket Units. second # [ 1.406582] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.416289] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.416895] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 1.406872] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.425039] systemd[1]: Mounting Kernel Configuration File System... second # [ 1.428979] systemd[1]: Starting Journal Service... test # [ 1.414840] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.415899] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.417304] systemd[1]: Expecting device /dev/disk/by-label/nixos... test # [ 1.418281] systemd[1]: Reached target Path Units. test # [ 1.418956] systemd[1]: Reached target Slice Units. test # [ 1.419640] systemd[1]: Reached target Swaps. test # [ 1.420275] systemd[1]: Reached target Timer Units. test # [ 1.421524] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.422915] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.437948] 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/input2 test # [ 1.423907] systemd[1]: Listening on Journal Sockets. second # [ 1.439137] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 test # [ 1.425132] systemd[1]: Listening on udev Control Socket. test # [ 1.425300] systemd[1]: Listening on udev Kernel Socket. test # [ 1.425342] systemd[1]: Reached target Socket Units. second # [ 1.444254] systemd[1]: Starting Load Kernel Modules... test # [ 1.429687] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.444359] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 1.433966] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.450130] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.435306] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 1.438515] 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/input2 test # [ 1.438646] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 second # [ 1.461249] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.462056] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 1.462264] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 1.462456] systemd[1]: Mounted Kernel Configuration File System. test # [ 1.451609] systemd[1]: Mounting Kernel Configuration File System... second # [ 1.472594] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.480794] systemd[1]: Starting Journal Service... second # [ 1.501715] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.489880] systemd[1]: Starting Load Kernel Modules... test # [ 1.490551] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 1.496759] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.516539] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.518119] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.520277] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.524693] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.512490] systemd[1]: Finished Create List of Static Device Nodes. test # [ 1.513382] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.513581] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.513822] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.540562] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 second # [ 1.540774] [drm] features: -virgl +edid -resource_blob -host_visible second # [ 1.540780] [drm] features: -context_init second # [ 1.541217] [drm] number of scanouts: 1 second # [ 1.541231] [drm] number of cap sets: 0 test # [ 1.532670] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 1.552407] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic second # [ 1.552426] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 test # [ 1.551271] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.568905] Console: switching to colour frame buffer device 160x50 second # [ 1.574259] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.574435] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.574464] systemd[1]: Reached target Local File Systems. second # [ 1.580526] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.572864] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. second # [ 1.592341] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device second # [ 1.594174] systemd[1]: Started Journal Service. test # [ 1.576845] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.577913] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 1.584473] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev second # [ 1.600211] systemd-modules-load[74]: Inserted module 'dm_mod' second # [ 1.601490] systemd-modules-load[74]: Module 'virtio_balloon' is built in second # [ 1.602207] systemd-modules-load[74]: Module 'virtio_console' is built in second # [ 1.602845] systemd-modules-load[74]: Inserted module 'virtio_gpu' second # [ 1.603465] systemd-modules-load[74]: Module 'virtio_rng' is built in test # [ 1.593257] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 test # [ 1.593466] [drm] features: -virgl +edid -resource_blob -host_visible test # [ 1.593471] [drm] features: -context_init test # [ 1.593899] [drm] number of scanouts: 1 test # [ 1.593912] [drm] number of cap sets: 0 second # [ 1.617272] systemd[1]: Starting Create System Files and Directories... second # [ 1.619033] systemd[1]: Finished Load Kernel Modules. second # [ 1.632126] systemd[1]: Starting Apply Kernel Variables... test # [ 1.618490] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic test # [ 1.618510] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 test # [ 1.624206] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.624606] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.624641] systemd[1]: Reached target Local File Systems. test # [ 1.627094] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 1.644234] systemd[1]: Finished Create System Files and Directories. test # [ 1.640718] Console: switching to colour frame buffer device 160x50 test # [ 1.645615] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device second # [ 1.659638] systemd[1]: Finished Apply Kernel Variables. second # [ 1.662621] systemd-udevd[80]: Using default interface naming scheme 'v261'. test # [ 1.651647] systemd-modules-load[74]: Inserted module 'dm_mod' test # [ 1.652809] systemd-modules-load[74]: Module 'virtio_balloon' is built in test # [ 1.653467] systemd-modules-load[74]: Module 'virtio_console' is built in test # [ 1.659532] systemd[1]: Started Journal Service. test # [ 1.660117] systemd-modules-load[74]: Inserted module 'virtio_gpu' test # [ 1.660696] systemd-modules-load[74]: Module 'virtio_rng' is built in test # [ 1.663140] systemd[1]: Finished Load Kernel Modules. second # [ 1.684983] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.688818] systemd[1]: Starting Apply Kernel Variables... test # [ 1.692130] systemd[1]: Starting Create System Files and Directories... test # [ 1.698315] systemd-udevd[79]: Using default interface naming scheme 'v261'. test # [ 1.710496] systemd[1]: Finished Apply Kernel Variables. test # [ 1.716699] systemd[1]: Finished Create System Files and Directories. second # [ 1.742518] systemd[1]: Starting Virtual Console Setup... test # [ 1.729785] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 1.784519] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 1.786305] systemd[1]: Finished Virtual Console Setup. test # [ 1.775424] systemd[1]: Starting Virtual Console Setup... test # [ 1.816612] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 1.820964] systemd[1]: Finished Virtual Console Setup. second # [ 1.996924] systemd[1]: Finished Coldplug All udev Devices. second # [ 1.997497] systemd[1]: Reached target System Initialization. second # [ 1.997990] systemd[1]: Reached target Basic System. test # [ 2.040846] systemd[1]: Finished Coldplug All udev Devices. test # [ 2.041389] systemd[1]: Reached target System Initialization. test # [ 2.041844] systemd[1]: Reached target Basic System. second # [ 2.090082] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.110380] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.133915] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.163627] systemd[1]: Found device /dev/disk/by-label/nixos. second # [ 2.167131] systemd[1]: Reached target Initrd Root Device. test # [ 2.153155] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.170889] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 2.209209] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 2.215735] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.205404] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.212327] systemd[1]: Reached target Initrd Root Device. test # [ 2.215429] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 2.255330] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks test # [ 2.260977] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.458408] systemd[1]: Mounting /sysroot... second # [ 2.488294] EXT4-fs (vda): mounted filesystem d0a8f9ce-00dd-4a0d-a529-643bea45ea6b r/w with ordered data mode. Quota mode: none. second # [ 2.488716] systemd[1]: Mounted /sysroot. second # [ 2.490219] systemd[1]: Reached target Initrd Root File System. second # [ 2.495267] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 2.506175] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 2.518420] systemd[1]: Mounting /sysroot/run... test # [ 2.506683] systemd[1]: Mounting /sysroot... second # [ 2.526884] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 2.546706] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 2.536033] EXT4-fs (vda): mounted filesystem 43eb4e23-cf37-4731-a75e-3ba96593425c r/w with ordered data mode. Quota mode: none. test # [ 2.537168] systemd[1]: Mounted /sysroot. test # [ 2.538471] systemd[1]: Reached target Initrd Root File System. second # [ 2.554455] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.544074] systemd[1]: Starting Mountpoints Configured in the Real Root... second # [ 2.565190] systemd[1]: Mounted /sysroot/nix/.ro-store. second # [ 2.578308] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 2.562694] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. second # [ 2.583597] systemd[1]: Mounted /sysroot/run. test # [ 2.568078] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.570917] systemd[1]: Reloading... second # [ 2.600190] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 2.601579] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 2.604316] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload. second # [ 2.611274] systemd[1]: Mounted /sysroot/tmp/xchg. second # [ 2.623390] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)... second # [ 2.625354] systemd[1]: Reloading... test # [ 2.734483] systemd[1]: Reloading finished in 164 ms. test # [ 2.751595] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... test # [ 2.753927] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... test # [ 2.756194] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 2.764545] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.772246] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 2.774379] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.776512] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 2.778318] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 2.799092] systemd[1]: Reloading finished in 177 ms. second # [ 2.829026] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace... second # [ 2.830373] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 2.832474] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 2.834914] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace... second # [ 2.843727] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 2.853035] systemd[1]: initrd-parse-etc.service: Deactivated successfully. second # [ 2.855419] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.856603] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. second # [ 2.858636] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 2.860204] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 2.977053] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory test # [ 2.981275] (udev-worker)[96]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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 directory test # [ 2.990360] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 2.992273] systemd[1]: Stopped Virtual Console Setup. test # [ 2.996174] systemd[1]: Stopping Virtual Console Setup... test # [ 2.996669] systemd[1]: Starting Virtual Console Setup... second # [ 3.021373] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory second # [ 3.025696] (udev-worker)[95]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/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 directory test # [ 3.018869] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 3.036148] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.021063] systemd[1]: Finished Virtual Console Setup. second # [ 3.037346] systemd[1]: Stopped Virtual Console Setup. second # [ 3.038497] systemd[1]: Stopping Virtual Console Setup... second # [ 3.039819] systemd[1]: Starting Virtual Console Setup... second # [ 3.061603] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 3.063198] systemd[1]: Finished Virtual Console Setup. second # [ 3.460370] systemd[1]: Mounting /sysroot/nix/store... second # [ 3.511466] systemd[1]: Mounted /sysroot/nix/store. second # [ 3.513659] systemd[1]: Reached target Initrd File Systems. second # [ 3.517305] systemd[1]: Starting Find NixOS closure... test # [ 3.510291] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.528688] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 3.521645] systemd[1]: Mounting /sysroot/nix/.rw-store... test # [ 3.523399] systemd[1]: Mounting /sysroot/run... test # [ 3.536265] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.564269] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. test # [ 3.552604] systemd[1]: Mounting /sysroot/tmp/xchg... second # [ 3.569877] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. second # [ 3.584311] systemd[1]: Finished Find NixOS closure. second # [ 3.586253] systemd[1]: Reached target Initrd Default Target. second # [ 3.587625] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 3.584303] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 3.589628] systemd[1]: Mounted /sysroot/run. test # [ 3.597262] systemd[1]: Mounted /sysroot/nix/.ro-store. second # [ 3.613276] systemd[1]: Stopped target Initrd Default Target. test # [ 3.598160] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.614769] systemd[1]: Stopped target Basic System. second # [ 3.615874] systemd[1]: Stopped target Initrd Root Device. test # [ 3.603696] systemd[1]: Mounted /sysroot/tmp/xchg. second # [ 3.619890] systemd[1]: Stopped target Path Units. second # [ 3.620631] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 3.605749] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.621592] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 3.623234] systemd[1]: Stopped target Slice Units. second # [ 3.625228] systemd[1]: Stopped target Socket Units. second # [ 3.628130] systemd[1]: Stopped target System Initialization. second # [ 3.628833] systemd[1]: Stopped target Swaps. second # [ 3.629360] systemd[1]: Stopped target Timer Units. second # [ 3.630149] systemd[1]: dbus.socket: Deactivated successfully. second # [ 3.631949] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 3.633782] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. second # [ 3.636188] systemd[1]: Stopped Find NixOS closure. second # [ 3.636781] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 3.622264] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.623303] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.640107] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.640752] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 3.641405] systemd[1]: Stopped Apply Kernel Variables. second # [ 3.643021] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 3.647861] systemd[1]: Stopped Load Kernel Modules. second # [ 3.648508] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 3.650709] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 3.653616] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 3.657433] systemd[1]: Stopped Create System Files and Directories. second # [ 3.658152] systemd[1]: Stopped target Local File Systems. second # [ 3.659105] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.659874] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 3.671835] systemd[1]: Stopped Coldplug All udev Devices. second # [ 3.672552] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 3.673265] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.673939] systemd[1]: Stopped Virtual Console Setup. second # [ 3.674416] systemd[1]: initrd-cleanup.service: Deactivated successfully. second # [ 3.674948] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 3.679656] systemd[1]: systemd-udevd.service: Deactivated successfully. second # [ 3.680682] systemd[1]: Stopped Rule-based Manager for Device Events and Files. second # [ 3.684143] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 3.684796] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 3.685289] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.685871] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.686967] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. second # [ 3.688406] systemd[1]: Closed udev Control Socket. second # [ 3.688917] systemd[1]: Starting Cleanup udev Database... second # [ 3.689447] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. second # [ 3.690076] systemd[1]: Stopped Create Static Device Nodes in /dev. second # [ 3.690592] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 3.691242] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. second # [ 3.691833] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 3.692536] systemd[1]: Stopped Create List of Static Device Nodes. second # [ 3.712559] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. second # [ 3.714199] systemd[1]: Finished Cleanup udev Database. second # [ 3.714717] systemd[1]: Reached target Switch Root. second # [ 3.716888] systemd[1]: Starting NixOS Activation... second # [ 3.902696] initrd-nixos-activation-start[179]: booting system configuration /nix/store/8h45q4iq7g1vs9x170gs07j7xsslbz2y-nixos-system-second-test second # [ 3.972278] initrd-nixos-activation-start[179]: running activation script... second # [ 4.435842] initrd-nixos-activation-start[203]: setting up /etc... test # [ 4.507497] systemd[1]: Mounting /sysroot/nix/store... test # [ 4.557973] systemd[1]: Mounted /sysroot/nix/store. test # [ 4.560518] systemd[1]: Reached target Initrd File Systems. test # [ 4.563705] systemd[1]: Starting Find NixOS closure... test # [ 4.572624] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 4.612349] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. test # [ 4.614092] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. test # [ 4.625711] systemd[1]: Finished Find NixOS closure. test # [ 4.627578] systemd[1]: Reached target Initrd Default Target. test # [ 4.632201] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 4.659403] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 4.660997] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 4.664113] systemd[1]: Stopped target Initrd Default Target. test # [ 4.665268] systemd[1]: Stopped target Basic System. test # [ 4.666027] systemd[1]: Stopped target Initrd Root Device. test # [ 4.668197] systemd[1]: Stopped target Path Units. test # [ 4.668866] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 4.670719] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. test # [ 4.672983] systemd[1]: Stopped target Slice Units. test # [ 4.676108] systemd[1]: Stopped target Socket Units. test # [ 4.676723] systemd[1]: Stopped target System Initialization. test # [ 4.677375] systemd[1]: Stopped target Swaps. test # [ 4.677889] systemd[1]: Stopped target Timer Units. test # [ 4.678448] systemd[1]: dbus.socket: Deactivated successfully. test # [ 4.679098] systemd[1]: Closed D-Bus System Message Bus Socket. test # [ 4.679752] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 4.684157] systemd[1]: Stopped Find NixOS closure. test # [ 4.685713] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 4.687270] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 4.690622] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 4.692178] systemd[1]: Stopped Apply Kernel Variables. test # [ 4.693721] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 4.709303] initrd-nixos-activation-start[203]: setting up age secrets... test # [ 4.702274] systemd[1]: Stopped Load Kernel Modules. test # [ 4.702820] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 4.706765] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. test # [ 4.710274] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 4.711555] systemd[1]: Stopped Create System Files and Directories. test # [ 4.715315] systemd[1]: Stopped target Local File Systems. test # [ 4.715971] systemd[1]: Stopped target Preparation for Local File Systems. test # [ 4.717352] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. test # [ 4.720460] systemd[1]: Stopped Coldplug All udev Devices. test # [ 4.720967] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 4.721567] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 4.722153] systemd[1]: Stopped Virtual Console Setup. test # [ 4.722585] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 4.723170] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 4.723693] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 4.725757] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 4.726276] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 4.726846] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 4.727448] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 4.728125] systemd[1]: Closed udev Control Socket. test # [ 4.728557] systemd[1]: Starting Cleanup udev Database... test # [ 4.729027] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 4.729673] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 4.730184] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 4.730837] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 4.731427] systemd[1]: kmod-static-nodes.service: Deactivated successfully. test # [ 4.731996] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 4.749481] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 4.750173] systemd[1]: Finished Cleanup udev Database. test # [ 4.751700] systemd[1]: Reached target Switch Root. test # [ 4.755478] systemd[1]: Starting NixOS Activation... second # [ 4.941044] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 4.942733] systemd[1]: Finished NixOS Activation. second # [ 4.943512] systemd[1]: Starting Switch Root... second # [ 4.960914] systemd[1]: Switching root. test # [ 4.947297] initrd-nixos-activation-start[180]: booting system configuration /nix/store/sn1vcypf8wfjwz7k1hw3av6y5n03s2j3-nixos-system-test-test test # [ 5.017303] initrd-nixos-activation-start[180]: running activation script... second # [ 5.134717] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). test # [ 5.491301] initrd-nixos-activation-start[203]: setting up /etc... second # [ 5.724386] systemd[1]: systemd 261 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) second # [ 5.730456] systemd[1]: Detected virtualization qemu. second # [ 5.732205] systemd[1]: Detected architecture arm64. second # [ 5.734423] systemd[1]: Detected first boot. second # [ 5.739507] systemd[1]: Initializing machine ID from random generator. test # [ 5.769265] initrd-nixos-activation-start[203]: setting up age secrets... second # [ 6.029517] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 6.082237] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 6.083949] systemd[1]: Finished NixOS Activation. test # [ 6.084812] systemd[1]: Starting Switch Root... test # [ 6.104865] systemd[1]: Switching root. second # [ 6.211091] systemd[1]: Applying preset policy. test # [ 6.279272] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). second # [ 6.783837] systemd[1]: Populated /etc with preset unit settings. test # [ 6.887604] systemd[1]: systemd 261 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) test # [ 6.894284] systemd[1]: Detected virtualization qemu. test # [ 6.895983] systemd[1]: Detected architecture arm64. test # [ 6.898198] systemd[1]: Detected first boot. test # [ 6.903582] systemd[1]: Initializing machine ID from random generator. test # [ 7.192941] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 7.349081] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 7.349897] systemd[1]: Stopped initrd-switch-root.service. second # [ 7.351873] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 7.354814] systemd[1]: Created slice Slice /system/getty. second # [ 7.356416] systemd[1]: Created slice User and Session Slice. second # [ 7.357584] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 7.359002] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 7.360077] systemd[1]: Expecting device /dev/hvc0... second # [ 7.361161] systemd[1]: Expecting device /dev/ttyAMA0... second # [ 7.362075] systemd[1]: Reached target Local Encrypted Volumes. second # [ 7.363075] systemd[1]: Stopped target initrd-fs.target. second # [ 7.364052] systemd[1]: Stopped target initrd-root-fs.target. second # [ 7.365565] systemd[1]: Stopped target initrd-switch-root.target. second # [ 7.367041] systemd[1]: Reached target Virtual Machines and Containers. second # [ 7.368676] systemd[1]: Reached target Path Units. second # [ 7.369551] systemd[1]: Reached target Remote File Systems. second # [ 7.371007] systemd[1]: Reached target Slice Units. second # [ 7.372431] systemd[1]: Reached target Swaps. second # [ 7.376204] systemd[1]: Listening on Query the User Interactively for a Password. second # [ 7.380672] systemd[1]: Listening on Process Core Dump Socket. test # [ 7.368628] systemd[1]: Applying preset policy. second # [ 7.384342] systemd[1]: Listening on Credential Encryption/Decryption. second # [ 7.387947] systemd[1]: Listening on Factory Reset Management. second # [ 7.389466] systemd[1]: Listening on Hostname Service Socket. second # [ 7.394141] systemd[1]: Starting Journal Log Access Socket... second # [ 7.396174] systemd[1]: Listening on Journal Audit Socket. second # [ 7.400355] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 7.401595] systemd[1]: Listening on Network Management Metrics Varlink Socket. second # [ 7.402871] systemd[1]: Listening on Network Management Varlink Socket. second # [ 7.404072] systemd[1]: Listening on Network Management Netlink Socket. second # [ 7.406412] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 7.407504] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.408830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 7.418495] systemd[1]: Listening on Disk Repartitioning Service Socket. second # [ 7.419558] systemd[1]: Listening on Resolve Monitor Varlink Socket. second # [ 7.420676] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 7.421735] systemd[1]: Listening on udev Control Socket. second # [ 7.422715] systemd[1]: Listening on udev Varlink Socket. second # [ 7.426412] systemd[1]: Mounting Huge Pages File System... second # [ 7.430190] systemd[1]: Mounting POSIX Message Queue File System... second # [ 7.440422] systemd[1]: Mounting Kernel Debug File System... second # [ 7.448474] systemd[1]: Mounting Kernel Trace File System... second # [ 7.458532] systemd[1]: Starting Create List of Static Device Nodes... second # [ 7.467895] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 7.470225] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 7.483081] systemd[1]: Mounting Kernel Configuration File System... second # [ 7.484287] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 7.485807] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 7.496828] systemd[1]: Starting Load Kernel Module fuse... second # [ 7.497806] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 second # [ 7.549855] systemd[1]: Starting Journal Service... second # [ 7.572920] systemd[1]: Starting Load Kernel Modules... second # [ 7.597835] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 7.615609] fuse: init (API version 7.45) second # [ 7.622130] systemd[1]: Starting Remount Root and Kernel File Systems... second # [ 7.624040] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.641899] systemd[1]: Starting Coldplug All udev Devices... second # [ 7.643810] systemd[1]: Listening on Journal Log Access Socket. second # [ 7.656767] systemd[1]: Mounted Huge Pages File System. second # [ 7.677718] systemd[1]: Mounted POSIX Message Queue File System. second # [ 7.680381] systemd[1]: Mounted Kernel Debug File System. second # [ 7.682282] systemd[1]: Mounted Kernel Trace File System. second # [ 7.684207] systemd[1]: Finished Create List of Static Device Nodes. second # [ 7.689487] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 7.693195] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 7.700325] systemd[1]: Mounted Kernel Configuration File System. second # [ 7.701225] systemd[1]: modprobe@fuse.service: Deactivated successfully. second # [ 7.704501] systemd[1]: Finished Load Kernel Module fuse. second # [ 7.709607] systemd[1]: Mounting FUSE Control File System... second # [ 7.719616] systemd-journald[304]: Collecting audit messages is enabled. second # [ 7.727578] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 7.728157] systemd[1]: Started Journal Service. second # [ 7.723264] systemd[1]: Queued start job for default target Multi-User System. second # [ 7.731493] systemd[1]: systemd-journald.service: Deactivated successfully. second # [ 7.738720] systemd-modules-load[305]: Module 'atkbd' is built in second # [ 7.741245] systemd-modules-load[305]: Module 'ctr' is built in second # [ 7.743475] systemd-modules-load[305]: Module 'loop' is built in[ 7.748292] EXT4-fs (vda): re-mounted d0a8f9ce-00dd-4a0d-a529-643bea45ea6b. second # second # [ 7.749291] systemd[1]: Finished Load Kernel Modules. second # [ 7.751996] systemd-oomd[306]: No swap; memory pressure usage will be degraded second # [ 7.760580] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. second # [ 7.762435] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 7.780125] systemd[1]: Listening on Disk Image Download Service Socket. second # [ 7.783746] systemd[1]: Starting Firewall... second # [ 7.790989] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 7.792609] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore second # [ 7.817653] systemd[1]: Starting Load/Save OS Random Seed... second # [ 7.820946] systemd[1]: Starting Apply Kernel Variables... second # [ 7.824647] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.870738] systemd[1]: Mounted FUSE Control File System. second # [ 7.885908] systemd-journald[304]: Received client request to flush runtime journal. second # [ 7.943162] systemd[1]: Finished Load/Save OS Random Seed. second # [ 7.948140] systemd[1]: Reached target First Boot Complete. second # [ 7.950867] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 7.954113] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 7.944270] systemd[1]: Populated /etc with preset unit settings. second # [ 7.960195] systemd[1]: Finished Flush Journal to Persistent Storage. second # [ 7.967750] systemd[1]: Finished Apply Kernel Variables. second # [ 7.975498] systemd[1]: Starting Network Name Resolution... second # [ 8.053367] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 8.054122] systemd[1]: Reached target Preparation for Local File Systems. second # [ 8.057236] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 8.113803] systemd-resolved[338]: Positive Trust Anchors: second # [ 8.114729] systemd-resolved[338]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d second # [ 8.117384] systemd-resolved[338]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 8.128213] 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 test second # [ 8.192768] systemd-udevd[343]: Using default interface naming scheme 'v261'. second # [ 8.351728] systemd[1]: Mounting /run/wrappers... second # [ 8.373019] systemd-resolved[338]: Using system hostname 'second'. second # [ 8.382064] systemd[1]: Started Network Name Resolution. second # [ 8.413841] systemd[1]: Mounted /run/wrappers. second # [ 8.415844] systemd[1]: Reached target Local File Systems. second # [ 8.424488] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 8.435189] systemd[1]: Starting register-nix-paths.service... second # [ 8.438458] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 8.439533] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 8.443103] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 8.461871] systemd[1]: Starting Create System Files and Directories... second # [ 8.502644] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 8.521442] systemd[1]: initrd-switch-root.service: Deactivated successfully. test # [ 8.522288] systemd[1]: Stopped initrd-switch-root.service. test # [ 8.524250] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. test # [ 8.527221] systemd[1]: Created slice Slice /system/getty. test # [ 8.528210] systemd[1]: Created slice User and Session Slice. test # [ 8.529506] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 8.530244] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 8.531367] systemd[1]: Expecting device /dev/hvc0... test # [ 8.532539] systemd[1]: Expecting device /dev/ttyAMA0... test # [ 8.533405] systemd[1]: Reached target Local Encrypted Volumes. test # [ 8.534429] systemd[1]: Stopped target initrd-fs.target. test # [ 8.535468] systemd[1]: Stopped target initrd-root-fs.target. test # [ 8.536499] systemd[1]: Stopped target initrd-switch-root.target. test # [ 8.537487] systemd[1]: Reached target Virtual Machines and Containers. test # [ 8.539081] systemd[1]: Reached target Path Units. test # [ 8.540506] systemd[1]: Reached target Remote File Systems. test # [ 8.541935] systemd[1]: Reached target Slice Units. test # [ 8.543283] systemd[1]: Reached target Swaps. test # [ 8.547006] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 8.551381] systemd[1]: Listening on Process Core Dump Socket. test # [ 8.554933] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 8.558772] systemd[1]: Listening on Factory Reset Management. test # [ 8.559751] systemd[1]: Listening on Hostname Service Socket. test # [ 8.564781] systemd[1]: Starting Journal Log Access Socket... test # [ 8.566011] systemd[1]: Listening on Journal Audit Socket. test # [ 8.569588] systemd[1]: Listening on Console Output Muting Service Socket. test # [ 8.570706] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 8.571900] systemd[1]: Listening on Network Management Varlink Socket. test # [ 8.573108] systemd[1]: Listening on Network Management Netlink Socket. test # [ 8.574414] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. test # [ 8.576053] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.577876] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 8.595249] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 8.588832] systemd[1]: Listening on Disk Repartitioning Service Socket. test # [ 8.589312] systemd[1]: Listening on Resolve Monitor Varlink Socket. test # [ 8.589664] systemd[1]: Listening on Resolve Service Varlink Socket. test # [ 8.589997] systemd[1]: Listening on udev Control Socket. test # [ 8.590328] systemd[1]: Listening on udev Varlink Socket. test # [ 8.595537] systemd[1]: Mounting Huge Pages File System... second # [ 8.609095] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 8.598790] systemd[1]: Mounting POSIX Message Queue File System... test # [ 8.608189] systemd[1]: Mounting Kernel Debug File System... test # [ 8.611515] systemd[1]: Mounting Kernel Trace File System... test # [ 8.621610] systemd[1]: Starting Create List of Static Device Nodes... test # [ 8.630906] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 8.632592] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 8.649837] systemd[1]: Finished Create System Files and Directories. test # [ 8.651540] systemd[1]: Mounting Kernel Configuration File System... test # [ 8.654319] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 8.667165] systemd[1]: Starting Rebuild Journal Catalog... test # [ 8.657297] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 8.670403] systemd[1]: Starting Record System Boot/Shutdown in UTMP... test # [ 8.666098] systemd[1]: Starting Load Kernel Module fuse... test # [ 8.669010] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 8.722132] systemd[1]: Starting Journal Service... test # [ 8.745005] systemd[1]: Starting Load Kernel Modules... second # [ 8.765361] systemd[1]: Finished Record System Boot/Shutdown in UTMP. test # [ 8.765904] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 8.803635] systemd[1]: Finished Coldplug All udev Devices. test # [ 8.792817] fuse: init (API version 7.45) test # [ 8.795947] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 8.796369] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.812885] systemd[1]: Starting Coldplug All udev Devices... test # [ 8.841669] systemd[1]: Listening on Journal Log Access Socket. test # [ 8.843559] systemd[1]: Mounted Huge Pages File System. second # [ 8.857529] systemd[1]: Finished Rebuild Journal Catalog. test # [ 8.846494] systemd[1]: Mounted POSIX Message Queue File System. second # [ 8.859887] systemd[1]: Starting Update is Completed... test # [ 8.851376] systemd[1]: Mounted Kernel Debug File System. test # [ 8.857110] systemd[1]: Mounted Kernel Trace File System. test # [ 8.857792] systemd[1]: Finished Create List of Static Device Nodes. test # [ 8.858323] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 8.858765] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 8.859197] systemd[1]: Mounted Kernel Configuration File System. test # [ 8.859648] systemd[1]: modprobe@fuse.service: Deactivated successfully. test # [ 8.860069] systemd[1]: Finished Load Kernel Module fuse. test # [ 8.880537] systemd[1]: Mounting FUSE Control File System... test # [ 8.882863] systemd-journald[324]: Collecting audit messages is enabled. test # [ 8.892940] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 8.900860] systemd[1]: Queued start job for default target Multi-User System. test # [ 8.902137] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 8.908033] systemd[1]: Finished Load Kernel Modules. test # [ 8.907676] systemd-modules-load[325]: Module 'atkbd' is built in test # [ 8.912779] EXT4-fs (vda): re-mounted 43eb4e23-cf37-4731-a75e-3ba96593425c. second # [ 8.927396] systemd[1]: Finished Update is Completed. test # [ 8.913292] systemd-modules-load[325]: Module 'ctr' is built in test # [ 8.913929] systemd-modules-load[325]: Module 'loop' is built in test # [ 8.926441] systemd[1]: Started Journal Service. test # [ 8.937653] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 8.939933] systemd-oomd[326]: No swap; memory pressure usage will be degraded test # [ 8.951577] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 8.965970] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 8.980158] systemd[1]: Starting Firewall... test # [ 8.983890] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 8.984941] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 8.987057] systemd[1]: Starting Load/Save OS Random Seed... test # [ 9.008957] systemd[1]: Starting Apply Kernel Variables... second # [ 9.025070] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 9.011502] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 9.018942] systemd[1]: Mounted FUSE Control File System. test # [ 9.082461] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 9.096714] systemd-journald[324]: Received client request to flush runtime journal. test # [ 9.159616] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 9.168384] systemd[1]: Finished Load/Save OS Random Seed. test # [ 9.168992] systemd[1]: Reached target First Boot Complete. test # [ 9.171857] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 9.174546] systemd[1]: Finished Apply Kernel Variables. test # [ 9.177418] systemd[1]: Starting Network Name Resolution... test # [ 9.206576] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 9.207231] systemd[1]: Reached target Preparation for Local File Systems. test # [ 9.214323] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 9.291701] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 9.341104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. second # [ 9.343180] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 9.327768] systemd-resolved[358]: Positive Trust Anchors: test # [ 9.328833] systemd-resolved[358]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 9.329953] systemd-resolved[358]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 9.358260] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. test # [ 9.333275] systemd-resolved[358]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test test # [ 9.379851] systemd-udevd[362]: Using default interface naming scheme 'v261'. test # [ 9.523246] systemd[1]: Mounting /run/wrappers... test # [ 9.592388] systemd[1]: Mounted /run/wrappers. test # [ 9.594856] systemd[1]: Reached target Local File Systems. test # [ 9.600572] systemd-resolved[358]: Using system hostname 'test'. test # [ 9.609238] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 9.612941] systemd[1]: Starting register-nix-paths.service... test # [ 9.615891] systemd[1]: Starting Create SUID/SGID Wrappers... test # [ 9.617863] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 9.649537] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 9.671083] (udev-worker)[435]: Network interface NamePolicy= disabled on kernel command line. second # [ 9.678668] (udev-worker)[433]: Network interface NamePolicy= disabled on kernel command line. test # [ 9.665498] systemd[1]: Starting Create System Files and Directories... second # [ 9.687216] systemd[1]: Finished register-nix-paths.service. second # [ 9.690112] systemd[1]: Reached target System Initialization. test # [ 9.675901] systemd[1]: Started Network Name Resolution. second # [ 9.691509] systemd[1]: Started Discard unused filesystem blocks once a week. second # [ 9.695937] systemd[1]: Started Daily Cleanup of Temporary Directories. second # [ 9.698428] systemd[1]: Reached target Timer Units. second # [ 9.700743] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 9.705195] systemd[1]: Listening on Nix Daemon Socket. second # [ 9.706944] systemd[1]: Listening on Authorization Manager Agent Helper. second # [ 9.709351] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. second # [ 9.711533] systemd[1]: Reached target Socket Units. second # [ 9.714678] systemd[1]: Starting D-Bus System Message Bus... second # [ 9.737332] systemd[1]: Finished Firewall. second # [ 9.739218] systemd[1]: Reached target Preparation for Network. second # [ 9.742486] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 9.728522] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 9.746394] systemd[1]: Starting Network Management... test # [ 9.794444] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 9.800144] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 9.870069] systemd[1]: Finished Create System Files and Directories. second # [ 9.890816] mousedev: PS/2 mouse device common for all mice test # [ 9.878116] systemd[1]: Starting Rebuild Journal Catalog... second # [ 9.924602] dbus-broker-launch[527]: Looking up NSS user entry for 'systemd-timesync'... test # [ 9.907537] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 9.960523] dbus-broker-launch[527]: NSS returned no entry for 'systemd-timesync' second # [ 9.961244] dbus-broker-launch[527]: Invalid user-name in /nix/store/b98va0xcf22lbv446dky3a90pzmflhn7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 9.956146] systemd[1]: Finished Coldplug All udev Devices. second # [ 9.979940] cfg80211: Loading compiled-in X.509 certificates for regulatory database second # [ 10.017084] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' second # [ 10.017615] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 10.021430] dbus-broker-launch[527]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 10.007199] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 10.023771] dbus-broker-launch[527]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 10.029590] dbus-broker-launch[527]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/q3gr23jczqdkab4ynasfyv5pk0907sly-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' second # [ 10.040135] dbus-broker-launch[527]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/50h0k21qqr8489rim5ww9gp74lvl1i34-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 10.047267] systemd[1]: Started D-Bus System Message Bus. test # [ 10.059369] systemd[1]: Finished Rebuild Journal Catalog. test # [ 10.066030] systemd[1]: Starting Update is Completed... second # [ 10.095682] systemd-networkd[530]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 10.106505] systemd-networkd[530]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 10.111569] systemd-networkd[530]: lo: Link UP second # [ 10.117684] systemd-networkd[530]: lo: Gained carrier second # [ 10.120747] dbus-broker-launch[527]: Ready second # [ 10.121807] systemd[1]: Started Network Management. second # [ 10.123741] systemd[1]: Reached target Basic System. second # [ 10.127817] systemd-networkd[530]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 10.131620] systemd-networkd[530]: eth1: Configuring with /etc/systemd/network/40-eth1.network. second # [ 10.138516] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 10.139131] systemd-networkd[530]: eth1: Link UP second # [ 10.139562] systemd-networkd[530]: eth1: Gained carrier second # [ 10.141545] systemd-networkd[530]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 10.149147] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 10.137261] systemd[1]: Finished Update is Completed. second # [ 10.153754] systemd[1]: Starting Network Manager... second # [ 10.169543] systemd[1]: Started backdoor.service. second # [ 10.197882] systemd[1]: Starting Import lastlog data into lastlog2 database... second # [ 10.215249] systemd[1]: Starting Name Service Cache Daemon (nsncd)... second # [ 10.256320] systemd[1]: Starting Post-Boot Actions... second # [ 10.261950] bfrwvyg79my69yafr053q6bzx4lix24v-wifi-secrets[539]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 10.286382] systemd[1]: Started Reset console on configuration changes. test # [ 10.271354] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 10.329501] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # [ 10.334005] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 10.381518] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. second # connecting to host... second # [ 10.438794] systemd[1]: Finished Post-Boot Actions. second # [ 10.491377] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 10.491997] systemd[1]: Reached target Host and Network Name Lookups. second # [ 10.501558] systemd[1]: Reached target User and Group Name Lookups. second # [ 10.507102] nsncd[544]: Aug 01 20:09:20.328 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 10.517642] systemd[1]: Starting User Login Management... second # [ 10.520488] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. second # [ 10.532627] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 10.515183] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 10.520859] systemd[1]: Finished Create SUID/SGID Wrappers. second # [ 10.542315] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 10.543560] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 10.617902] systemd[1]: Starting Hostname Service... test # [ 10.617401] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. second # [ 10.679386] systemd-logind[577]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) second # [ 10.682094] systemd-logind[577]: Watching system buttons on /dev/input/event0 (gpio-keys) second # [ 10.684976] systemd-logind[577]: New seat seat0. second # [ 10.690060] systemd[1]: Started User Login Management. second # [ 10.699332] systemd[1]: Starting linger-users.service... second # [ 10.757322] systemd[1]: Started Hostname Service. second # [ 10.772817] systemd[1]: linger-users.service: Deactivated successfully. second # [ 10.775702] systemd[1]: Finished linger-users.service. second # [ 10.860511] systemd-networkd[530]: eth0: Link UP second # [ 10.861017] systemd-networkd[530]: eth0: Gained carrier second # [ 10.882852] systemd[1]: Started Network Manager. second # [ 10.885004] systemd[1]: Reached target Network. second # [ 10.891131] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 10.906998] systemd[1]: Starting Permit User Sessions... test # [ 10.903529] systemd[1]: Finished register-nix-paths.service. test # [ 10.905834] systemd[1]: Reached target System Initialization. test # [ 10.908515] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 10.912316] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 10.912947] systemd[1]: Reached target Timer Units. test # [ 10.913573] (udev-worker)[464]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.914439] (udev-worker)[462]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.915135] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 10.915657] systemd[1]: Listening on Nix Daemon Socket. test # [ 10.923544] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 10.927362] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. test # [ 10.932820] systemd[1]: Reached target Socket Units. test # [ 10.934932] systemd[1]: Starting D-Bus System Message Bus... test # [ 10.988859] systemd[1]: Finished Firewall. test # [ 10.991175] systemd[1]: Reached target Preparation for Network. test # [ 10.992640] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 10.996485] systemd[1]: Starting Network Management... second # [ 11.060634] systemd[1]: Finished Permit User Sessions. second # [ 11.074951] systemd[1]: Started Getty on tty1. second # [ 11.075453] systemd[1]: Reached target Login Prompts. test # [ 11.106766] mousedev: PS/2 mouse device common for all mice test # [ 11.119487] dbus-broker-launch[543]: Looking up NSS user entry for 'systemd-timesync'... second # [ 11.149386] systemd-resolved[338]: eth0: Bus client set default route setting: yes test # [ 11.136772] dbus-broker-launch[543]: NSS returned no entry for 'systemd-timesync' second # [ 11.152431] systemd-resolved[338]: eth0: Bus client set DNS server list to: 10.0.2.3 test # [ 11.138291] dbus-broker-launch[543]: Invalid user-name in /nix/store/b98va0xcf22lbv446dky3a90pzmflhn7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 11.202332] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. second # [ 11.207209] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. test # [ 11.222835] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 11.233627] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 11.236307] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' test # [ 11.240260] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/q3gr23jczqdkab4ynasfyv5pk0907sly-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 11.244192] dbus-broker-launch[543]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/50h0k21qqr8489rim5ww9gp74lvl1i34-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' test # [ 11.252248] systemd[1]: Started D-Bus System Message Bus. test # [ 11.270257] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 11.270759] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' test # [ 11.306988] dbus-broker-launch[543]: Ready test # [ 11.311460] systemd[1]: Reached target Basic System. second # [ 11.330526] systemd[1]: Reached target Multi-User System. test # [ 11.317968] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 11.334093] systemd[1]: Startup finished in 712ms (kernel) + 4.515s (initrd) + 6.104s (userspace) = 11.332s. test # [ 11.321358] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 11.331533] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.361714] systemd-networkd[530]: eth1: Gained IPv6LL test # [ 11.346755] systemd-networkd[549]: /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. test # [ 11.359686] systemd-networkd[549]: /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. test # [ 11.365865] systemd-networkd[549]: lo: Link UP test # [ 11.372919] systemd-networkd[549]: lo: Gained carrier test # [ 11.377613] systemd-networkd[549]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 11.383160] systemd-networkd[549]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 11.386430] systemd-networkd[549]: eth1: Link UP test # [ 11.396698] systemd-networkd[549]: eth1: Gained carrier test # [ 11.397443] systemd-networkd[549]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 11.408160] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 11.414354] systemd[1]: Starting Network Manager... test # [ 11.433206] systemd[1]: Started backdoor.service. test # [ 11.439173] bfrwvyg79my69yafr053q6bzx4lix24v-wifi-secrets[558]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 11.468467] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 11.481191] 6zad8qjsgcihj3d5ws39j6s93s5yrjm7-wifi-secrets[559]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 11.490794] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 11.495504] vx4skfrgyqk0f8j1mp5lv936zif6nn10-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 11.521659] systemd[1]: Starting Post-Boot Actions... test # [ 11.549682] systemd[1]: Started Reset console on configuration changes. test # [ 11.565566] systemd[1]: Started Network Management. test # connecting to host... test # [ 11.610289] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 11.634523] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 test # [ 11.619048] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.630000] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test # [ 11.635139] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.635825] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. test # [ 11.646071] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test: Guest shell says: b'Spawning backdoor root shell...\n' test # [ 11.667573] systemd[1]: Finished Post-Boot Actions. test # [ 11.695404] systemd[1]: Started Name Service Cache Daemon (nsncd). test # [ 11.701282] nsncd[572]: Aug 01 20:09:21.543 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test # [ 11.707220] systemd[1]: Reached target Host and Network Name Lookups. test: connected to guest root shell test # [ 11.711249] systemd[1]: Reached target User and Group Name Lookups. test: (connecting took 11.96 seconds) test: (finished: waiting for the VM to finish booting, in 11.96 seconds) test # [ 11.726244] systemd[1]: Starting User Login Management... test # [ 11.731324] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 11.761442] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 11.769958] systemd[1]: Started Network Manager Script Dispatcher Service. second # [ 11.884118] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. test # [ 11.878314] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 11.893393] systemd[1]: Starting Hostname Service... second # [ 11.916455] systemd[1]: Starting Virtual Console Setup... test # [ 11.919190] systemd-logind[602]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) test # [ 11.922045] systemd-logind[602]: Watching system buttons on /dev/input/event0 (gpio-keys) test # [ 11.923036] systemd-logind[602]: New seat seat0. second # [ 11.941764] systemd-logind[577]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) test # [ 11.928314] systemd[1]: Started User Login Management. test # [ 11.930713] systemd[1]: Starting linger-users.service... test # [ 12.004355] systemd[1]: linger-users.service: Deactivated successfully. test # [ 12.007163] systemd[1]: Finished linger-users.service. test # [ 12.020522] systemd[1]: Started Hostname Service. test # [ 12.114380] systemd-networkd[549]: eth0: Link UP test # [ 12.114839] systemd-networkd[549]: eth0: Gained carrier test # [ 12.135671] systemd[1]: Started Network Manager. test # [ 12.137365] systemd[1]: Reached target Network. test # [ 12.141207] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 12.152979] systemd[1]: Starting Permit User Sessions... test # [ 12.287240] systemd[1]: Finished Permit User Sessions. test # [ 12.301771] systemd[1]: Started Getty on tty1. test # [ 12.304771] systemd[1]: Reached target Login Prompts. test # [ 12.349446] systemd-resolved[358]: eth0: Bus client set default route setting: yes test # [ 12.353341] systemd-resolved[358]: eth0: Bus client set DNS server list to: 10.0.2.3 second # [ 12.372824] systemd-vconsole-setup[640]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 12.375609] systemd[1]: Finished Virtual Console Setup. test # [ 12.358817] NetworkManager[561]: [1785614962.2026] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty test # [ 12.417259] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. test # [ 12.418651] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. test # [ 12.557641] systemd[1]: Reached target Multi-User System. test # [ 12.562017] systemd[1]: Startup finished in 698ms (kernel) + 5.680s (initrd) + 6.180s (userspace) = 12.560s. second # [ 12.675763] systemd-networkd[530]: eth0: Gained IPv6LL test # [ 12.901408] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 test: (finished: waiting for unit NetworkManager.service, in 13.21 seconds) test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds) test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds) test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds) (finished: run the VM test script, in 13.72 seconds) test script finished in 13.78s cleanup kill QemuMachine (pid 47) second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) test # [ 13.218029] systemd-networkd[549]: eth1: Gained IPv6LL test # [ 13.225880] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. test # [ 13.233933] systemd[1]: Starting Virtual Console Setup... test # [ 13.253888] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 13.257029] systemd[1]: Stopped Virtual Console Setup. kill QemuMachine (pid 48) test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.25 seconds)