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.0 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 # Disk image does not exist, creating the virtualisation disk image... second # Formatting '/build/vm-state-second/tmp.kSCopSQhoR', fmt=raw size=1073741824 second # mke2fs 1.47.4 (6-Mar-2025) second # Discarding device blocks: 0/262144 done second # Creating filesystem with 262144 4k blocks and 65536 inodes second # Filesystem UUID: 235ccac8-d358-4119-8253-4558ab49ee4a second # Superblock backups stored on blocks: second # 32768, 98304, 163840, 229376 second # second # Allocating group tables: 0/8 done second # Writing inode tables: 0/8 done second # Creating journal (8192 blocks): done second # Writing superblocks and filesystem accounting information: 0/8 done second # second # Virtualisation disk image created. second: QEMU running (pid 47) test # Disk image does not exist, creating the virtualisation disk image... test: QEMU running (pid 48) test # Formatting '/build/vm-state-test/tmp.bpI3MEbGda', fmt=raw size=1073741824 test # mke2fs 1.47.4 (6-Mar-2025) test # Discarding device blocks: 0/262144 done test # Creating filesystem with 262144 4k blocks and 65536 inodes test # Filesystem UUID: 13a5909b-75a1-46d8-91b8-51a5d8bc6041 test # Superblock backups stored on blocks: test # 32768, 98304, 163840, 229376 test # test # Allocating group tables: 0/8 done test # Writing inode tables: 0/8 done test # Creating journal (8192 blocks): done test # Writing superblocks and filesystem accounting information: 0/8 done test # test # Virtualisation disk image created. (finished: start all VMs, in 0.44 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.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Aug 19 16:18:21 UTC 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 0x7fc07700-0x7fc0ae7f] 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 s186712 r8192 d116392 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 test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] 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 test # [ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Aug 19 16:18:21 UTC 2026 test # [ 0.000000] KASLR enabled test # [ 0.000000] random: crng init done test # [ 0.000000] Machine model: linux,dummy-virt test # [ 0.000000] efi: UEFI not found. test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] 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/dkdgmkd0q0n8qvg06lvb9n9bhvw9pz66-nixos-system-second-test/init regInfo=/nix/store/ihinz71gg5568ny8xw6vcx2r7phl4rms-closure-info/registration console=ttyAMA0,115200n8 console=tty0 test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f] test # [ 0.000000] Zone ranges: test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] DMA32 empty second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ihinz71gg5568ny8xw6vcx2r7phl4rms-closure-info/registration", will be passed to user space. test # [ 0.000000] Normal empty test # [ 0.000000] Device empty second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes test # [ 0.000000] Movable zone start for each node test # [ 0.000000] Early memory node ranges second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 second # [ 0.000000] software IO TLB: area num 1. test # [ 0.000000] psci: probing for conduit method from DT. second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) test # [ 0.000000] psci: PSCIv1.3 detected in firmware. second # [ 0.000000] Fallback order for Node 0: 0 test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 test # [ 0.000000] psci: Trusted OS migration not required second # [ 0.000000] Policy zone: DMA test # [ 0.000000] psci: SMC Calling Convention v1.1 second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 test # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296 second # [ 0.000000] allocated 2097152 bytes of page_ext test # [ 0.000000] Detected PIPT I-cache on CPU0 second # [ 0.000000] ftrace: allocating 74881 entries in 294 pages test # [ 0.000000] CPU features: detected: GICv3 CPU interface second # [ 0.000000] ftrace: allocated 294 pages with 4 groups second # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.000000] CPU features: detected: Spectre-v4 second # [ 0.000000] rcu: RCU event tracing is enabled. test # [ 0.000000] CPU features: detected: Spectre-BHB test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) second # [ 0.000000] Trampoline variant of Tasks RCU enabled. second # [ 0.000000] Rude variant of Tasks RCU enabled. test # [ 0.000000] CPU features: detected: ARM erratum 1418040 second # [ 0.000000] Tracing variant of Tasks RCU enabled. second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. 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: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.000000] alternatives: applying boot alternatives second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 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.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] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5c74aq96g7d42fbjn35xjzh0pl7djmcj-nixos-system-test-test/init regInfo=/nix/store/z3i2i3pf2ha4xfdlpkk7g4psbwsz74dw-closure-info/registration console=ttyAMA0,115200n8 console=tty0 second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/z3i2i3pf2ha4xfdlpkk7g4psbwsz74dw-closure-info/registration", will be passed to user space. 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 second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) 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 test # [ 0.000000] software IO TLB: area num 1. second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) test # [ 0.000000] Fallback order for Node 0: 0 test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 test # [ 0.000000] Policy zone: DMA second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 test # [ 0.000000] allocated 2097152 bytes of page_ext test # [ 0.000000] ftrace: allocating 74881 entries in 294 pages test # [ 0.000000] ftrace: allocated 294 pages with 4 groups test # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.000000] rcu: RCU event tracing is enabled. second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns second # [ 0.000078] arm-pv: using stolen time PV test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.000000] Trampoline variant of Tasks RCU enabled. second # [ 0.000656] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.000000] Rude variant of Tasks RCU enabled. second # [ 0.001002] Console: colour dummy device 80x25 test # [ 0.000000] Tracing variant of Tasks RCU enabled. second # [ 0.001015] printk: legacy console [tty0] enabled second # [ 0.001250] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) second # [ 0.001255] pid_max: default: 32768 minimum: 301 second # [ 0.001356] LSM: initializing lsm=capability,landlock,yama,bpf,ima second # [ 0.001557] landlock: Up and running. test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 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] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.001559] Yama: becoming mindful. second # [ 0.002341] LSM support for eBPF active 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.002530] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 test # [ 0.000000] GICv3: 256 SPIs implemented test # [ 0.000000] GICv3: 0 Extended SPIs implemented test # [ 0.000000] Root IRQ handler: gic_handle_irq test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 second # [ 0.002548] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.004797] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.005544] rcu: Hierarchical SRCU implementation. second # [ 0.005549] rcu: Max phase no-delay instances is 1000. second # [ 0.006503] fsl-mc MSI: its@8080000 domain created second # [ 0.006679] EFI services will not be available. test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] second # [ 0.006811] smp: Bringing up secondary CPUs ... second # [ 0.006843] smp: Brought up 1 node, 1 CPU test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) second # [ 0.006846] SMP: Total of 1 processors activated. second # [ 0.006848] CPU: All CPU(s) started at EL1 second # [ 0.006862] CPU features: detected: 32-bit EL0 Support test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 second # [ 0.006865] CPU features: detected: Data cache clean to the PoU not required for I/D coherence test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 second # [ 0.006868] CPU features: detected: Common not Private translations second # [ 0.006870] CPU features: detected: CRC32 instructions test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.006871] CPU features: detected: Data cache clean to Point of Persistence test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns second # [ 0.006874] CPU features: detected: Enhanced Virtualization Traps test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 second # [ 0.006885] CPU features: detected: RCpc load-acquire (LDAPR) test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). second # [ 0.006891] CPU features: detected: LSE atomic instructions second # [ 0.006893] CPU features: detected: Privileged Access Never second # [ 0.006895] CPU features: detected: PMUv3 test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns second # [ 0.006896] CPU features: detected: RAS Extension Support test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns test # [ 0.000079] arm-pv: using stolen time PV second # [ 0.006900] CPU features: detected: Speculative Store Bypassing Safe (SSBS) second # [ 0.006934] alternatives: applying system-wide alternatives test # [ 0.000579] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.008497] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.000919] Console: colour dummy device 80x25 test # [ 0.000935] printk: legacy console [tty0] enabled second # [ 0.008729] Memory: 891432K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115800K reserved, 32768K cma-reserved) test # [ 0.001164] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) second # [ 0.009261] devtmpfs: initialized test # [ 0.001169] pid_max: default: 32768 minimum: 301 second # [ 0.010816] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.001275] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.001605] landlock: Up and running. second # [ 0.010837] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.001608] Yama: becoming mindful. second # [ 0.010972] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL test # [ 0.002436] LSM support for eBPF active second # [ 0.010975] 0 pages in range for non-PLT usage test # [ 0.002628] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.010976] 508288 pages in range for PLT usage second # [ 0.011106] pinctrl core: initialized pinctrl subsystem test # [ 0.002648] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.011955] DMI not present or invalid. test # [ 0.004838] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.016280] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.005573] rcu: Hierarchical SRCU implementation. second # [ 0.018723] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.005579] rcu: Max phase no-delay instances is 1000. test # [ 0.006572] fsl-mc MSI: its@8080000 domain created second # [ 0.018867] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations test # [ 0.006774] EFI services will not be available. test # [ 0.006894] smp: Bringing up secondary CPUs ... second # [ 0.019019] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations test # [ 0.006940] smp: Brought up 1 node, 1 CPU second # [ 0.019044] audit: initializing netlink subsys (disabled) test # [ 0.006943] SMP: Total of 1 processors activated. second # [ 0.019743] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.006945] CPU: All CPU(s) started at EL1 second # [ 0.019746] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.006962] CPU features: detected: 32-bit EL0 Support second # [ 0.019749] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.006965] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.019751] thermal_sys: Registered thermal governor 'user_space' test # [ 0.006968] CPU features: detected: Common not Private translations second # [ 0.019754] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.006970] CPU features: detected: CRC32 instructions second # [ 0.019780] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 test # [ 0.006972] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.019799] cpuidle: using governor ladder test # [ 0.006975] CPU features: detected: Enhanced Virtualization Traps second # [ 0.019804] cpuidle: using governor menu test # [ 0.006989] CPU features: detected: RCpc load-acquire (LDAPR) second # [ 0.019954] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. test # [ 0.006991] CPU features: detected: LSE atomic instructions second # [ 0.019980] ASID allocator initialised with 32768 entries test # [ 0.006993] CPU features: detected: Privileged Access Never second # [ 0.020724] Serial: AMBA PL011 UART driver test # [ 0.006995] CPU features: detected: PMUv3 test # [ 0.006996] CPU features: detected: RAS Extension Support second # [ 0.023981] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 second # [ 0.024144] printk: console [ttyAMA0] enabled test # [ 0.007000] CPU features: detected: Speculative Store Bypassing Safe (SSBS) test # [ 0.007035] alternatives: applying system-wide alternatives test # [ 0.008527] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.008798] Memory: 891440K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 115796K reserved, 32768K cma-reserved) test # [ 0.009330] devtmpfs: initialized test # [ 0.010897] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.010920] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). test # [ 0.011074] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL test # [ 0.011078] 0 pages in range for non-PLT usage test # [ 0.011079] 508288 pages in range for PLT usage test # [ 0.011230] pinctrl core: initialized pinctrl subsystem test # [ 0.012034] DMI not present or invalid. test # [ 0.015879] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.018231] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations test # [ 0.018378] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations test # [ 0.018531] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.099237] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages test # [ 0.018553] audit: initializing netlink subsys (disabled) second # [ 0.099262] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.019251] thermal_sys: Registered thermal governor 'fair_share' second # [ 0.099269] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages test # [ 0.019254] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.099272] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page test # [ 0.019257] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.019259] thermal_sys: Registered thermal governor 'user_space' test # [ 0.019261] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.019291] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 test # [ 0.019305] cpuidle: using governor ladder test # [ 0.019310] cpuidle: using governor menu second # [ 0.099275] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages second # [ 0.099278] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.099281] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages second # [ 0.099284] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page test # [ 0.019452] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. test # [ 0.019477] ASID allocator initialised with 32768 entries test # [ 0.020182] Serial: AMBA PL011 UART driver second # [ 0.104449] fbcon: Taking over console second # [ 0.104472] ACPI: Interpreter disabled. second # [ 0.105767] iommu: Default domain type: Translated second # [ 0.105780] iommu: DMA domain TLB invalidation policy: strict mode test # [ 0.023512] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 test # [ 0.023675] printk: console [ttyAMA0] enabled second # [ 0.106967] SCSI subsystem initialized second # [ 0.111643] usbcore: registered new interface driver usbfs second # [ 0.111686] usbcore: registered new interface driver hub second # [ 0.111697] usbcore: registered new device driver usb second # [ 0.111917] pps_core: LinuxPPS API ver. 1 registered second # [ 0.111924] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti second # [ 0.111931] PTP clock support registered second # [ 0.111959] EDAC MC: Ver: 3.0.0 second # [ 0.115001] scmi_core: SCMI protocol bus registered second # [ 0.115783] FPGA manager framework test # [ 0.101483] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages test # [ 0.101510] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page test # [ 0.101518] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages test # [ 0.101521] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page second # [ 0.117005] vgaarb: loaded second # [ 0.117441] clocksource: Switched to clocksource arch_sys_counter test # [ 0.101524] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.101527] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.101531] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages test # [ 0.101533] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page test # [ 0.106885] fbcon: Taking over console test # [ 0.106911] ACPI: Interpreter disabled. test # [ 0.108300] iommu: Default domain type: Translated test # [ 0.108315] iommu: DMA domain TLB invalidation policy: strict mode test # [ 0.109535] SCSI subsystem initialized test # [ 0.110105] usbcore: registered new interface driver usbfs test # [ 0.110150] usbcore: registered new interface driver hub test # [ 0.110160] usbcore: registered new device driver usb test # [ 0.110383] pps_core: LinuxPPS API ver. 1 registered test # [ 0.110389] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti test # [ 0.110396] PTP clock support registered test # [ 0.110425] EDAC MC: Ver: 3.0.0 second # [ 0.126673] VFS: Disk quotas dquot_6.6.0 test # [ 0.113744] scmi_core: SCMI protocol bus registered second # [ 0.126711] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.129039] netfs: FS-Cache loaded test # [ 0.114568] FPGA manager framework second # [ 0.129184] pnp: PnP ACPI: disabled second # [ 0.131583] NET: Registered PF_INET protocol family second # [ 0.131769] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.121331] vgaarb: loaded test # [ 0.121818] clocksource: Switched to clocksource arch_sys_counter test # [ 0.127163] VFS: Disk quotas dquot_6.6.0 test # [ 0.127206] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.129607] netfs: FS-Cache loaded test # [ 0.129743] pnp: PnP ACPI: disabled test # [ 0.132249] NET: Registered PF_INET protocol family test # [ 0.132460] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) second # [ 0.156771] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.156804] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) second # [ 0.156818] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.156859] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.156933] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.157036] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) second # [ 0.157068] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.157125] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.157304] NET: Registered PF_UNIX/PF_LOCAL protocol family second # [ 0.157389] NET: Registered PF_XDP protocol family test # [ 0.157433] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.157412] PCI: CLS 0 bytes, default 64 second # [ 0.157562] Trying to unpack rootfs image as initramfs... test # [ 0.157466] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.157480] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.157520] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) test # [ 0.157588] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.157688] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.157719] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.157773] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.171721] kvm [1]: HYP mode not available test # [ 0.162686] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.162739] NET: Registered PF_XDP protocol family test # [ 0.162762] PCI: CLS 0 bytes, default 64 test # [ 0.162990] Trying to unpack rootfs image as initramfs... test # [ 0.171455] kvm [1]: HYP mode not available second # [ 0.237520] Initialise system trusted keyrings second # [ 0.238041] workingset: timestamp_bits=42 max_order=18 bucket_order=0 second # [ 0.239037] squashfs: version 4.0 (2009/01/31) Phillip Lougher second # [ 0.239564] 9p: Installing v9fs 9p2000 file system support test # [ 0.242223] Initialise system trusted keyrings test # [ 0.242767] workingset: timestamp_bits=42 max_order=18 bucket_order=0 test # [ 0.243816] squashfs: version 4.0 (2009/01/31) Phillip Lougher test # [ 0.244358] 9p: Installing v9fs 9p2000 file system support second # [ 0.262569] Key type asymmetric registered second # [ 0.262606] Asymmetric key parser 'x509' registered second # [ 0.262663] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.263997] io scheduler mq-deadline registered second # [ 0.264011] io scheduler kyber registered test # [ 0.263819] Key type asymmetric registered test # [ 0.263851] Asymmetric key parser 'x509' registered test # [ 0.263913] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.273635] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.273989] ledtrig-cpu: registered to indicate activity on CPUs second # [ 0.274302] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: second # [ 0.274324] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 second # [ 0.274339] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.269972] io scheduler mq-deadline registered test # [ 0.269996] io scheduler kyber registered second # [ 0.274344] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 second # [ 0.274386] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits second # [ 0.274411] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] second # [ 0.274485] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 second # [ 0.274503] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.274508] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.272998] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.274512] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.273786] ledtrig-cpu: registered to indicate activity on CPUs second # [ 0.274516] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] test # [ 0.274619] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: second # [ 0.274636] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint second # [ 0.275087] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.275222] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] second # [ 0.275235] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.275255] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.275267] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.275594] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.275724] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] second # [ 0.275736] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.274648] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 test # [ 0.274663] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.274669] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 test # [ 0.274708] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits test # [ 0.274732] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] test # [ 0.274809] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 second # [ 0.275757] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.274838] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.276075] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.276204] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] second # [ 0.276216] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.276236] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.276553] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.276681] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] second # [ 0.276693] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.276714] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.274844] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.274848] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.274851] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] test # [ 0.274974] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint test # [ 0.275430] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.275566] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] test # [ 0.275580] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.275602] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.277059] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.277191] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] second # [ 0.277204] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.277225] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.277580] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.277711] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] second # [ 0.277723] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.277744] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.278065] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.278198] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] second # [ 0.278210] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.278234] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.278245] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.278626] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint second # [ 0.278761] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.275613] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.275951] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.276085] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] test # [ 0.276097] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.276118] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.276444] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.276578] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] test # [ 0.276589] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.276611] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.276941] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.277073] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] test # [ 0.277084] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.277106] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.277441] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.277576] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] test # [ 0.277588] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.278784] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.279120] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.279257] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.279278] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.279555] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.279682] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.279882] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.280098] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] test # [ 0.277609] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.280113] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.280133] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.280465] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.280596] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.280608] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.280629] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.281067] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned second # [ 0.281079] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned second # [ 0.281084] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned second # [ 0.281120] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned second # [ 0.281152] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned second # [ 0.281186] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.281218] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned second # [ 0.281251] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned second # [ 0.281284] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned second # [ 0.281317] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned second # [ 0.281349] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned test # [ 0.302100] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.302256] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] second # [ 0.281381] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned test # [ 0.302269] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.302291] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.302633] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.302769] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] test # [ 0.302780] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.302807] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.302819] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.303213] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint test # [ 0.303352] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.303374] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.303719] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.303856] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.303878] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.304164] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.325527] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned test # [ 0.304295] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.325608] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned test # [ 0.304485] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.325624] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned test # [ 0.304659] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] second # [ 0.325640] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned test # [ 0.304673] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.325656] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned test # [ 0.304694] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.305067] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.305200] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] test # [ 0.305211] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.325671] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned second # [ 0.325687] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned second # [ 0.325702] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned second # [ 0.325718] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned test # [ 0.305232] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.305673] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned test # [ 0.305686] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned test # [ 0.305692] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned test # [ 0.305727] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned test # [ 0.305760] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned test # [ 0.305794] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.325733] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned second # [ 0.325750] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned second # [ 0.325765] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned second # [ 0.325780] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned second # [ 0.325794] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned second # [ 0.325808] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned second # [ 0.325822] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned second # [ 0.325837] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned second # [ 0.325858] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned second # [ 0.325872] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned second # [ 0.325886] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned second # [ 0.325900] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned second # [ 0.325914] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.325937] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] second # [ 0.325942] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] second # [ 0.325946] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] second # [ 0.326748] pci 0000:00:0a.0: enabling device (0000 -> 0002) test # [ 0.325922] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned test # [ 0.325973] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned test # [ 0.326010] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned test # [ 0.326047] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned test # [ 0.326081] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned test # [ 0.326114] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned test # [ 0.326186] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned test # [ 0.326277] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned test # [ 0.326294] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned test # [ 0.326310] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned test # [ 0.326325] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned test # [ 0.326340] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned test # [ 0.326354] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned test # [ 0.326369] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned test # [ 0.326382] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned test # [ 0.326397] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned test # [ 0.326411] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned test # [ 0.326426] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned test # [ 0.326441] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned test # [ 0.326455] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.326468] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.326482] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.326496] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned test # [ 0.326516] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned test # [ 0.326530] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.326543] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned test # [ 0.326557] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned test # [ 0.326571] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned test # [ 0.326593] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] test # [ 0.326599] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] test # [ 0.326603] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] test # [ 0.327443] pci 0000:00:0a.0: enabling device (0000 -> 0002) second # [ 0.353917] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.355882] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) second # [ 0.357763] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) second # [ 0.359739] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) test # [ 0.358678] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.369666] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) second # [ 0.371532] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.373360] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.360636] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) second # [ 0.383363] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.385303] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) second # [ 0.387975] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) test # [ 0.370352] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) test # [ 0.372383] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) test # [ 0.374305] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) test # [ 0.376230] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.394426] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) test # [ 0.386048] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.388045] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.410219] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled second # [ 0.411864] msm_serial: driver initialized second # [ 0.411959] SuperH (H)SCI(F) driver initialized second # [ 0.411994] STM32 USART driver initialized test # [ 0.398018] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) test # [ 0.399802] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) test # [ 0.401861] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) test # [ 0.410563] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.412191] msm_serial: driver initialized test # [ 0.412306] SuperH (H)SCI(F) driver initialized test # [ 0.412344] STM32 USART driver initialized second # [ 0.430843] loop: module loaded second # [ 0.430988] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 0.431528] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 0.441870] megasas: 07.734.00.00-rc1 second # [ 0.442331] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] second # [ 0.444460] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.444514] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.435756] loop: module loaded test # [ 0.435921] virtio_blk virtio5: 1/0/0 default/read/poll queues test # [ 0.436508] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 0.454011] Using buffer write method second # [ 0.454099] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] second # [ 0.457103] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.442268] megasas: 07.734.00.00-rc1 second # [ 0.457131] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.458597] Using buffer write method test # [ 0.442810] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] second # [ 0.458618] Concatenating MTD devices: second # [ 0.458622] (0): "0.flash" second # [ 0.458625] (1): "0.flash" test # [ 0.444986] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.458627] into device "0.flash" test # [ 0.445043] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.454417] Using buffer write method test # [ 0.454492] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] test # [ 0.456682] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.456708] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.466326] Using buffer write method test # [ 0.466360] Concatenating MTD devices: test # [ 0.466363] (0): "0.flash" test # [ 0.466366] (1): "0.flash" test # [ 0.466369] into device "0.flash" second # [ 0.692567] Freeing initrd memory: 26996K second # [ 0.699707] tun: Universal TUN/TAP device driver, 1.6 second # [ 0.702556] thunder_xcv, ver 1.0 second # [ 0.702591] thunder_bgx, ver 1.0 second # [ 0.702604] nicpf, ver 1.0 second # [ 0.702914] e1000: Intel(R) PRO/1000 Network Driver second # [ 0.702922] e1000: Copyright (c) 1999-2006 Intel Corporation. second # [ 0.702940] e1000e: Intel(R) PRO/1000 Network Driver second # [ 0.702947] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. second # [ 0.702959] igb: Intel(R) Gigabit Ethernet Network Driver second # [ 0.702962] igb: Copyright (c) 2007-2014 Intel Corporation. second # [ 0.702974] igbvf: Intel(R) Gigabit Virtual Function Network Driver second # [ 0.702977] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. second # [ 0.703039] sky2: driver version 1.30 test # [ 0.695715] Freeing initrd memory: 26992K second # [ 0.703827] usbcore: registered new interface driver usb-storage second # [ 0.703950] usbcore: registered new interface driver usbserial_generic second # [ 0.703971] usbserial: USB Serial support registered for generic second # [ 0.704255] hv_vmbus: registering driver hyperv_keyboard second # [ 0.705272] ehci-pci 0000:00:0a.0: EHCI Host Controller second # [ 0.705308] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 second # [ 0.705571] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 second # [ 0.713395] rtc-pl031 9010000.pl031: registered as rtc0 second # [ 0.713482] rtc-pl031 9010000.pl031: setting system clock to 2026-08-20T05:08:13 UTC (1787202493) second # [ 0.713706] i2c_dev: i2c /dev entries driver test # [ 0.702808] tun: Universal TUN/TAP device driver, 1.6 second # [ 0.716559] sdhci: Secure Digital Host Controller Interface driver second # [ 0.716578] sdhci: Copyright(c) Pierre Ossman second # [ 0.716710] Synopsys Designware Multimedia Card Interface Driver second # [ 0.716889] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.717497] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 test # [ 0.705590] thunder_xcv, ver 1.0 test # [ 0.705628] thunder_bgx, ver 1.0 test # [ 0.705647] nicpf, ver 1.0 second # [ 0.720096] hid: raw HID events driver (C) Jiri Kosina second # [ 0.720301] usbcore: registered new interface driver usbhid second # [ 0.720306] usbhid: USB HID core driver second # [ 0.721242] hub 1-0:1.0: USB hub found second # [ 0.721317] hub 1-0:1.0: 6 ports detected test # [ 0.706767] e1000: Intel(R) PRO/1000 Network Driver test # [ 0.706782] e1000: Copyright (c) 1999-2006 Intel Corporation. test # [ 0.706801] e1000e: Intel(R) PRO/1000 Network Driver second # [ 0.723360] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available test # [ 0.706809] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. test # [ 0.706834] igb: Intel(R) Gigabit Ethernet Network Driver second # [ 0.724186] drop_monitor: Initializing network drop monitor service test # [ 0.706838] igb: Copyright (c) 2007-2014 Intel Corporation. second # [ 0.724299] NET: Registered PF_INET6 protocol family test # [ 0.706849] igbvf: Intel(R) Gigabit Virtual Function Network Driver test # [ 0.706853] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. second # [ 0.726737] Segment Routing with IPv6 test # [ 0.706923] sky2: driver version 1.30 second # [ 0.726766] In-situ OAM (IOAM) with IPv6 test # [ 0.707779] usbcore: registered new interface driver usb-storage second # [ 0.726822] NET: Registered PF_PACKET protocol family test # [ 0.707901] usbcore: registered new interface driver usbserial_generic test # [ 0.707923] usbserial: USB Serial support registered for generic test # [ 0.708220] hv_vmbus: registering driver hyperv_keyboard test # [ 0.709227] ehci-pci 0000:00:0a.0: EHCI Host Controller second # [ 0.727898] 9pnet: Installing 9P2000 support test # [ 0.709263] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 test # [ 0.709436] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 test # [ 0.716725] rtc-pl031 9010000.pl031: registered as rtc0 test # [ 0.716787] rtc-pl031 9010000.pl031: setting system clock to 2026-08-20T05:08:13 UTC (1787202493) second # [ 0.729852] Key type dns_resolver registered test # [ 0.717010] i2c_dev: i2c /dev entries driver second # [ 0.733100] registered taskstats version 1 second # [ 0.733290] Loading compiled-in X.509 certificates test # [ 0.719036] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 test # [ 0.719463] hub 1-0:1.0: USB hub found test # [ 0.719492] hub 1-0:1.0: 6 ports detected test # [ 0.721793] sdhci: Secure Digital Host Controller Interface driver test # [ 0.721811] sdhci: Copyright(c) Pierre Ossman test # [ 0.722845] Synopsys Designware Multimedia Card Interface Driver second # [ 0.738752] Demotion targets for Node 0: null test # [ 0.723032] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.738843] Key type .fscrypt registered test # [ 0.724001] hid: raw HID events driver (C) Jiri Kosina second # [ 0.738849] Key type fscrypt-provisioning registered test # [ 0.724148] usbcore: registered new interface driver usbhid second # [ 0.738961] ima: No TPM chip found, activating TPM-bypass! test # [ 0.724153] usbhid: USB HID core driver second # [ 0.738975] ima: Allocated hash algorithm: sha1 second # [ 0.739032] ima: No architecture policies found second # [ 0.741788] input: gpio-keys as /devices/platform/gpio-keys/input/input0 test # [ 0.726902] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available test # [ 0.727709] drop_monitor: Initializing network drop monitor service test # [ 0.727892] NET: Registered PF_INET6 protocol family test # [ 0.730241] Segment Routing with IPv6 test # [ 0.730269] In-situ OAM (IOAM) with IPv6 test # [ 0.730332] NET: Registered PF_PACKET protocol family test # [ 0.731440] 9pnet: Installing 9P2000 support test # [ 0.733268] Key type dns_resolver registered test # [ 0.736951] registered taskstats version 1 test # [ 0.737116] Loading compiled-in X.509 certificates second # [ 0.752918] clk: Disabling unused clocks second # [ 0.752945] PM: genpd: Disabling unused power domains second # [ 0.756227] Freeing unused kernel memory: 4736K second # [ 0.756331] Run /init as init process test # [ 0.742799] Demotion targets for Node 0: null test # [ 0.742946] Key type .fscrypt registered test # [ 0.742954] Key type fscrypt-provisioning registered test # [ 0.743081] ima: No TPM chip found, activating TPM-bypass! test # [ 0.743095] ima: Allocated hash algorithm: sha1 test # [ 0.743153] ima: No architecture policies found test # [ 0.746275] input: gpio-keys as /devices/platform/gpio-keys/input/input0 test # [ 0.756824] clk: Disabling unused clocks test # [ 0.756852] PM: genpd: Disabling unused power domains test # [ 0.760120] Freeing unused kernel memory: 4736K test # [ 0.760229] Run /init as init process second # [ 0.776488] systemd[1]: Successfully made /usr/ read-only. test # [ 0.780537] systemd[1]: Successfully made /usr/ read-only. second # [ 0.969479] usb 1-1: new high-speed USB device number 2 using ehci-pci test # [ 0.965862] usb 1-1: new high-speed USB device number 2 using ehci-pci second # [ 1.111295] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) second # [ 1.115126] systemd[1]: Detected virtualization qemu. second # [ 1.115991] systemd[1]: Detected architecture arm64. second # [ 1.116587] systemd[1]: Running in initrd. second # [ 1.117762] systemd[1]: Initializing machine ID from random generator. second # [ 1.119079] systemd[1]: Hostname set to . second # [ 1.122959] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 test # [ 1.113206] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 test # [ 1.115245] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) test # [ 1.115272] systemd[1]: Detected virtualization qemu. test # [ 1.115303] systemd[1]: Detected architecture arm64. test # [ 1.115311] systemd[1]: Running in initrd. test # [ 1.115867] systemd[1]: Initializing machine ID from random generator. test # [ 1.116081] systemd[1]: Hostname set to . second # [ 1.197582] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 test # [ 1.190008] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 second # [ 1.317472] usb 1-2: new high-speed USB device number 3 using ehci-pci test # [ 1.309861] usb 1-2: new high-speed USB device number 3 using ehci-pci second # [ 1.344785] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 1.347363] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.403256] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.411388] systemd[1]: Created slice Slice /system/modprobe. second # [ 1.412155] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 1.412844] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.413427] systemd[1]: Reached target Path Units. second # [ 1.413891] systemd[1]: Reached target Slice Units. second # [ 1.414319] systemd[1]: Reached target Swaps. second # [ 1.414699] systemd[1]: Reached target Timer Units. second # [ 1.415344] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.416073] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.416701] systemd[1]: Listening on Journal Sockets. second # [ 1.417260] systemd[1]: Listening on udev Control Socket. second # [ 1.417933] systemd[1]: Listening on udev Kernel Socket. second # [ 1.418418] systemd[1]: Reached target Socket Units. second # [ 1.420220] systemd[1]: Starting Create List of Static Device Nodes... test # [ 1.410393] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.426062] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.426702] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 1.433647] systemd[1]: Mounting Kernel Configuration File System... test # [ 1.420060] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.421069] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.421980] systemd[1]: Expecting device /dev/disk/by-label/nixos... test # [ 1.422708] systemd[1]: Reached target Path Units. test # [ 1.423153] systemd[1]: Reached target Slice Units. test # [ 1.423612] systemd[1]: Reached target Swaps. test # [ 1.424003] systemd[1]: Reached target Timer Units. test # [ 1.424723] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.425502] systemd[1]: Listening on Journal Socket (/dev/log). test # [ 1.426274] systemd[1]: Listening on Journal Sockets. test # [ 1.426920] systemd[1]: Listening on udev Control Socket. test # [ 1.427544] systemd[1]: Listening on udev Kernel Socket. test # [ 1.428045] systemd[1]: Reached target Socket Units. test # [ 1.429788] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.447163] systemd[1]: Starting Journal Service... test # [ 1.438013] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 1.438753] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 1.454269] systemd[1]: Starting Load Kernel Modules... second # [ 1.454847] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 1.446041] systemd[1]: Mounting Kernel Configuration File System... second # [ 1.471593] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.472542] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 second # [ 1.473874] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 test # [ 1.462073] systemd[1]: Starting Journal Service... second # [ 1.482848] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.486706] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.473140] systemd[1]: Starting Load Kernel Modules... test # [ 1.474081] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 1.489941] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.476578] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 test # [ 1.477761] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 second # [ 1.494153] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.501980] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.487458] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.506011] systemd[1]: Finished Create List of Static Device Nodes. test # [ 1.507310] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.507545] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.507798] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.529201] systemd-journald[73]: Collecting audit messages is disabled. test # [ 1.518674] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 1.539354] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. second # [ 1.553605] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev second # [ 1.561432] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 second # [ 1.561699] [drm] features: -virgl +edid -resource_blob -host_visible second # [ 1.561704] [drm] features: -context_init second # [ 1.562208] [drm] number of scanouts: 1 second # [ 1.562224] [drm] number of cap sets: 0 second # [ 1.564990] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.554143] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.573971] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 1.564920] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.566792] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.568862] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.586355] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic second # [ 1.586380] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 test # [ 1.582261] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.588211] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 test # [ 1.588499] [drm] features: -virgl +edid -resource_blob -host_visible test # [ 1.588506] [drm] features: -context_init test # [ 1.589111] [drm] number of scanouts: 1 test # [ 1.589133] [drm] number of cap sets: 0 second # [ 1.611170] Console: switching to colour frame buffer device 160x50 second # [ 1.621997] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device second # [ 1.628116] systemd[1]: Started Journal Service. second # [ 1.627345] systemd-modules-load[74]: Inserted module 'dm_mod' test # [ 1.618202] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic second # [ 1.628308] systemd-modules-load[74]: Module 'virtio_balloon' is built in test # [ 1.618222] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 second # [ 1.629787] systemd-modules-load[74]: Module 'virtio_console' is built in test # [ 1.626338] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.626697] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.626740] systemd[1]: Reached target Local File Systems. test # [ 1.629491] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 1.636389] systemd-modules-load[74]: Inserted module 'virtio_gpu' second # [ 1.637106] systemd-modules-load[74]: Module 'virtio_rng' is built in second # [ 1.637822] systemd[1]: Finished Load Kernel Modules. second # [ 1.639260] systemd[1]: Starting Apply Kernel Variables... second # [ 1.639927] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.649789] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.642212] Console: switching to colour frame buffer device 160x50 second # [ 1.650465] systemd[1]: Reached target Local File Systems. test # [ 1.645253] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device test # [ 1.654175] systemd[1]: Started Journal Service. test # [ 1.650422] systemd-modules-load[74]: Inserted module 'dm_mod' test # [ 1.651259] systemd-modules-load[74]: Module 'virtio_balloon' is built in second # [ 1.661953] systemd[1]: Starting Create System Files and Directories... test # [ 1.652127] systemd-modules-load[74]: Module 'virtio_console' is built in test # [ 1.652903] systemd-modules-load[74]: Inserted module 'virtio_gpu' second # [ 1.672626] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.664297] systemd-modules-load[74]: Module 'virtio_rng' is built in test # [ 1.665144] systemd[1]: Starting Create System Files and Directories... test # [ 1.668242] systemd[1]: Finished Load Kernel Modules. second # [ 1.680915] systemd[1]: Finished Apply Kernel Variables. second # [ 1.704897] systemd[1]: Finished Create System Files and Directories. test # [ 1.696158] systemd[1]: Starting Apply Kernel Variables... test # [ 1.712839] systemd[1]: Finished Create System Files and Directories. second # [ 1.729987] systemd-udevd[88]: Using default interface naming scheme 'v261'. test # [ 1.719950] systemd-udevd[79]: Using default interface naming scheme 'v261'. test # [ 1.724317] systemd[1]: Finished Apply Kernel Variables. second # [ 1.752679] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.745142] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.805178] systemd[1]: Starting Virtual Console Setup... second # [ 1.816142] systemd[1]: Starting Virtual Console Setup... second # [ 1.860404] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 1.862886] systemd[1]: Finished Virtual Console Setup. test # [ 1.856457] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 1.859075] systemd[1]: Finished Virtual Console Setup. second # [ 2.054705] systemd[1]: Finished Coldplug All udev Devices. second # [ 2.055303] systemd[1]: Reached target System Initialization. second # [ 2.055841] systemd[1]: Reached target Basic System. test # [ 2.074145] systemd[1]: Finished Coldplug All udev Devices. test # [ 2.074743] systemd[1]: Reached target System Initialization. test # [ 2.075249] systemd[1]: Reached target Basic System. second # [ 2.156160] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.172242] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.191870] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.196295] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.255282] systemd[1]: Found device /dev/disk/by-label/nixos. second # [ 2.258910] systemd[1]: Reached target Initrd Root Device. second # [ 2.261470] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 2.275375] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.276166] systemd[1]: Reached target Initrd Root Device. test # [ 2.280352] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 2.307266] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 2.312285] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.326980] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks test # [ 2.331217] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.475345] systemd[1]: Mounting /sysroot... second # [ 2.513001] EXT4-fs (vda): mounted filesystem 235ccac8-d358-4119-8253-4558ab49ee4a r/w with ordered data mode. Quota mode: none. test # [ 2.494591] systemd[1]: Mounting /sysroot... second # [ 2.510786] systemd[1]: Mounted /sysroot. second # [ 2.511512] systemd[1]: Reached target Initrd Root File System. second # [ 2.513127] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.527986] EXT4-fs (vda): mounted filesystem 13a5909b-75a1-46d8-91b8-51a5d8bc6041 r/w with ordered data mode. Quota mode: none. second # [ 2.535072] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.528585] systemd[1]: Mounted /sysroot. test # [ 2.529683] systemd[1]: Reached target Initrd Root File System. second # [ 2.541169] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.533745] systemd[1]: Starting Mountpoints Configured in the Real Root... second # [ 2.544123] systemd[1]: Reloading... test # [ 2.555671] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.562574] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.566261] systemd[1]: Reloading... second # [ 2.717119] systemd[1]: Reloading finished in 173 ms. second # [ 2.743810] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... second # [ 2.746545] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... second # [ 2.749311] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.741440] systemd[1]: Reloading finished in 175 ms. second # [ 2.752756] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.753396] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. second # [ 2.757900] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 2.761266] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... test # [ 2.764230] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... test # [ 2.768206] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 2.778705] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 2.779434] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 2.769386] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.773566] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 2.774723] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.794666] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 2.795727] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 3.054204] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory second # [ 3.057961] (udev-worker)[99]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory second # [ 3.066845] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.068165] systemd[1]: Stopped Virtual Console Setup. second # [ 3.069503] systemd[1]: Stopping Virtual Console Setup... second # [ 3.071346] systemd[1]: Starting Virtual Console Setup... second # [ 3.099478] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 3.101994] systemd[1]: Finished Virtual Console Setup. test # [ 3.093848] (udev-worker)[100]: mtd0ro: Failed to find and pin callout binary "/nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/mtd_probe": No such file or directory test # [ 3.098215] (udev-worker)[100]: mtd0ro: /nix/store/pyrvwmigi6qdpz9lbbslj5771pfl7r69-systemd-261.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory test # [ 3.111307] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.112357] systemd[1]: Stopped Virtual Console Setup. test # [ 3.113781] systemd[1]: Stopping Virtual Console Setup... test # [ 3.116362] systemd[1]: Starting Virtual Console Setup... test # [ 3.139584] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 3.142257] systemd[1]: Finished Virtual Console Setup. second # [ 3.477043] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.484207] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.492202] systemd[1]: Mounting /sysroot/run... second # [ 3.496179] systemd[1]: Mounting /sysroot/tmp/shared... test # [ 3.497622] systemd[1]: Mounting /sysroot/nix/.ro-store... test # [ 3.505448] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.517589] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 3.520201] systemd[1]: Mounting /sysroot/run... second # [ 3.531834] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 3.526599] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.544559] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.550518] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.540217] systemd[1]: Mounting /sysroot/tmp/xchg... second # [ 3.551273] systemd[1]: Mounted /sysroot/run. second # [ 3.551935] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.559982] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.561276] systemd[1]: Mounted /sysroot/nix/.rw-store. second # [ 3.574484] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.575667] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.567424] systemd[1]: Mounted /sysroot/nix/.ro-store. second # [ 3.578285] systemd[1]: Mounting /sysroot/nix/store... test # [ 3.580274] systemd[1]: Mounted /sysroot/run. test # [ 3.582331] systemd[1]: Mounted /sysroot/tmp/shared. test # [ 3.582887] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.588140] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.616953] systemd[1]: Mounted /sysroot/nix/store. second # [ 3.618764] systemd[1]: Reached target Initrd File Systems. second # [ 3.621309] systemd[1]: Starting Find NixOS closure... test # [ 3.612949] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.614159] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.627864] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 3.648892] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 3.676140] systemd[1]: Finished Find NixOS closure. second # [ 3.677634] systemd[1]: Reached target Initrd Default Target. second # [ 3.680188] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... second # [ 3.708467] systemd[1]: initrd-cleanup.service: Deactivated successfully. second # [ 3.709420] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 3.713653] systemd[1]: Stopped target Initrd Default Target. second # [ 3.714310] systemd[1]: Stopped target Basic System. second # [ 3.716113] systemd[1]: Stopped target Initrd Root Device. second # [ 3.716652] systemd[1]: Stopped target Path Units. second # [ 3.719444] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. second # [ 3.720301] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 3.721005] systemd[1]: Stopped target Slice Units. second # [ 3.721456] systemd[1]: Stopped target Socket Units. second # [ 3.721909] systemd[1]: Stopped target System Initialization. second # [ 3.722420] systemd[1]: Stopped target Swaps. second # [ 3.722835] systemd[1]: Stopped target Timer Units. second # [ 3.723328] systemd[1]: dbus.socket: Deactivated successfully. second # [ 3.723876] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 3.728173] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. second # [ 3.732102] systemd[1]: Stopped Find NixOS closure. second # [ 3.732603] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 3.733276] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.733928] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 3.734593] systemd[1]: Stopped Apply Kernel Variables. second # [ 3.735793] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 3.740219] systemd[1]: Stopped Load Kernel Modules. second # [ 3.740714] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 3.741414] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 3.742116] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 3.742761] systemd[1]: Stopped Create System Files and Directories. second # [ 3.743324] systemd[1]: Stopped target Local File Systems. second # [ 3.743846] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 3.748670] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 3.749336] systemd[1]: Stopped Coldplug All udev Devices. second # [ 3.749859] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 3.750528] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.751195] systemd[1]: Stopped Virtual Console Setup. second # [ 3.763712] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 3.764940] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 3.766165] systemd[1]: systemd-udevd.service: Deactivated successfully. second # [ 3.767368] systemd[1]: Stopped Rule-based Manager for Device Events and Files. second # [ 3.769605] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.770608] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.772214] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. second # [ 3.773384] systemd[1]: Closed udev Control Socket. second # [ 3.776382] systemd[1]: Starting Cleanup udev Database... second # [ 3.776930] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. second # [ 3.777645] systemd[1]: Stopped Create Static Device Nodes in /dev. second # [ 3.778243] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 3.779367] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. second # [ 3.780245] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 3.780878] systemd[1]: Stopped Create List of Static Device Nodes. second # [ 3.805475] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. second # [ 3.807185] systemd[1]: Finished Cleanup udev Database. second # [ 3.807729] systemd[1]: Reached target Switch Root. second # [ 3.811719] systemd[1]: Starting NixOS Activation... second # [ 3.997604] initrd-nixos-activation-start[178]: booting system configuration /nix/store/dkdgmkd0q0n8qvg06lvb9n9bhvw9pz66-nixos-system-second-test second # [ 4.076091] initrd-nixos-activation-start[178]: running activation script... test # [ 4.495355] systemd[1]: Mounting /sysroot/nix/store... test # [ 4.542281] systemd[1]: Mounted /sysroot/nix/store. second # [ 4.555096] initrd-nixos-activation-start[201]: setting up /etc... test # [ 4.544890] systemd[1]: Reached target Initrd File Systems. test # [ 4.548308] systemd[1]: Starting Find NixOS closure... test # [ 4.560379] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 4.603887] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. test # [ 4.605811] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. test # [ 4.621960] systemd[1]: Finished Find NixOS closure. test # [ 4.624328] systemd[1]: Reached target Initrd Default Target. test # [ 4.625860] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 4.653822] systemd[1]: Stopped target Initrd Default Target. test # [ 4.656306] systemd[1]: Stopped target Basic System. test # [ 4.660418] systemd[1]: Stopped target Initrd Root Device. test # [ 4.661578] systemd[1]: Stopped target Path Units. test # [ 4.662288] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 4.664300] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. test # [ 4.668131] systemd[1]: Stopped target Slice Units. test # [ 4.668846] systemd[1]: Stopped target Socket Units. test # [ 4.670288] systemd[1]: Stopped target System Initialization. test # [ 4.671399] systemd[1]: Stopped target Swaps. test # [ 4.676164] systemd[1]: Stopped target Timer Units. test # [ 4.676791] systemd[1]: dbus.socket: Deactivated successfully. test # [ 4.677482] systemd[1]: Closed D-Bus System Message Bus Socket. test # [ 4.678172] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 4.679027] systemd[1]: Stopped Find NixOS closure. test # [ 4.679614] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 4.683796] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 4.685231] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 4.688129] systemd[1]: Stopped Apply Kernel Variables. test # [ 4.689168] systemd[1]: systemd-modules-load.service: Deactivated successfully. test # [ 4.693615] systemd[1]: Stopped Load Kernel Modules. test # [ 4.694169] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 4.696891] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. test # [ 4.700416] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 4.701652] systemd[1]: Stopped Create System Files and Directories. test # [ 4.702306] systemd[1]: Stopped target Local File Systems. test # [ 4.702861] systemd[1]: Stopped target Preparation for Local File Systems. test # [ 4.703521] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. test # [ 4.712684] systemd[1]: Stopped Coldplug All udev Devices. test # [ 4.713482] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 4.714242] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 4.714961] systemd[1]: Stopped Virtual Console Setup. test # [ 4.715438] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 4.722012] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 4.722857] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 4.724134] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 4.725446] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 4.727128] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 4.728316] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 4.732418] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 4.732970] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 4.733583] systemd[1]: Closed udev Control Socket. test # [ 4.734026] systemd[1]: Starting Cleanup udev Database... test # [ 4.734503] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 4.735098] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 4.735592] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 4.736884] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 4.737528] systemd[1]: kmod-static-nodes.service: Deactivated successfully. test # [ 4.738124] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 4.761393] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 4.763641] systemd[1]: Finished Cleanup udev Database. test # [ 4.764325] systemd[1]: Reached target Switch Root. test # [ 4.769288] systemd[1]: Starting NixOS Activation... second # [ 4.817709] initrd-nixos-activation-start[201]: setting up age secrets... test # [ 4.964599] initrd-nixos-activation-start[180]: booting system configuration /nix/store/5c74aq96g7d42fbjn35xjzh0pl7djmcj-nixos-system-test-test test # [ 5.013790] initrd-nixos-activation-start[180]: running activation script... second # [ 5.058831] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 5.060691] systemd[1]: Finished NixOS Activation. second # [ 5.061484] systemd[1]: Starting Switch Root... second # [ 5.077476] systemd[1]: Switching root. second # [ 5.260090] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). test # [ 5.429800] initrd-nixos-activation-start[203]: setting up /etc... test # [ 5.645877] initrd-nixos-activation-start[203]: setting up age secrets... second # [ 5.867343] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) second # [ 5.874945] systemd[1]: Detected virtualization qemu. second # [ 5.876880] systemd[1]: Detected architecture arm64. second # [ 5.879265] systemd[1]: Detected first boot. second # [ 5.884873] systemd[1]: Initializing machine ID from random generator. test # [ 5.869176] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 5.870981] systemd[1]: Finished NixOS Activation. test # [ 5.871751] systemd[1]: Starting Switch Root... test # [ 5.885879] systemd[1]: Switching root. test # [ 6.052351] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). second # [ 6.188423] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 6.405053] systemd[1]: Applying preset policy. test # [ 6.615712] systemd[1]: systemd 261.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) test # [ 6.623001] systemd[1]: Detected virtualization qemu. test # [ 6.625027] systemd[1]: Detected architecture arm64. test # [ 6.627763] systemd[1]: Detected first boot. test # [ 6.634216] systemd[1]: Initializing machine ID from random generator. test # [ 6.800482] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 6.976793] systemd[1]: Applying preset policy. second # [ 7.009928] systemd[1]: Populated /etc with preset unit settings. test # [ 7.568942] systemd[1]: Populated /etc with preset unit settings. second # [ 7.617066] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 7.618153] systemd[1]: Stopped initrd-switch-root.service. second # [ 7.619358] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 7.622706] systemd[1]: Created slice Slice /system/getty. second # [ 7.623766] systemd[1]: Created slice User and Session Slice. second # [ 7.624412] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 7.626500] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 7.627190] systemd[1]: Expecting device /dev/hvc0... second # [ 7.628200] systemd[1]: Expecting device /dev/ttyAMA0... second # [ 7.629985] systemd[1]: Reached target Local Encrypted Volumes. second # [ 7.630470] systemd[1]: Stopped target initrd-fs.target. second # [ 7.631356] systemd[1]: Stopped target initrd-root-fs.target. second # [ 7.632345] systemd[1]: Stopped target initrd-switch-root.target. second # [ 7.633988] systemd[1]: Reached target Virtual Machines and Containers. second # [ 7.635524] systemd[1]: Reached target Path Units. second # [ 7.636934] systemd[1]: Reached target Remote File Systems. second # [ 7.638419] systemd[1]: Reached target Slice Units. second # [ 7.639829] systemd[1]: Reached target Swaps. second # [ 7.643941] systemd[1]: Listening on Query the User Interactively for a Password. second # [ 7.649138] systemd[1]: Listening on Process Core Dump Socket. second # [ 7.652893] systemd[1]: Listening on Credential Encryption/Decryption. second # [ 7.656642] systemd[1]: Listening on Factory Reset Management. second # [ 7.657755] systemd[1]: Listening on Hostname Service Socket. second # [ 7.662503] systemd[1]: Starting Journal Log Access Socket... second # [ 7.664176] systemd[1]: Listening on Journal Audit Socket. second # [ 7.668352] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 7.669915] systemd[1]: Listening on Network Management Metrics Varlink Socket. second # [ 7.671162] systemd[1]: Listening on Network Management Varlink Socket. second # [ 7.672950] systemd[1]: Listening on Network Management Netlink Socket. second # [ 7.675036] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 7.677431] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.679206] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 7.691181] systemd[1]: Listening on Disk Repartitioning Service Socket. second # [ 7.691686] systemd[1]: Listening on Resolve Monitor Varlink Socket. second # [ 7.692043] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 7.692372] systemd[1]: Listening on udev Control Socket. second # [ 7.692709] systemd[1]: Listening on udev Varlink Socket. second # [ 7.698170] systemd[1]: Mounting Huge Pages File System... second # [ 7.702555] systemd[1]: Mounting POSIX Message Queue File System... second # [ 7.713210] systemd[1]: Mounting Kernel Debug File System... second # [ 7.722196] systemd[1]: Mounting Kernel Trace File System... second # [ 7.733128] systemd[1]: Starting Create List of Static Device Nodes... second # [ 7.740918] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 7.745621] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 7.753123] systemd[1]: Mounting Kernel Configuration File System... second # [ 7.754775] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 7.756858] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 7.769414] systemd[1]: Starting Load Kernel Module fuse... second # [ 7.771901] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 second # [ 7.851449] systemd[1]: Starting Journal Service... second # [ 7.884655] systemd[1]: Starting Load Kernel Modules... second # [ 7.922698] fuse: init (API version 7.45) second # [ 7.927709] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 7.958058] systemd[1]: Starting Remount Root and Kernel File Systems... second # [ 7.959940] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.973020] systemd[1]: Starting Coldplug All udev Devices... second # [ 7.983217] systemd[1]: Listening on Journal Log Access Socket. second # [ 8.003995] systemd[1]: Mounted Huge Pages File System. second # [ 8.008864] systemd[1]: Mounted POSIX Message Queue File System. second # [ 8.014004] systemd[1]: Mounted Kernel Debug File System. second # [ 8.016150] systemd[1]: Mounted Kernel Trace File System. second # [ 8.022850] systemd[1]: Finished Create List of Static Device Nodes. second # [ 8.025420] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 8.028019] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 8.031104] systemd[1]: Mounted Kernel Configuration File System. second # [ 8.033410] systemd[1]: modprobe@fuse.service: Deactivated successfully. second # [ 8.038488] systemd[1]: Finished Load Kernel Module fuse. second # [ 8.043804] systemd[1]: Finished Load Kernel Modules. second # [ 8.053315] systemd[1]: Mounting FUSE Control File System... second # [ 8.055999] systemd-journald[306]: Collecting audit messages is enabled. second # [ 8.071965] systemd[1]: Starting Firewall... second # [ 8.067453] systemd[1]: Queued start job for default target Multi-User System. second # [ 8.069105] systemd[1]: systemd-journald.service: Deactivated successfully. second # [ 8.073158] systemd-modules-load[307]: Module 'atkbd' is built in second # [ 8.077008] systemd-modules-load[307]: Module 'ctr' is built in second # [ 8.078340] systemd-modules-load[307]: Module 'loop' is built in second # [ 8.092899] systemd[1]: Starting Apply Kernel Variables... second # [ 8.101578] EXT4-fs (vda): re-mounted 235ccac8-d358-4119-8253-4558ab49ee4a. second # [ 8.097437] systemd-oomd[308]: No swap; memory pressure usage will be degraded second # [ 8.109140] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 8.129917] systemd[1]: Started Journal Service. second # [ 8.127260] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. second # [ 8.133870] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 8.179157] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 8.184210] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 8.180108] systemd[1]: Stopped initrd-switch-root.service. test # [ 8.182527] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. test # [ 8.185749] systemd[1]: Created slice Slice /system/getty. test # [ 8.187535] systemd[1]: Created slice User and Session Slice. second # [ 8.194002] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 8.188859] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 8.190585] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 8.191356] systemd[1]: Expecting device /dev/hvc0... test # [ 8.192387] systemd[1]: Expecting device /dev/ttyAMA0... second # [ 8.196738] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 8.193443] systemd[1]: Reached target Local Encrypted Volumes. test # [ 8.195115] systemd[1]: Stopped target initrd-fs.target. test # [ 8.196156] systemd[1]: Stopped target initrd-root-fs.target. test # [ 8.197269] systemd[1]: Stopped target initrd-switch-root.target. test # [ 8.198485] systemd[1]: Reached target Virtual Machines and Containers. test # [ 8.200201] systemd[1]: Reached target Path Units. second # [ 8.203630] systemd[1]: Starting Load/Save OS Random Seed... test # [ 8.201661] systemd[1]: Reached target Remote File Systems. test # [ 8.203230] systemd[1]: Reached target Slice Units. second # [ 8.208823] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.204677] systemd[1]: Reached target Swaps. test # [ 8.209199] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 8.214283] systemd[1]: Listening on Process Core Dump Socket. test # [ 8.218392] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 8.222809] systemd[1]: Listening on Factory Reset Management. second # [ 8.228228] systemd[1]: Mounted FUSE Control File System. test # [ 8.224602] systemd[1]: Listening on Hostname Service Socket. test # [ 8.230476] systemd[1]: Starting Journal Log Access Socket... test # [ 8.232565] systemd[1]: Listening on Journal Audit Socket. test # [ 8.237328] systemd[1]: Listening on Console Output Muting Service Socket. test # [ 8.239474] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 8.241004] systemd[1]: Listening on Network Management Varlink Socket. test # [ 8.243122] systemd[1]: Listening on Network Management Netlink Socket. test # [ 8.244367] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. test # [ 8.245723] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.248568] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 8.259729] systemd[1]: Finished Apply Kernel Variables. test # [ 8.260561] systemd[1]: Listening on Disk Repartitioning Service Socket. test # [ 8.261754] systemd[1]: Listening on Resolve Monitor Varlink Socket. test # [ 8.262934] systemd[1]: Listening on Resolve Service Varlink Socket. test # [ 8.264234] systemd[1]: Listening on udev Control Socket. test # [ 8.265338] systemd[1]: Listening on udev Varlink Socket. test # [ 8.269642] systemd[1]: Mounting Huge Pages File System... second # [ 8.273614] systemd[1]: Starting Network Name Resolution... test # [ 8.274263] systemd[1]: Mounting POSIX Message Queue File System... test # [ 8.283217] systemd[1]: Mounting Kernel Debug File System... test # [ 8.292517] systemd[1]: Mounting Kernel Trace File System... second # [ 8.302521] systemd[1]: Finished Load/Save OS Random Seed. second # [ 8.309107] systemd[1]: Reached target First Boot Complete. test # [ 8.304360] systemd[1]: Starting Create List of Static Device Nodes... test # [ 8.311423] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 8.317226] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 8.312975] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 8.323780] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 8.335678] systemd-journald[306]: Received client request to flush runtime journal. test # [ 8.326311] systemd[1]: Mounting Kernel Configuration File System... test # [ 8.327429] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm test # [ 8.330801] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore test # [ 8.340884] systemd[1]: Starting Load Kernel Module fuse... test # [ 8.346075] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 8.404656] systemd[1]: Starting Journal Service... second # [ 8.413118] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 8.441026] systemd[1]: Starting Load Kernel Modules... second # [ 8.473562] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 8.475919] systemd[1]: Reached target Preparation for Local File Systems. test # [ 8.475559] fuse: init (API version 7.45) second # [ 8.483687] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 8.480076] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 8.491217] systemd-resolved[335]: Positive Trust Anchors: second # [ 8.492704] systemd-resolved[335]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d second # [ 8.498040] systemd-resolved[335]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 test # [ 8.499099] systemd[1]: Starting Remount Root and Kernel File Systems... second # [ 8.504284] systemd-resolved[335]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test test # [ 8.510134] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.534120] systemd[1]: Starting Coldplug All udev Devices... test # [ 8.541464] systemd-journald[329]: Collecting audit messages is enabled. test # [ 8.548711] systemd[1]: Queued start job for default target Multi-User System. test # [ 8.550681] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 8.557788] systemd[1]: Started Journal Service. test # [ 8.555800] systemd-modules-load[330]: Module 'atkbd' is built in test # [ 8.558989] systemd-modules-load[330]: Module 'ctr' is built in test # [ 8.563777] systemd-modules-load[330]: Module 'loop' is built in test # [ 8.568749] systemd[1]: Listening on Journal Log Access Socket. test # [ 8.572716] systemd[1]: Mounted Huge Pages File System. test # [ 8.577921] systemd[1]: Mounted POSIX Message Queue File System. test # [ 8.582929] systemd[1]: Mounted Kernel Debug File System. test # [ 8.589095] systemd[1]: Mounted Kernel Trace File System. test # [ 8.590806] systemd[1]: Finished Create List of Static Device Nodes. test # [ 8.596817] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 8.599942] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 8.611646] systemd[1]: Mounting /run/wrappers... test # [ 8.604279] systemd[1]: Mounted Kernel Configuration File System. test # [ 8.605716] systemd[1]: modprobe@fuse.service: Deactivated successfully. test # [ 8.606855] systemd[1]: Finished Load Kernel Module fuse. test # [ 8.610490] systemd[1]: Finished Load Kernel Modules. test # [ 8.616227] systemd[1]: Mounting FUSE Control File System... test # [ 8.619681] systemd[1]: Starting Firewall... test # [ 8.625768] systemd[1]: Starting Apply Kernel Variables... second # [ 8.640921] systemd-udevd[349]: Using default interface naming scheme 'v261'. test # [ 8.649961] EXT4-fs (vda): re-mounted 13a5909b-75a1-46d8-91b8-51a5d8bc6041. test # [ 8.657553] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 8.664978] systemd-oomd[332]: No swap; memory pressure usage will be degraded second # [ 8.680373] systemd[1]: Mounted /run/wrappers. test # [ 8.670991] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 8.682791] systemd[1]: Reached target Local File Systems. second # [ 8.692424] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 8.685787] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 8.690061] systemd[1]: Listening on Disk Image Download Service Socket. second # [ 8.702826] systemd[1]: Starting register-nix-paths.service... second # [ 8.710397] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 8.712285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 8.706404] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 8.716585] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore second # [ 8.732311] systemd[1]: Starting Save Transient machine-id to Disk... test # [ 8.734695] systemd[1]: Starting Load/Save OS Random Seed... test # [ 8.740158] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 8.770175] systemd[1]: Starting Create System Files and Directories... test # [ 8.810003] systemd[1]: Finished Apply Kernel Variables. test # [ 8.820367] systemd-journald[329]: Received client request to flush runtime journal. second # [ 8.831349] systemd-resolved[335]: Using system hostname 'second'. second # [ 8.847211] systemd[1]: Started Network Name Resolution. second # [ 8.908362] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 8.898398] systemd[1]: Mounted FUSE Control File System. second # [ 8.916069] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 8.906059] systemd[1]: Starting Network Name Resolution... test # [ 8.910637] systemd[1]: Finished Load/Save OS Random Seed. test # [ 8.920991] systemd[1]: Reached target First Boot Complete. test # [ 8.921640] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 8.938385] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 8.943099] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 9.009928] systemd[1]: Finished Create System Files and Directories. test # [ 9.009875] systemd-resolved[358]: Positive Trust Anchors: test # [ 9.012280] systemd-resolved[358]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 9.019503] systemd-resolved[358]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 9.034122] systemd[1]: Starting Rebuild Journal Catalog... test # [ 9.020727] systemd-resolved[358]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test second # [ 9.041554] systemd[1]: Starting Record System Boot/Shutdown in UTMP... test # [ 9.078286] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 9.081099] systemd[1]: Reached target Preparation for Local File Systems. second # [ 9.092702] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 9.086298] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 9.165153] systemd[1]: Finished Record System Boot/Shutdown in UTMP. test # [ 9.182174] systemd[1]: Mounting /run/wrappers... test # [ 9.230134] systemd-udevd[374]: Using default interface naming scheme 'v261'. second # [ 9.271446] systemd[1]: Finished Rebuild Journal Catalog. test # [ 9.268086] systemd[1]: Mounted /run/wrappers. second # [ 9.280958] systemd[1]: Starting Update is Completed... test # [ 9.272786] systemd[1]: Reached target Local File Systems. test # [ 9.278405] systemd[1]: Listening on Boot Loader Control Service Socket. test # [ 9.288105] systemd[1]: Starting register-nix-paths.service... test # [ 9.296719] systemd[1]: Starting Create SUID/SGID Wrappers... test # [ 9.300674] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 9.318472] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 9.333266] systemd[1]: Finished Coldplug All udev Devices. test # [ 9.335614] systemd-resolved[358]: Using system hostname 'test'. second # [ 9.357131] systemd[1]: Finished Update is Completed. test # [ 9.364961] systemd[1]: Starting Create System Files and Directories... test # [ 9.368617] systemd[1]: Started Network Name Resolution. test # [ 9.486088] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 9.499014] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 9.576757] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 9.595679] systemd[1]: Finished Create System Files and Directories. test # [ 9.609291] systemd[1]: Starting Rebuild Journal Catalog... test # [ 9.620759] systemd[1]: Starting Record System Boot/Shutdown in UTMP... test # [ 9.700445] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 9.761344] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 9.782409] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. second # [ 9.786214] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 9.832610] systemd[1]: Finished Coldplug All udev Devices. test # [ 9.838186] systemd[1]: Finished Rebuild Journal Catalog. second # [ 9.854061] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 9.847047] systemd[1]: Starting Update is Completed... second # [ 9.899174] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. test # [ 9.917202] systemd[1]: Finished Update is Completed. second # [ 10.136795] systemd[1]: Finished register-nix-paths.service. second # [ 10.139795] systemd[1]: Reached target System Initialization. second # [ 10.142410] systemd[1]: Started Discard unused filesystem blocks once a week. second # [ 10.145466] systemd[1]: Started Daily Cleanup of Temporary Directories. second # [ 10.149175] systemd[1]: Reached target Timer Units. second # [ 10.149847] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 10.152471] systemd[1]: Listening on Nix Daemon Socket. second # [ 10.159451] systemd[1]: Listening on Authorization Manager Agent Helper. second # [ 10.161663] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. second # [ 10.162508] systemd[1]: Reached target Socket Units. second # [ 10.165345] systemd[1]: Starting D-Bus System Message Bus... test # [ 10.169647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 10.226357] (udev-worker)[447]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.229582] (udev-worker)[454]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.306454] systemd[1]: Finished Firewall. second # [ 10.310375] systemd[1]: Reached target Preparation for Network. second # [ 10.312293] systemd[1]: Listening on Network Management Resolve Hook Socket. second # [ 10.315490] systemd[1]: Starting Network Management... second # [ 10.369226] dbus-broker-launch[519]: Looking up NSS user entry for 'systemd-timesync'... test # [ 10.361014] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 10.365709] systemd[1]: Finished Create SUID/SGID Wrappers. second # [ 10.392505] dbus-broker-launch[519]: NSS returned no entry for 'systemd-timesync' second # [ 10.394219] dbus-broker-launch[519]: Invalid user-name in /nix/store/9bi1kkmb9432hp88ll5za3nqn4z3r8gi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 10.440296] mousedev: PS/2 mouse device common for all mice second # [ 10.457643] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' second # [ 10.465519] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' test # [ 10.455715] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 10.469918] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/0b4cs5a1w1cs0mxvnms62684qzblwipc-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' second # [ 10.483265] dbus-broker-launch[519]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 10.488682] systemd[1]: Started D-Bus System Message Bus. second # [ 10.544612] dbus-broker-launch[519]: Ready test # [ 10.534975] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. second # [ 10.549615] systemd[1]: Reached target Basic System. second # [ 10.554187] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 10.573040] cfg80211: Loading compiled-in X.509 certificates for regulatory database second # [ 10.574841] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 10.589434] systemd[1]: Starting Network Manager... second # [ 10.608276] systemd[1]: Started backdoor.service. second # [ 10.647732] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' second # [ 10.648255] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 10.651977] systemd[1]: Starting Import lastlog data into lastlog2 database... second # [ 10.690576] zsn6lh46yrf8f6yb2sf9bp8azbl2d0jg-wifi-secrets[537]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all second # [ 10.698031] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 10.697168] systemd[1]: Finished register-nix-paths.service. test # [ 10.699398] systemd[1]: Reached target System Initialization. test # [ 10.701053] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 10.703775] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 10.707564] systemd[1]: Reached target Timer Units. test # [ 10.709961] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 10.711915] systemd[1]: Listening on Nix Daemon Socket. test # [ 10.718595] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 10.719353] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. test # [ 10.722994] systemd[1]: Reached target Socket Units. test # [ 10.728509] systemd[1]: Starting D-Bus System Message Bus... second # [ 10.746849] systemd[1]: Starting Post-Boot Actions... second # [ 10.752377] systemd-networkd[532]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 10.771198] systemd-networkd[532]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 10.785598] systemd-networkd[532]: lo: Link UP second # [ 10.793461] systemd-networkd[532]: lo: Gained carrier second # [ 10.803282] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 10.821982] systemd-networkd[532]: eth1: Configuring with /etc/systemd/network/40-eth1.network. second # [ 10.833765] systemd[1]: Started Reset console on configuration changes. second # [ 10.841649] systemd[1]: Started Network Management. second # [ 10.844689] systemd-networkd[532]: eth1: Link UP second # [ 10.852944] systemd-networkd[532]: eth1: Gained carrier second # [ 10.859625] systemd-networkd[532]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 10.852767] (udev-worker)[481]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.856299] (udev-worker)[472]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.871448] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # connecting to host... second # [ 10.878678] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 10.881098] systemd[1]: Finished Firewall. test # [ 10.884109] systemd[1]: Reached target Preparation for Network. test # [ 10.885805] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 10.889156] systemd[1]: Starting Network Management... second # [ 10.909389] systemd[1]: Finished Post-Boot Actions. test # [ 10.934378] dbus-broker-launch[540]: Looking up NSS user entry for 'systemd-timesync'... second # [ 10.947423] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 10.955018] dbus-broker-launch[540]: NSS returned no entry for 'systemd-timesync' test # [ 10.957365] dbus-broker-launch[540]: Invalid user-name in /nix/store/9bi1kkmb9432hp88ll5za3nqn4z3r8gi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 10.997742] nsncd[548]: Aug 20 05:08:23.790 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 10.999009] systemd[1]: Finished Import lastlog data into lastlog2 database. second # [ 11.006590] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 11.009784] systemd[1]: Started Network Manager Script Dispatcher Service. second # [ 11.012699] systemd[1]: Reached target Host and Network Name Lookups. second # [ 11.015481] systemd[1]: Reached target User and Group Name Lookups. second # [ 11.018773] systemd[1]: Starting User Login Management... test # [ 11.019896] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 11.026458] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/g7jql8i5higxl05cy286zjdvxd6ky93l-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' test # [ 11.031887] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/0b4cs5a1w1cs0mxvnms62684qzblwipc-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 11.046085] dbus-broker-launch[540]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/i5ggc249vy2vpjd3yx8abjch11c1q6z9-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 11.057954] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 11.053638] mousedev: PS/2 mouse device common for all mice test # [ 11.052954] systemd[1]: Started D-Bus System Message Bus. test # [ 11.106445] dbus-broker-launch[540]: Ready second # [ 11.117509] systemd[1]: Starting Hostname Service... test # [ 11.110788] systemd[1]: Reached target Basic System. test # [ 11.128219] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 11.131736] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 11.145684] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 11.148993] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.169995] systemd-logind[580]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) second # [ 11.174830] systemd-logind[580]: Watching system buttons on /dev/input/event0 (gpio-keys) second # [ 11.175624] systemd-logind[580]: New seat seat0. test # [ 11.167571] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.182132] systemd[1]: Started User Login Management. second # [ 11.185945] systemd[1]: Starting linger-users.service... test # [ 11.205816] systemd[1]: Starting Network Manager... test # [ 11.235780] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 11.236309] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 11.255561] systemd[1]: Started Hostname Service. test # [ 11.245679] systemd[1]: Started backdoor.service. second # [ 11.268524] systemd[1]: linger-users.service: Deactivated successfully. second # [ 11.271518] systemd[1]: Finished linger-users.service. test # [ 11.277048] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 11.308352] 3g5nyz1jngrkxdc2n9blgiwyahkpbd78-wifi-secrets[562]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-open test # [ 11.321196] zsn6lh46yrf8f6yb2sf9bp8azbl2d0jg-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-all test # [ 11.334865] systemd[1]: Starting Name Service Cache Daemon (nsncd)... second # [ 11.359475] systemd-networkd[532]: eth0: Link UP second # [ 11.360084] systemd-networkd[532]: eth0: Gained carrier second # [ 11.379748] systemd[1]: Started Network Manager. second # [ 11.382305] systemd[1]: Reached target Network. test # [ 11.372370] s26qgk2g28g5q546f1jwsyjwvcspvch9-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets-wg-test-one second # [ 11.389388] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 11.384532] systemd[1]: Starting Post-Boot Actions... second # [ 11.397435] systemd[1]: Starting Permit User Sessions... test # [ 11.409605] systemd-networkd[555]: /etc/systemd/network/99-ethernet-default-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. test # [ 11.430296] systemd[1]: Started Reset console on configuration changes. test # [ 11.439932] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. test # [ 11.450344] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.453215] systemd-networkd[555]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. test # [ 11.469902] systemd-networkd[555]: lo: Link UP test # [ 11.475233] systemd-networkd[555]: lo: Gained carrier test # [ 11.485656] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 11.501239] systemd-networkd[555]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 11.509917] systemd[1]: Started Network Management. test # [ 11.514677] systemd-networkd[555]: eth1: Link UP test # [ 11.517775] systemd-networkd[555]: eth1: Gained carrier test # [ 11.523633] systemd-networkd[555]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # connecting to host... test # [ 11.538240] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test # [ 11.547029] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.547700] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. second # [ 11.563319] systemd[1]: Finished Permit User Sessions. test # [ 11.561914] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. second # [ 11.579048] systemd[1]: Started Getty on tty1. second # [ 11.579619] systemd[1]: Reached target Login Prompts. second # [ 11.592807] systemd-resolved[335]: eth0: Bus client set default route setting: yes test # [ 11.587340] systemd[1]: Finished Post-Boot Actions. second # [ 11.599964] systemd-resolved[335]: eth0: Bus client set DNS server list to: 10.0.2.3 test # [ 11.604912] nsncd[578]: Aug 20 05:08:24.392 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test # [ 11.616646] systemd[1]: Started Name Service Cache Daemon (nsncd). test: Guest shell says: b'Spawning backdoor root shell...\n' test # [ 11.627513] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 11.634985] systemd[1]: Reached target Host and Network Name Lookups. test # [ 11.640561] systemd[1]: Reached target User and Group Name Lookups. test # [ 11.650325] systemd[1]: Starting User Login Management... test: connected to guest root shell test: (connecting took 12.23 seconds) test: (finished: waiting for the VM to finish booting, in 12.23 seconds) test # [ 11.660576] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # [ 11.691644] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. second # [ 11.693202] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. test # [ 11.705381] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 11.820160] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. second # [ 11.836165] systemd[1]: Reached target Multi-User System. second # [ 11.840095] systemd[1]: Startup finished in 752ms (kernel) + 4.605s (initrd) + 6.481s (userspace) = 11.839s. test # [ 11.839656] systemd[1]: Starting Hostname Service... test # [ 11.859884] systemd-logind[610]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) test # [ 11.865048] systemd-logind[610]: Watching system buttons on /dev/input/event0 (gpio-keys) test # [ 11.868998] systemd-logind[610]: New seat seat0. test # [ 11.869557] systemd[1]: Started User Login Management. test # [ 11.875250] systemd[1]: Starting linger-users.service... test # [ 11.956651] systemd[1]: linger-users.service: Deactivated successfully. test # [ 11.957881] systemd[1]: Finished linger-users.service. test # [ 11.979146] systemd[1]: Started Hostname Service. test # [ 12.078300] systemd-networkd[555]: eth0: Link UP test # [ 12.078815] systemd-networkd[555]: eth0: Gained carrier test # [ 12.097755] systemd[1]: Started Network Manager. test # [ 12.100156] systemd[1]: Reached target Network. test # [ 12.108314] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 12.122299] systemd[1]: Starting Permit User Sessions... second # [ 12.244265] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 test # [ 12.270149] systemd[1]: Finished Permit User Sessions. test # [ 12.286019] systemd[1]: Started Getty on tty1. test # [ 12.286535] systemd[1]: Reached target Login Prompts. test # [ 12.294009] systemd-resolved[358]: eth0: Bus client set default route setting: yes test # [ 12.300990] systemd-resolved[358]: eth0: Bus client set DNS server list to: 10.0.2.3 test # [ 12.386206] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. test # [ 12.387667] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. second # [ 12.449293] systemd-networkd[532]: eth1: Gained IPv6LL second # [ 12.494101] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. second # [ 12.534797] systemd[1]: Starting Virtual Console Setup... test # [ 12.537979] systemd[1]: Reached target Multi-User System. test # [ 12.539479] systemd[1]: Startup finished in 760ms (kernel) + 5.373s (initrd) + 6.405s (userspace) = 12.539s. second # [ 12.558215] systemd-logind[580]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) second # [ 12.833923] systemd-networkd[532]: eth0: Gained IPv6LL test: (finished: waiting for unit NetworkManager.service, in 13.47 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-wg-test-open test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets-wg-test-open, in 0.05 seconds) test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection second # [ 13.042633] systemd-vconsole-setup[642]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 13.045458] systemd[1]: Finished Virtual Console Setup. test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds) (finished: run the VM test script, in 14.05 seconds) test # [ 13.057569] systemd-networkd[555]: eth1: Gained IPv6LL test script finished in 14.13s cleanup kill QemuMachine (pid 47) second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14) test # [ 13.153394] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 kill QemuMachine (pid 48) test # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3inr3nxzqarhb9rh1z7s2s20j8c0395h-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.22 seconds)