Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script additionally exposed symbols: second, test, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs second: starting vm test: starting vm second # Disk image does not exist, creating the virtualisation disk image... second # Formatting '/build/vm-state-second/tmp.9fg4Z9jIx0', fmt=raw size=1073741824 second: QEMU running (pid 47) second # mke2fs 1.47.4 (6-Mar-2025) test: QEMU running (pid 48) second # Discarding device blocks: 0/262144 done test # Disk image does not exist, creating the virtualisation disk image... second # Creating filesystem with 262144 4k blocks and 65536 inodes test # Formatting '/build/vm-state-test/tmp.2xKdXrtFOf', fmt=raw size=1073741824 second # Filesystem UUID: 76eb3747-16b5-488f-93cc-511006339cf1 test # mke2fs 1.47.4 (6-Mar-2025) second # Superblock backups stored on blocks: test # Discarding device blocks: 0/262144 done second # 32768, 98304, 163840, 229376 test # Creating filesystem with 262144 4k blocks and 65536 inodes second # test # Filesystem UUID: e4b92456-3df9-414d-b5aa-ad5a662d1ac1 second # Allocating group tables: 0/8 done test # Superblock backups stored on blocks: second # Writing inode tables: 0/8 done test # 32768, 98304, 163840, 229376 second # Creating journal (8192 blocks): done test # second # Writing superblocks and filesystem accounting information: 0/8 done test # Allocating group tables: 0/8 done second # test # Writing inode tables: 0/8 done second # Virtualisation disk image created. test # Creating journal (8192 blocks): done (finished: start all VMs, in 0.45 seconds) test # Writing superblocks and filesystem accounting information: 0/8 done test: waiting for unit NetworkManager.service test # test: waiting for the VM to finish booting test # Virtualisation disk image created. test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] second # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 2026 test # [ 0.000000] Linux version 6.18.40 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Jul 24 14:17:26 UTC 2026 test # [ 0.000000] KASLR enabled test # [ 0.000000] random: crng init done second # [ 0.000000] KASLR enabled second # [ 0.000000] random: crng init done test # [ 0.000000] Machine model: linux,dummy-virt second # [ 0.000000] Machine model: linux,dummy-virt test # [ 0.000000] efi: UEFI not found. second # [ 0.000000] efi: UEFI not found. test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT second # [ 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] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf] second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf] test # [ 0.000000] Zone ranges: second # [ 0.000000] Zone ranges: second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] DMA32 empty test # [ 0.000000] DMA32 empty second # [ 0.000000] Normal empty test # [ 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 test # [ 0.000000] Device empty test # [ 0.000000] Movable zone start for each node test # [ 0.000000] Early memory node ranges second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 test # [ 0.000000] psci: probing for conduit method from DT. test # [ 0.000000] psci: PSCIv1.3 detected in firmware. test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs test # [ 0.000000] psci: Trusted OS migration not required test # [ 0.000000] psci: SMC Calling Convention v1.1 second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) 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 s186392 r8192 d116712 u311296 second # [ 0.000000] Detected PIPT I-cache on CPU0 test # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296 test # [ 0.000000] Detected PIPT I-cache on CPU0 second # [ 0.000000] CPU features: detected: GICv3 CPU interface test # [ 0.000000] CPU features: detected: GICv3 CPU interface second # [ 0.000000] CPU features: detected: Spectre-v4 second # [ 0.000000] CPU features: detected: Spectre-BHB test # [ 0.000000] CPU features: detected: Spectre-v4 test # [ 0.000000] CPU features: detected: Spectre-BHB second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR test # [ 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] CPU features: detected: Kernel page table isolation (KPTI) test # [ 0.000000] CPU features: detected: ARM erratum 1418040 second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion test # [ 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] CPU features: detected: SSBS not fully self-synchronizing test # [ 0.000000] alternatives: applying boot alternatives second # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/sig1b3m5b75sija5blqd6yz3zhfcg0iw-nixos-system-second-test/init regInfo=/nix/store/j285cn5i5k102zf66kqs3c4vw4k58apq-closure-info/registration console=ttyAMA0,115200n8 console=tty0 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/1yld3c5hx0gbc576caic5a44pr6ffiwf-nixos-system-test-test/init regInfo=/nix/store/3vm6bjgby7n08qmf7nsr1qgxjhf9swxx-closure-info/registration console=ttyAMA0,115200n8 console=tty0 second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/j285cn5i5k102zf66kqs3c4vw4k58apq-closure-info/registration", will be passed to user space. test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/3vm6bjgby7n08qmf7nsr1qgxjhf9swxx-closure-info/registration", will be passed to user space. second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) second # [ 0.000000] software IO TLB: area num 1. 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] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) second # [ 0.000000] Fallback order for Node 0: 0 test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 test # [ 0.000000] Fallback order for Node 0: 0 second # [ 0.000000] Policy zone: DMA test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.000000] Policy zone: DMA second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] allocated 2097152 bytes of page_ext second # [ 0.000000] ftrace: allocating 74754 entries in 294 pages test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] ftrace: allocated 294 pages with 4 groups test # [ 0.000000] allocated 2097152 bytes of page_ext second # [ 0.000000] rcu: Hierarchical RCU implementation. second # [ 0.000000] rcu: RCU event tracing is enabled. test # [ 0.000000] ftrace: allocating 74754 entries in 294 pages test # [ 0.000000] ftrace: allocated 294 pages with 4 groups second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.000000] rcu: Hierarchical RCU implementation. second # [ 0.000000] Trampoline variant of Tasks RCU enabled. test # [ 0.000000] rcu: RCU event tracing is enabled. second # [ 0.000000] Rude variant of Tasks RCU enabled. second # [ 0.000000] Tracing variant of Tasks RCU enabled. 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.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. test # [ 0.000000] Rude variant of Tasks RCU enabled. second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.000000] Tracing variant of Tasks RCU enabled. second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] 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 second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] 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 Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 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.000000] GICv3: 256 SPIs implemented test # [ 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] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 second # [ 0.000000] GICv3: 0 Extended SPIs implemented second # [ 0.000000] Root IRQ handler: gic_handle_irq second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 test # [ 0.000000] GICv3: 256 SPIs implemented test # [ 0.000000] GICv3: 0 Extended SPIs implemented second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 test # [ 0.000000] Root IRQ handler: gic_handle_irq second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] second # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) test # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). second # [ 0.000077] arm-pv: using stolen time PV test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns second # [ 0.000442] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.000748] Console: colour dummy device 80x25 test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns second # [ 0.000768] printk: legacy console [tty0] enabled test # [ 0.000071] arm-pv: using stolen time PV second # [ 0.000981] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) test # [ 0.000421] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) second # [ 0.000987] pid_max: default: 32768 minimum: 301 test # [ 0.000728] Console: colour dummy device 80x25 second # [ 0.001081] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.000747] printk: legacy console [tty0] enabled second # [ 0.001225] landlock: Up and running. second # [ 0.001227] Yama: becoming mindful. second # [ 0.001722] LSM support for eBPF active test # [ 0.000963] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) test # [ 0.000969] pid_max: default: 32768 minimum: 301 second # [ 0.001879] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.001065] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.001263] landlock: Up and running. second # [ 0.001899] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.001265] Yama: becoming mindful. second # [ 0.003950] cacheinfo: Unable to detect cache hierarchy for CPU 0 test # [ 0.001744] LSM support for eBPF active second # [ 0.004825] rcu: Hierarchical SRCU implementation. test # [ 0.001921] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.001941] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.004141] cacheinfo: Unable to detect cache hierarchy for CPU 0 test # [ 0.004914] rcu: Hierarchical SRCU implementation. test # [ 0.004919] rcu: Max phase no-delay instances is 1000. test # [ 0.005884] fsl-mc MSI: its@8080000 domain created test # [ 0.006084] EFI services will not be available. test # [ 0.006195] smp: Bringing up secondary CPUs ... test # [ 0.006235] smp: Brought up 1 node, 1 CPU test # [ 0.006239] SMP: Total of 1 processors activated. second # [ 0.004831] rcu: Max phase no-delay instances is 1000. second # [ 0.005787] fsl-mc MSI: its@8080000 domain created second # [ 0.005951] EFI services will not be available. second # [ 0.006050] smp: Bringing up secondary CPUs ... second # [ 0.006093] smp: Brought up 1 node, 1 CPU second # [ 0.006097] SMP: Total of 1 processors activated. second # [ 0.006099] CPU: All CPU(s) started at EL1 second # [ 0.006112] CPU features: detected: 32-bit EL0 Support second # [ 0.006115] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.006118] CPU features: detected: Common not Private translations second # [ 0.006120] CPU features: detected: CRC32 instructions test # [ 0.006241] CPU: All CPU(s) started at EL1 test # [ 0.006254] CPU features: detected: 32-bit EL0 Support second # [ 0.006122] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.006125] CPU features: detected: Enhanced Virtualization Traps test # [ 0.006256] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.006135] CPU features: detected: RCpc load-acquire (LDAPR) test # [ 0.006259] CPU features: detected: Common not Private translations second # [ 0.006137] CPU features: detected: LSE atomic instructions test # [ 0.006262] CPU features: detected: CRC32 instructions second # [ 0.006139] CPU features: detected: Privileged Access Never second # [ 0.006141] CPU features: detected: PMUv3 test # [ 0.006263] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.006143] CPU features: detected: RAS Extension Support test # [ 0.006266] CPU features: detected: Enhanced Virtualization Traps second # [ 0.006147] CPU features: detected: Speculative Store Bypassing Safe (SSBS) test # [ 0.006277] CPU features: detected: RCpc load-acquire (LDAPR) second # [ 0.006175] alternatives: applying system-wide alternatives test # [ 0.006279] CPU features: detected: LSE atomic instructions second # [ 0.007609] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.006281] CPU features: detected: Privileged Access Never second # [ 0.007817] Memory: 891556K/1048576K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 115744K reserved, 32768K cma-reserved) second # [ 0.008327] devtmpfs: initialized second # [ 0.009891] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.009914] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). second # [ 0.010038] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL second # [ 0.010041] 0 pages in range for non-PLT usage second # [ 0.010042] 508320 pages in range for PLT usage test # [ 0.006283] CPU features: detected: PMUv3 test # [ 0.006285] CPU features: detected: RAS Extension Support test # [ 0.006289] CPU features: detected: Speculative Store Bypassing Safe (SSBS) test # [ 0.006311] alternatives: applying system-wide alternatives test # [ 0.007695] CPU features: detected: Hardware dirty bit management on CPU0 test # [ 0.007936] Memory: 891552K/1048576K available (24384K kernel code, 7086K rwdata, 26316K rodata, 4736K init, 1102K bss, 115744K reserved, 32768K cma-reserved) test # [ 0.008429] devtmpfs: initialized test # [ 0.010007] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.010172] pinctrl core: initialized pinctrl subsystem second # [ 0.010975] DMI not present or invalid. test # [ 0.010030] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). second # [ 0.014816] NET: Registered PF_NETLINK/PF_ROUTE protocol family second # [ 0.017210] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations second # [ 0.017349] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.017501] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.017521] audit: initializing netlink subsys (disabled) second # [ 0.018150] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.010174] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL test # [ 0.010177] 0 pages in range for non-PLT usage test # [ 0.010178] 508320 pages in range for PLT usage test # [ 0.010307] pinctrl core: initialized pinctrl subsystem test # [ 0.011142] DMI not present or invalid. test # [ 0.014659] NET: Registered PF_NETLINK/PF_ROUTE protocol family test # [ 0.017295] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations second # [ 0.018152] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.017433] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.018156] thermal_sys: Registered thermal governor 'step_wise' second # [ 0.018158] thermal_sys: Registered thermal governor 'user_space' second # [ 0.018160] thermal_sys: Registered thermal governor 'power_allocator' second # [ 0.018201] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 second # [ 0.018216] cpuidle: using governor ladder second # [ 0.018221] cpuidle: using governor menu second # [ 0.018338] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. second # [ 0.018360] ASID allocator initialised with 32768 entries second # [ 0.019031] Serial: AMBA PL011 UART driver test # [ 0.017585] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.022218] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 test # [ 0.017605] audit: initializing netlink subsys (disabled) second # [ 0.022396] printk: console [ttyAMA0] enabled test # [ 0.018256] thermal_sys: Registered thermal governor 'fair_share' test # [ 0.018258] thermal_sys: Registered thermal governor 'bang_bang' test # [ 0.018261] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.018263] thermal_sys: Registered thermal governor 'user_space' test # [ 0.018265] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.018308] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 test # [ 0.018325] cpuidle: using governor ladder test # [ 0.018330] cpuidle: using governor menu test # [ 0.018454] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. test # [ 0.018477] ASID allocator initialised with 32768 entries test # [ 0.019177] Serial: AMBA PL011 UART driver test # [ 0.022796] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 test # [ 0.022981] printk: console [ttyAMA0] enabled second # [ 0.093599] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.093624] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.093628] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages second # [ 0.093633] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page test # [ 0.095959] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.093637] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.095982] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.093640] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.095986] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages second # [ 0.093643] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages test # [ 0.095992] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page second # [ 0.093646] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page test # [ 0.095995] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.095998] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page test # [ 0.096001] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages test # [ 0.096004] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page second # [ 0.098432] fbcon: Taking over console second # [ 0.098459] ACPI: Interpreter disabled. second # [ 0.099644] iommu: Default domain type: Translated second # [ 0.099654] iommu: DMA domain TLB invalidation policy: strict mode test # [ 0.100822] fbcon: Taking over console second # [ 0.100780] SCSI subsystem initialized test # [ 0.100847] ACPI: Interpreter disabled. test # [ 0.102099] iommu: Default domain type: Translated second # [ 0.101325] usbcore: registered new interface driver usbfs test # [ 0.102108] iommu: DMA domain TLB invalidation policy: strict mode second # [ 0.101363] usbcore: registered new interface driver hub second # [ 0.101374] usbcore: registered new device driver usb test # [ 0.103247] SCSI subsystem initialized second # [ 0.101574] pps_core: LinuxPPS API ver. 1 registered test # [ 0.103803] usbcore: registered new interface driver usbfs test # [ 0.103840] usbcore: registered new interface driver hub test # [ 0.103850] usbcore: registered new device driver usb test # [ 0.105298] pps_core: LinuxPPS API ver. 1 registered test # [ 0.105308] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti test # [ 0.105315] PTP clock support registered test # [ 0.105361] EDAC MC: Ver: 3.0.0 second # [ 0.109602] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti second # [ 0.109638] PTP clock support registered test # [ 0.112082] scmi_core: SCMI protocol bus registered second # [ 0.109682] EDAC MC: Ver: 3.0.0 second # [ 0.111053] scmi_core: SCMI protocol bus registered second # [ 0.111715] FPGA manager framework test # [ 0.112804] FPGA manager framework second # [ 0.112754] vgaarb: loaded test # [ 0.113769] vgaarb: loaded second # [ 0.113184] clocksource: Switched to clocksource arch_sys_counter test # [ 0.114202] clocksource: Switched to clocksource arch_sys_counter second # [ 0.114276] VFS: Disk quotas dquot_6.6.0 test # [ 0.114616] VFS: Disk quotas dquot_6.6.0 second # [ 0.114310] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.114642] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.115307] netfs: FS-Cache loaded test # [ 0.116226] netfs: FS-Cache loaded second # [ 0.115419] pnp: PnP ACPI: disabled test # [ 0.116336] pnp: PnP ACPI: disabled second # [ 0.122472] NET: Registered PF_INET protocol family test # [ 0.124802] NET: Registered PF_INET protocol family second # [ 0.122654] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.124993] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.149951] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.149979] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.149991] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.150029] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) test # [ 0.150098] TCP: Hash tables configured (established 8192 bind 8192) test # [ 0.150188] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.153603] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.153663] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.153806] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.153842] NET: Registered PF_XDP protocol family test # [ 0.153865] PCI: CLS 0 bytes, default 64 second # [ 0.147871] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.147900] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) second # [ 0.147914] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.147950] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.148018] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.148110] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) test # [ 0.156197] Trying to unpack rootfs image as initramfs... second # [ 0.148179] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.148230] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.148358] NET: Registered PF_UNIX/PF_LOCAL protocol family second # [ 0.148396] NET: Registered PF_XDP protocol family second # [ 0.148418] PCI: CLS 0 bytes, default 64 second # [ 0.148628] Trying to unpack rootfs image as initramfs... test # [ 0.162653] kvm [1]: HYP mode not available second # [ 0.162916] kvm [1]: HYP mode not available second # [ 0.225571] Initialise system trusted keyrings second # [ 0.226093] workingset: timestamp_bits=42 max_order=18 bucket_order=0 second # [ 0.227023] squashfs: version 4.0 (2009/01/31) Phillip Lougher test # [ 0.228247] Initialise system trusted keyrings test # [ 0.228724] workingset: timestamp_bits=42 max_order=18 bucket_order=0 test # [ 0.229716] squashfs: version 4.0 (2009/01/31) Phillip Lougher second # [ 0.227498] 9p: Installing v9fs 9p2000 file system support test # [ 0.230187] 9p: Installing v9fs 9p2000 file system support test # [ 0.249455] Key type asymmetric registered test # [ 0.249482] Asymmetric key parser 'x509' registered test # [ 0.249546] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.250411] Key type asymmetric registered second # [ 0.250438] Asymmetric key parser 'x509' registered second # [ 0.250502] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) second # [ 0.251795] io scheduler mq-deadline registered second # [ 0.251805] io scheduler kyber registered test # [ 0.254263] io scheduler mq-deadline registered test # [ 0.254277] io scheduler kyber registered second # [ 0.261331] pl061_gpio 9030000.pl061: PL061 GPIO chip registered test # [ 0.262342] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.261694] ledtrig-cpu: registered to indicate activity on CPUs test # [ 0.262707] ledtrig-cpu: registered to indicate activity on CPUs second # [ 0.262004] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: test # [ 0.263030] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: second # [ 0.262025] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 test # [ 0.263052] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 second # [ 0.262042] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.263067] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 second # [ 0.262049] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 test # [ 0.263073] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 second # [ 0.262086] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits test # [ 0.263101] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits second # [ 0.262111] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] test # [ 0.263125] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] second # [ 0.262198] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 test # [ 0.263195] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 second # [ 0.262222] pci_bus 0000:00: root bus resource [bus 00-ff] test # [ 0.263218] pci_bus 0000:00: root bus resource [bus 00-ff] second # [ 0.262227] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.263224] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] second # [ 0.262231] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.263227] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] second # [ 0.262234] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] test # [ 0.263231] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] second # [ 0.262319] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint test # [ 0.263350] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint second # [ 0.262796] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.263822] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.262921] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] test # [ 0.263950] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] second # [ 0.262933] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.263962] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.262954] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.263984] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.262965] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.263995] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.263275] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.264308] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.263400] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] test # [ 0.264433] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] second # [ 0.263411] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.264444] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.263432] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.264465] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.263736] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.264776] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.263860] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] test # [ 0.264901] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] second # [ 0.263871] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.264912] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.263892] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.264932] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.264197] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.265244] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.264333] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] test # [ 0.265368] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] second # [ 0.264344] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.265378] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.264363] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.265399] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.264673] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.265702] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint second # [ 0.264796] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] test # [ 0.265825] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] second # [ 0.264807] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.265836] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.264828] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.265855] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.265130] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.266147] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint second # [ 0.265274] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] test # [ 0.266286] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] second # [ 0.265286] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.266298] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.265306] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.266317] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.265643] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.266617] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.265767] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] test # [ 0.266740] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] second # [ 0.265778] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.266751] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.265800] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.266771] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.265815] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.266785] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.266117] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint test # [ 0.267120] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint second # [ 0.266251] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.267253] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.266271] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.267274] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.266584] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint test # [ 0.267582] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.266710] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.267708] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.266731] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.267728] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.266988] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint test # [ 0.267990] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.267108] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] test # [ 0.268108] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.267285] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint test # [ 0.268274] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.267451] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] test # [ 0.268468] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] second # [ 0.267463] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.268482] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.267482] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.268502] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.267899] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.268022] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] test # [ 0.268806] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.268929] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.268034] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.268940] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.268053] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.268959] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.268470] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned test # [ 0.269373] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned second # [ 0.268483] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned test # [ 0.269384] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned second # [ 0.268488] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned test # [ 0.269389] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned second # [ 0.268523] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned test # [ 0.269422] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned second # [ 0.268555] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned test # [ 0.269454] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned second # [ 0.268585] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned test # [ 0.269484] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.268616] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned test # [ 0.269515] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned second # [ 0.268646] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned test # [ 0.269547] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned second # [ 0.268676] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned test # [ 0.269578] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned second # [ 0.268707] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned test # [ 0.269610] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned second # [ 0.268737] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned test # [ 0.269642] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned second # [ 0.268768] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned test # [ 0.269673] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned second # [ 0.268830] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned second # [ 0.268861] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned test # [ 0.269732] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned second # [ 0.268876] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned test # [ 0.269763] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned second # [ 0.268889] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned test # [ 0.269777] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned second # [ 0.268903] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned test # [ 0.269791] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned second # [ 0.268917] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned test # [ 0.269804] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned second # [ 0.268931] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned test # [ 0.269817] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned second # [ 0.268945] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned test # [ 0.269831] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned second # [ 0.268959] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned test # [ 0.269845] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned second # [ 0.268972] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned test # [ 0.269859] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned second # [ 0.268986] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned test # [ 0.269872] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned second # [ 0.269000] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned test # [ 0.269886] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned second # [ 0.269014] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned test # [ 0.269900] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned second # [ 0.269027] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.269914] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned second # [ 0.269041] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.269927] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.269940] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.269954] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.269967] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned test # [ 0.269980] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned test # [ 0.269999] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.270012] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned second # [ 0.269055] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.270025] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned second # [ 0.269068] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned test # [ 0.270038] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.269082] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned test # [ 0.270062] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] second # [ 0.269100] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.270069] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] second # [ 0.269113] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned test # [ 0.270073] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] second # [ 0.269127] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned second # [ 0.269140] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.269165] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] second # [ 0.269172] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] second # [ 0.269176] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] test # [ 0.326897] pci 0000:00:0a.0: enabling device (0000 -> 0002) second # [ 0.325973] pci 0000:00:0a.0: enabling device (0000 -> 0002) second # [ 0.332562] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) test # [ 0.333652] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.342362] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) test # [ 0.343466] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) test # [ 0.350369] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) second # [ 0.349354] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) test # [ 0.352104] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) second # [ 0.351133] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) test # [ 0.353854] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) second # [ 0.353038] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) test # [ 0.363488] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.362665] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) test # [ 0.365360] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) second # [ 0.364553] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.371279] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) test # [ 0.373271] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) second # [ 0.375808] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.378273] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) second # [ 0.379856] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) test # [ 0.383352] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) test # [ 0.385464] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) second # [ 0.389693] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) second # [ 0.393848] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.394939] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled second # [ 0.395384] msm_serial: driver initialized test # [ 0.396484] msm_serial: driver initialized second # [ 0.395474] SuperH (H)SCI(F) driver initialized test # [ 0.396575] SuperH (H)SCI(F) driver initialized second # [ 0.395509] STM32 USART driver initialized test # [ 0.396618] STM32 USART driver initialized second # [ 0.421666] loop: module loaded second # [ 0.421810] virtio_blk virtio5: 1/0/0 default/read/poll queues test # [ 0.422916] loop: module loaded test # [ 0.423062] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 0.422424] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) test # [ 0.423607] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 0.425592] megasas: 07.734.00.00-rc1 second # [ 0.426061] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] test # [ 0.430655] megasas: 07.734.00.00-rc1 test # [ 0.431138] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] test # [ 0.433448] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.433480] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.435165] Using buffer write method test # [ 0.435218] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] test # [ 0.436942] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.436981] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.437756] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.437796] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.442591] Using buffer write method second # [ 0.439485] Using buffer write method test # [ 0.442614] Concatenating MTD devices: test # [ 0.442617] (0): "0.flash" test # [ 0.442620] (1): "0.flash" second # [ 0.439524] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] test # [ 0.442622] into device "0.flash" second # [ 0.444178] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.444200] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.446730] Using buffer write method second # [ 0.446753] Concatenating MTD devices: second # [ 0.446756] (0): "0.flash" second # [ 0.446759] (1): "0.flash" second # [ 0.446762] into device "0.flash" test # [ 0.662622] Freeing initrd memory: 27072K test # [ 0.669547] tun: Universal TUN/TAP device driver, 1.6 second # [ 0.671736] Freeing initrd memory: 27072K test # [ 0.672169] thunder_xcv, ver 1.0 test # [ 0.672202] thunder_bgx, ver 1.0 test # [ 0.672214] nicpf, ver 1.0 test # [ 0.672526] e1000: Intel(R) PRO/1000 Network Driver test # [ 0.672536] e1000: Copyright (c) 1999-2006 Intel Corporation. test # [ 0.672554] e1000e: Intel(R) PRO/1000 Network Driver test # [ 0.672559] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. test # [ 0.672573] igb: Intel(R) Gigabit Ethernet Network Driver test # [ 0.672576] igb: Copyright (c) 2007-2014 Intel Corporation. test # [ 0.672588] igbvf: Intel(R) Gigabit Virtual Function Network Driver test # [ 0.672591] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. test # [ 0.672658] sky2: driver version 1.30 test # [ 0.673544] usbcore: registered new interface driver usb-storage second # [ 0.678741] tun: Universal TUN/TAP device driver, 1.6 test # [ 0.673600] usbcore: registered new interface driver usbserial_generic test # [ 0.673625] usbserial: USB Serial support registered for generic test # [ 0.673927] hv_vmbus: registering driver hyperv_keyboard test # [ 0.674838] ehci-pci 0000:00:0a.0: EHCI Host Controller test # [ 0.674877] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 test # [ 0.675108] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 test # [ 0.682784] rtc-pl031 9010000.pl031: registered as rtc0 test # [ 0.682820] rtc-pl031 9010000.pl031: setting system clock to 2026-07-27T00:15:05 UTC (1785111305) second # [ 0.681464] thunder_xcv, ver 1.0 test # [ 0.683008] i2c_dev: i2c /dev entries driver second # [ 0.681491] thunder_bgx, ver 1.0 second # [ 0.681502] nicpf, ver 1.0 second # [ 0.681796] e1000: Intel(R) PRO/1000 Network Driver second # [ 0.681804] e1000: Copyright (c) 1999-2006 Intel Corporation. second # [ 0.681822] e1000e: Intel(R) PRO/1000 Network Driver second # [ 0.681827] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. second # [ 0.681840] igb: Intel(R) Gigabit Ethernet Network Driver test # [ 0.685780] sdhci: Secure Digital Host Controller Interface driver second # [ 0.681844] igb: Copyright (c) 2007-2014 Intel Corporation. test # [ 0.685795] sdhci: Copyright(c) Pierre Ossman second # [ 0.681854] igbvf: Intel(R) Gigabit Virtual Function Network Driver test # [ 0.685944] Synopsys Designware Multimedia Card Interface Driver second # [ 0.681858] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. test # [ 0.686121] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.681924] sky2: driver version 1.30 test # [ 0.686275] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 second # [ 0.682714] usbcore: registered new interface driver usb-storage test # [ 0.686613] hub 1-0:1.0: USB hub found test # [ 0.686636] hub 1-0:1.0: 6 ports detected second # [ 0.682800] usbcore: registered new interface driver usbserial_generic second # [ 0.682821] usbserial: USB Serial support registered for generic second # [ 0.683101] hv_vmbus: registering driver hyperv_keyboard second # [ 0.690051] ehci-pci 0000:00:0a.0: EHCI Host Controller second # [ 0.690089] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 second # [ 0.690308] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 second # [ 0.691832] rtc-pl031 9010000.pl031: registered as rtc0 second # [ 0.691869] rtc-pl031 9010000.pl031: setting system clock to 2026-07-27T00:15:05 UTC (1785111305) second # [ 0.692051] i2c_dev: i2c /dev entries driver second # [ 0.694756] sdhci: Secure Digital Host Controller Interface driver test # [ 0.690387] hid: raw HID events driver (C) Jiri Kosina second # [ 0.694771] sdhci: Copyright(c) Pierre Ossman test # [ 0.690529] usbcore: registered new interface driver usbhid test # [ 0.690534] usbhid: USB HID core driver second # [ 0.694899] Synopsys Designware Multimedia Card Interface Driver second # [ 0.695091] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.695970] hid: raw HID events driver (C) Jiri Kosina second # [ 0.696142] usbcore: registered new interface driver usbhid second # [ 0.696148] usbhid: USB HID core driver test # [ 0.718588] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available test # [ 0.719416] drop_monitor: Initializing network drop monitor service second # [ 0.719101] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 test # [ 0.719530] NET: Registered PF_INET6 protocol family second # [ 0.719484] hub 1-0:1.0: USB hub found second # [ 0.719509] hub 1-0:1.0: 6 ports detected test # [ 0.721644] Segment Routing with IPv6 test # [ 0.721671] In-situ OAM (IOAM) with IPv6 test # [ 0.721728] NET: Registered PF_PACKET protocol family second # [ 0.720801] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available second # [ 0.721640] drop_monitor: Initializing network drop monitor service second # [ 0.721791] NET: Registered PF_INET6 protocol family second # [ 0.723937] Segment Routing with IPv6 second # [ 0.723964] In-situ OAM (IOAM) with IPv6 second # [ 0.724012] NET: Registered PF_PACKET protocol family second # [ 0.725042] 9pnet: Installing 9P2000 support test # [ 0.722793] 9pnet: Installing 9P2000 support test # [ 0.724454] Key type dns_resolver registered second # [ 0.727172] Key type dns_resolver registered test # [ 0.728684] registered taskstats version 1 test # [ 0.728858] Loading compiled-in X.509 certificates second # [ 0.730547] registered taskstats version 1 second # [ 0.730702] Loading compiled-in X.509 certificates test # [ 0.734143] Demotion targets for Node 0: null test # [ 0.734855] Key type .fscrypt registered test # [ 0.734865] Key type fscrypt-provisioning registered test # [ 0.734985] ima: No TPM chip found, activating TPM-bypass! test # [ 0.734998] ima: Allocated hash algorithm: sha1 test # [ 0.735051] ima: No architecture policies found second # [ 0.735893] Demotion targets for Node 0: null second # [ 0.735999] Key type .fscrypt registered test # [ 0.737292] input: gpio-keys as /devices/platform/gpio-keys/input/input0 second # [ 0.736005] Key type fscrypt-provisioning registered second # [ 0.736121] ima: No TPM chip found, activating TPM-bypass! second # [ 0.736134] ima: Allocated hash algorithm: sha1 second # [ 0.736189] ima: No architecture policies found second # [ 0.739016] input: gpio-keys as /devices/platform/gpio-keys/input/input0 test # [ 0.747704] clk: Disabling unused clocks test # [ 0.747731] PM: genpd: Disabling unused power domains test # [ 0.750959] Freeing unused kernel memory: 4736K test # [ 0.751050] Run /init as init process second # [ 0.749856] clk: Disabling unused clocks second # [ 0.749882] PM: genpd: Disabling unused power domains second # [ 0.753215] Freeing unused kernel memory: 4736K second # [ 0.753317] Run /init as init process test # [ 0.772628] systemd[1]: Successfully made /usr/ read-only. second # [ 0.775663] systemd[1]: Successfully made /usr/ read-only. test # [ 0.938258] usb 1-1: new high-speed USB device number 2 using ehci-pci second # [ 0.965243] usb 1-1: new high-speed USB device number 2 using ehci-pci test # [ 1.090313] 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.107203] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) test # [ 1.113658] systemd[1]: Detected virtualization qemu. test # [ 1.114868] systemd[1]: Detected architecture arm64. test # [ 1.115872] systemd[1]: Running in initrd. second # [ 1.110382] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) test # [ 1.117515] systemd[1]: Initializing machine ID from random generator. second # [ 1.117274] systemd[1]: Detected virtualization qemu. second # [ 1.118341] systemd[1]: Detected architecture arm64. test # [ 1.119319] systemd[1]: Hostname set to . second # [ 1.119344] systemd[1]: Running in initrd. second # [ 1.121367] systemd[1]: Initializing machine ID from random generator. second # [ 1.123468] systemd[1]: Hostname set to . second # [ 1.128639] 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.174408] 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.209388] 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.294244] usb 1-2: new high-speed USB device number 3 using ehci-pci second # [ 1.329222] usb 1-2: new high-speed USB device number 3 using ehci-pci test # [ 1.391195] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.414452] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 1.448210] 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.451390] 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.471488] systemd[1]: Queued start job for default target Initrd Default Target. second # [ 1.479644] systemd[1]: Created slice Slice /system/modprobe. second # [ 1.480556] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 1.481261] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.481775] systemd[1]: Reached target Path Units. second # [ 1.482318] systemd[1]: Reached target Slice Units. second # [ 1.483054] 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.483132] 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.485251] systemd[1]: Reached target Swaps. second # [ 1.485613] systemd[1]: Reached target Timer Units. second # [ 1.486172] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.486794] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.487355] systemd[1]: Listening on Journal Sockets. second # [ 1.487847] systemd[1]: Listening on udev Control Socket. second # [ 1.488465] systemd[1]: Listening on udev Kernel Socket. second # [ 1.488907] systemd[1]: Reached target Socket Units. second # [ 1.490366] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.496304] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.497286] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 1.499829] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.508200] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.509138] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.510090] systemd[1]: Expecting device /dev/disk/by-label/nixos... test # [ 1.510939] systemd[1]: Reached target Path Units. test # [ 1.511520] systemd[1]: Reached target Slice Units. test # [ 1.512100] systemd[1]: Reached target Swaps. test # [ 1.512620] systemd[1]: Reached target Timer Units. test # [ 1.513512] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.511974] systemd[1]: Mounting Kernel Configuration File System... test # [ 1.514454] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.514094] systemd[1]: Starting Journal Service... test # [ 1.515273] systemd[1]: Listening on Journal Sockets. test # [ 1.515974] systemd[1]: Listening on udev Control Socket. test # [ 1.516730] systemd[1]: Listening on udev Kernel Socket. test # [ 1.517391] systemd[1]: Reached target Socket Units. test # [ 1.519419] systemd[1]: Starting Create List of Static Device Nodes... second # [ 1.519798] systemd[1]: Starting Load Kernel Modules... second # [ 1.521342] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 1.522732] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.526317] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 1.527102] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 1.536129] systemd[1]: Mounting Kernel Configuration File System... second # [ 1.535695] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.536687] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.546544] systemd[1]: Starting Journal Service... second # [ 1.549376] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 1.549807] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.556088] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.558374] systemd[1]: Starting Load Kernel Modules... test # [ 1.559080] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 1.570281] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.569281] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev second # [ 1.573843] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 second # [ 1.574066] [drm] features: -virgl +edid -resource_blob -host_visible second # [ 1.574070] [drm] features: -context_init second # [ 1.574509] [drm] number of scanouts: 1 second # [ 1.574522] [drm] number of cap sets: 0 second # [ 1.577360] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.586369] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.586943] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 1.587373] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 1.588575] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 1.587560] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.587749] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.595957] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.596825] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic second # [ 1.596839] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 test # [ 1.602483] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.623964] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. second # [ 1.619070] Console: switching to colour frame buffer device 160x50 second # [ 1.625406] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.625542] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.625568] systemd[1]: Reached target Local File Systems. test # [ 1.632100] systemd-journald[73]: Collecting audit messages is disabled. test # [ 1.633105] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.629443] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.634829] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.646268] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device test # [ 1.650299] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.654968] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 test # [ 1.655184] [drm] features: -virgl +edid -resource_blob -host_visible test # [ 1.655190] [drm] features: -context_init test # [ 1.655634] [drm] number of scanouts: 1 test # [ 1.655651] [drm] number of cap sets: 0 second # [ 1.660818] systemd[1]: Finished Load Kernel Modules. second # [ 1.662976] systemd[1]: Starting Apply Kernel Variables... test # [ 1.666628] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.666823] systemd[1]: Reached target Preparation for Local File Systems. test # [ 1.666855] systemd[1]: Reached target Local File Systems. test # [ 1.669340] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.678619] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic test # [ 1.678635] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 second # [ 1.684285] systemd-modules-load[74]: Inserted module 'dm_mod' second # [ 1.685132] systemd-modules-load[74]: Module 'virtio_balloon' is built in second # [ 1.697444] systemd[1]: Started Journal Service. second # [ 1.690741] systemd-modules-load[74]: Module 'virtio_console' is built in second # [ 1.696335] systemd-modules-load[74]: Inserted module 'virtio_gpu' test # [ 1.702616] Console: switching to colour frame buffer device 160x50 second # [ 1.700144] systemd-modules-load[74]: Module 'virtio_rng' is built in second # [ 1.704098] systemd[1]: Starting Create System Files and Directories... second # [ 1.704712] systemd[1]: Finished Apply Kernel Variables. second # [ 1.714003] systemd-udevd[80]: Using default interface naming scheme 'v261'. test # [ 1.725877] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device test # [ 1.730423] systemd[1]: Started Journal Service. test # [ 1.728919] systemd-modules-load[74]: Inserted module 'dm_mod' test # [ 1.729932] systemd-modules-load[74]: Module 'virtio_balloon' is built in test # [ 1.735719] systemd-modules-load[74]: Module 'virtio_console' is built in second # [ 1.732316] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.740294] systemd[1]: Starting Create System Files and Directories... test # [ 1.740963] systemd-modules-load[74]: Inserted module 'virtio_gpu' test # [ 1.741552] systemd-modules-load[74]: Module 'virtio_rng' is built in second # [ 1.738592] systemd[1]: Finished Create System Files and Directories. test # [ 1.752049] systemd-udevd[80]: Using default interface naming scheme 'v261'. test # [ 1.753756] systemd[1]: Finished Load Kernel Modules. test # [ 1.765284] systemd[1]: Starting Apply Kernel Variables... test # [ 1.773429] systemd[1]: Finished Create System Files and Directories. second # [ 1.775775] systemd[1]: Starting Virtual Console Setup... test # [ 1.787166] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.792599] systemd[1]: Finished Apply Kernel Variables. second # [ 1.813064] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 1.814767] systemd[1]: Finished Virtual Console Setup. test # [ 1.839522] systemd[1]: Starting Virtual Console Setup... test # [ 1.872393] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 1.874555] systemd[1]: Finished Virtual Console Setup. second # [ 2.041393] systemd[1]: Finished Coldplug All udev Devices. second # [ 2.041961] systemd[1]: Reached target System Initialization. second # [ 2.042438] systemd[1]: Reached target Basic System. test # [ 2.094833] systemd[1]: Finished Coldplug All udev Devices. test # [ 2.095404] systemd[1]: Reached target System Initialization. test # [ 2.095870] systemd[1]: Reached target Basic System. second # [ 2.139215] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.159949] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.186190] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.208194] systemd[1]: Found device /dev/disk/by-label/nixos. second # [ 2.209556] systemd[1]: Reached target Initrd Root Device. second # [ 2.211377] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 2.215953] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.255354] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks test # [ 2.260623] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.262850] systemd[1]: Reached target Initrd Root Device. test # [ 2.265139] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 2.269829] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.309069] systemd-fsck[111]: nixos: clean, 12/65536 files, 13019/262144 blocks test # [ 2.314221] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.516147] systemd[1]: Mounting /sysroot... second # [ 2.549962] EXT4-fs (vda): mounted filesystem 76eb3747-16b5-488f-93cc-511006339cf1 r/w with ordered data mode. Quota mode: none. second # [ 2.546086] systemd[1]: Mounted /sysroot. second # [ 2.547594] systemd[1]: Reached target Initrd Root File System. second # [ 2.550822] systemd[1]: Starting Mountpoints Configured in the Real Root... second # [ 2.569462] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. second # [ 2.573366] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.578715] systemd[1]: Mounting /sysroot... second # [ 2.576213] systemd[1]: Reloading... test # [ 2.610303] EXT4-fs (vda): mounted filesystem e4b92456-3df9-414d-b5aa-ad5a662d1ac1 r/w with ordered data mode. Quota mode: none. test # [ 2.608197] systemd[1]: Mounted /sysroot. test # [ 2.610962] systemd[1]: Reached target Initrd Root File System. test # [ 2.612354] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.630434] systemd-sysroot-fstab-check[119]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.635292] systemd[1]: Reload requested from client PID 119 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.638220] systemd[1]: Reloading... second # [ 2.737242] systemd[1]: Reloading finished in 162 ms. second # [ 2.763388] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... second # [ 2.765568] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... second # [ 2.770168] systemd[1]: initrd-parse-etc.service: Deactivated successfully. second # [ 2.772095] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.773379] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. second # [ 2.776134] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 2.793051] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 2.793691] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 2.800316] systemd[1]: Reloading finished in 163 ms. test # [ 2.827635] systemd-sysroot-fstab-check[119]: Requesting initrd-fs.target/start/replace... test # [ 2.831107] systemd-sysroot-fstab-check[119]: Requesting swap.target/start/replace... test # [ 2.836346] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 2.843711] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 2.848609] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 2.849222] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 2.851799] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 2.854220] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 2.979500] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory second # [ 2.983262] (udev-worker)[95]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory second # [ 3.002836] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.003697] systemd[1]: Stopped Virtual Console Setup. second # [ 3.006141] systemd[1]: Stopping Virtual Console Setup... second # [ 3.006769] systemd[1]: Starting Virtual Console Setup... second # [ 3.012680] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.013578] systemd[1]: Stopped Virtual Console Setup. second # [ 3.019759] systemd[1]: Starting Virtual Console Setup... test # [ 3.039160] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/mtd_probe": No such file or directory second # [ 3.039427] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 3.041591] systemd[1]: Finished Virtual Console Setup. test # [ 3.044203] (udev-worker)[102]: mtd0ro: /nix/store/z2nxjmk4666nbka3hgyxlg13prrnvx38-systemd-261/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory test # [ 3.051599] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.052338] systemd[1]: Stopped Virtual Console Setup. test # [ 3.053180] systemd[1]: Stopping Virtual Console Setup... test # [ 3.056165] systemd[1]: Starting Virtual Console Setup... test # [ 3.079064] systemd-vconsole-setup[140]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 3.081310] systemd[1]: Finished Virtual Console Setup. second # [ 3.519645] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.528256] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.536240] systemd[1]: Mounting /sysroot/run... second # [ 3.544496] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.564216] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 3.582202] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.580435] systemd[1]: Mounted /sysroot/run. second # [ 3.583393] systemd[1]: Mounted /sysroot/nix/.ro-store. second # [ 3.589547] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 3.593726] systemd[1]: Mounting /sysroot/nix/.rw-store... test # [ 3.595578] systemd[1]: Mounting /sysroot/run... second # [ 3.596229] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.598301] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.602387] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.608272] systemd[1]: Mounting /sysroot/tmp/shared... second # [ 3.614896] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.616188] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.624272] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 3.657707] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 3.668756] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.671685] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 3.678288] systemd[1]: Mounted /sysroot/run. test # [ 3.679816] systemd[1]: Mounted /sysroot/tmp/shared. test # [ 3.681765] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.691648] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.692883] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.694832] systemd[1]: Mounting /sysroot/nix/store... test # [ 3.720615] systemd[1]: Mounted /sysroot/nix/store. test # [ 3.721744] systemd[1]: Reached target Initrd File Systems. test # [ 3.723347] systemd[1]: Starting Find NixOS closure... test # [ 3.731470] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... test # [ 3.749254] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. test # [ 3.762409] systemd[1]: Finished Find NixOS closure. test # [ 3.763563] systemd[1]: Reached target Initrd Default Target. test # [ 3.765496] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 3.788338] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 3.789300] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 3.791807] systemd[1]: Stopped target Initrd Default Target. test # [ 3.792688] systemd[1]: Stopped target Basic System. test # [ 3.793168] systemd[1]: Stopped target Initrd Root Device. test # [ 3.795820] systemd[1]: Stopped target Path Units. test # [ 3.796558] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 3.797320] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. test # [ 3.798852] systemd[1]: Stopped target Slice Units. test # [ 3.800160] systemd[1]: Stopped target Socket Units. test # [ 3.803976] systemd[1]: Stopped target System Initialization. test # [ 3.804624] systemd[1]: Stopped target Swaps. test # [ 3.805111] systemd[1]: Stopped target Timer Units. test # [ 3.805525] systemd[1]: dbus.socket: Deactivated successfully. test # [ 3.806055] systemd[1]: Closed D-Bus System Message Bus Socket. test # [ 3.806567] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 3.807284] systemd[1]: Stopped Find NixOS closure. test # [ 3.807782] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 3.811520] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.814603] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 3.820149] systemd[1]: Stopped Apply Kernel Variables. test # [ 3.821158] systemd[1]: systemd-modules-load.service: Deactivated successfully. test # [ 3.825443] systemd[1]: Stopped Load Kernel Modules. test # [ 3.827237] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 3.830259] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. test # [ 3.831622] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 3.832525] systemd[1]: Stopped Create System Files and Directories. test # [ 3.833074] systemd[1]: Stopped target Local File Systems. test # [ 3.833543] systemd[1]: Stopped target Preparation for Local File Systems. test # [ 3.834092] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. test # [ 3.834691] systemd[1]: Stopped Coldplug All udev Devices. test # [ 3.835191] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 3.835815] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.839425] systemd[1]: Stopped Virtual Console Setup. test # [ 3.843214] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.843846] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.844677] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 3.845272] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 3.845763] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.846312] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 3.846905] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 3.847495] systemd[1]: Closed udev Control Socket. test # [ 3.847901] systemd[1]: Starting Cleanup udev Database... test # [ 3.848943] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 3.849598] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 3.850123] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 3.850802] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 3.851380] systemd[1]: kmod-static-nodes.service: Deactivated successfully. test # [ 3.851946] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 3.871816] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 3.874002] systemd[1]: Finished Cleanup udev Database. test # [ 3.874481] systemd[1]: Reached target Switch Root. test # [ 3.875163] systemd[1]: Starting NixOS Activation... test # [ 4.069411] initrd-nixos-activation-start[179]: booting system configuration /nix/store/1yld3c5hx0gbc576caic5a44pr6ffiwf-nixos-system-test-test test # [ 4.131997] initrd-nixos-activation-start[179]: running activation script... second # [ 4.517693] systemd[1]: Mounting /sysroot/nix/store... second # [ 4.561443] systemd[1]: Mounted /sysroot/nix/store. second # [ 4.563191] systemd[1]: Reached target Initrd File Systems. test # [ 4.568752] initrd-nixos-activation-start[202]: setting up /etc... second # [ 4.566408] systemd[1]: Starting Find NixOS closure... second # [ 4.573523] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 4.618117] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 4.623553] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. second # [ 4.640666] systemd[1]: Finished Find NixOS closure. second # [ 4.643178] systemd[1]: Reached target Initrd Default Target. second # [ 4.648240] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... second # [ 4.677108] systemd[1]: Stopped target Initrd Default Target. second # [ 4.678810] systemd[1]: Stopped target Basic System. second # [ 4.680274] systemd[1]: Stopped target Initrd Root Device. second # [ 4.681567] systemd[1]: Stopped target Path Units. second # [ 4.684266] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. second # [ 4.685520] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 4.688213] systemd[1]: Stopped target Slice Units. second # [ 4.689815] systemd[1]: Stopped target Socket Units. second # [ 4.696110] systemd[1]: Stopped target System Initialization. second # [ 4.696857] systemd[1]: Stopped target Swaps. second # [ 4.697450] systemd[1]: Stopped target Timer Units. second # [ 4.698053] systemd[1]: dbus.socket: Deactivated successfully. second # [ 4.698742] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 4.699444] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. second # [ 4.700919] systemd[1]: Stopped Find NixOS closure. second # [ 4.701544] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 4.710842] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 4.711883] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 4.713843] systemd[1]: Stopped Apply Kernel Variables. second # [ 4.714495] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 4.715354] systemd[1]: Stopped Load Kernel Modules. second # [ 4.715958] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 4.725353] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 4.726321] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 4.727367] systemd[1]: Stopped Create System Files and Directories. second # [ 4.732965] systemd[1]: Stopped target Local File Systems. second # [ 4.733633] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 4.735323] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 4.738199] systemd[1]: Stopped Coldplug All udev Devices. second # [ 4.739500] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 4.745279] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 4.749255] systemd[1]: Stopped Virtual Console Setup. second # [ 4.749929] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 4.752185] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 4.754784] systemd[1]: initrd-cleanup.service: Deactivated successfully. second # [ 4.755856] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 4.757005] systemd[1]: systemd-udevd.service: Deactivated successfully. second # [ 4.760338] systemd[1]: Stopped Rule-based Manager for Device Events and Files. second # [ 4.761029] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. second # [ 4.761648] systemd[1]: Closed udev Control Socket. second # [ 4.762917] systemd[1]: Starting Cleanup udev Database... second # [ 4.763489] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. second # [ 4.766000] systemd[1]: Stopped Create Static Device Nodes in /dev. second # [ 4.766587] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 4.767390] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. second # [ 4.768154] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 4.768796] systemd[1]: Stopped Create List of Static Device Nodes. second # [ 4.769362] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 4.769993] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 4.789345] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. second # [ 4.791568] systemd[1]: Finished Cleanup udev Database. second # [ 4.792868] systemd[1]: Reached target Switch Root. second # [ 4.797029] systemd[1]: Starting NixOS Activation... test # [ 4.841250] initrd-nixos-activation-start[202]: setting up age secrets... second # [ 4.983912] initrd-nixos-activation-start[181]: booting system configuration /nix/store/sig1b3m5b75sija5blqd6yz3zhfcg0iw-nixos-system-second-test second # [ 5.052526] initrd-nixos-activation-start[181]: running activation script... test # [ 5.136274] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 5.137940] systemd[1]: Finished NixOS Activation. test # [ 5.138665] systemd[1]: Starting Switch Root... test # [ 5.152635] systemd[1]: Switching root. test # [ 5.320698] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). second # [ 5.519502] initrd-nixos-activation-start[204]: setting up /etc... second # [ 5.788154] initrd-nixos-activation-start[204]: setting up age secrets... test # [ 5.911629] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) test # [ 5.918157] systemd[1]: Detected virtualization qemu. test # [ 5.919780] systemd[1]: Detected architecture arm64. test # [ 5.921444] systemd[1]: Detected first boot. test # [ 5.927068] systemd[1]: Initializing machine ID from random generator. second # [ 6.014929] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 6.016709] systemd[1]: Finished NixOS Activation. second # [ 6.017410] systemd[1]: Starting Switch Root... second # [ 6.033235] systemd[1]: Switching root. second # [ 6.215937] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). test # [ 6.218763] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 6.403539] systemd[1]: Applying preset policy. second # [ 6.819033] systemd[1]: systemd 261 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) second # [ 6.822589] systemd[1]: Detected virtualization qemu. second # [ 6.823689] systemd[1]: Detected architecture arm64. second # [ 6.824800] systemd[1]: Detected first boot. second # [ 6.829288] systemd[1]: Initializing machine ID from random generator. test # [ 6.980098] systemd[1]: Populated /etc with preset unit settings. second # [ 7.093575] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 7.273066] systemd[1]: Applying preset policy. test # [ 7.547415] systemd[1]: initrd-switch-root.service: Deactivated successfully. test # [ 7.548257] systemd[1]: Stopped initrd-switch-root.service. test # [ 7.550398] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. test # [ 7.552863] systemd[1]: Created slice Slice /system/getty. test # [ 7.554094] systemd[1]: Created slice User and Session Slice. test # [ 7.554843] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 7.554940] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 7.554989] systemd[1]: Expecting device /dev/hvc0... test # [ 7.555004] systemd[1]: Expecting device /dev/ttyAMA0... test # [ 7.555034] systemd[1]: Reached target Local Encrypted Volumes. test # [ 7.555065] systemd[1]: Stopped target initrd-fs.target. test # [ 7.555572] systemd[1]: Stopped target initrd-root-fs.target. test # [ 7.555885] systemd[1]: Stopped target initrd-switch-root.target. test # [ 7.556181] systemd[1]: Reached target Virtual Machines and Containers. test # [ 7.556490] systemd[1]: Reached target Path Units. test # [ 7.556772] systemd[1]: Reached target Remote File Systems. test # [ 7.557066] systemd[1]: Reached target Slice Units. test # [ 7.557342] systemd[1]: Reached target Swaps. test # [ 7.566194] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 7.570873] systemd[1]: Listening on Process Core Dump Socket. test # [ 7.574570] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 7.578753] systemd[1]: Listening on Factory Reset Management. test # [ 7.579754] systemd[1]: Listening on Hostname Service Socket. test # [ 7.584654] systemd[1]: Starting Journal Log Access Socket... test # [ 7.586764] systemd[1]: Listening on Journal Audit Socket. test # [ 7.590911] systemd[1]: Listening on Console Output Muting Service Socket. test # [ 7.593227] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 7.595186] systemd[1]: Listening on Network Management Varlink Socket. test # [ 7.596283] systemd[1]: Listening on Network Management Netlink Socket. test # [ 7.597462] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. test # [ 7.598628] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os test # [ 7.600330] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki test # [ 7.610570] systemd[1]: Listening on Disk Repartitioning Service Socket. test # [ 7.611079] systemd[1]: Listening on Resolve Monitor Varlink Socket. test # [ 7.611436] systemd[1]: Listening on Resolve Service Varlink Socket. test # [ 7.611774] systemd[1]: Listening on udev Control Socket. test # [ 7.612121] systemd[1]: Listening on udev Varlink Socket. test # [ 7.617999] systemd[1]: Mounting Huge Pages File System... test # [ 7.621675] systemd[1]: Mounting POSIX Message Queue File System... test # [ 7.627044] systemd[1]: Mounting Kernel Debug File System... test # [ 7.635501] systemd[1]: Mounting Kernel Trace File System... test # [ 7.647254] systemd[1]: Starting Create List of Static Device Nodes... test # [ 7.657137] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 7.658857] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 7.671525] systemd[1]: Mounting Kernel Configuration File System... test # [ 7.674187] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm test # [ 7.678078] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore test # [ 7.691550] systemd[1]: Starting Load Kernel Module fuse... test # [ 7.693204] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 7.748737] systemd[1]: Starting Journal Service... test # [ 7.779634] systemd[1]: Starting Load Kernel Modules... test # [ 7.809626] fuse: init (API version 7.45) second # [ 7.812951] systemd[1]: Populated /etc with preset unit settings. test # [ 7.814397] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... test # [ 7.831179] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 7.835281] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 7.850086] systemd[1]: Starting Coldplug All udev Devices... test # [ 7.880892] systemd[1]: Listening on Journal Log Access Socket. test # [ 7.884515] systemd-journald[324]: Collecting audit messages is enabled. test # [ 7.886679] systemd[1]: Mounted Huge Pages File System. test # [ 7.887195] systemd[1]: Mounted POSIX Message Queue File System. test # [ 7.887634] systemd[1]: Mounted Kernel Debug File System. test # [ 7.888021] systemd[1]: Mounted Kernel Trace File System. test # [ 7.895962] systemd[1]: Finished Create List of Static Device Nodes. test # [ 7.899421] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 7.903103] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 7.898869] systemd[1]: Queued start job for default target Multi-User System. test # [ 7.900355] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 7.907805] systemd[1]: Started Journal Service. test # [ 7.907360] systemd-modules-load[325]: Module 'atkbd' is built in test # [ 7.910588] systemd-modules-load[325]: Module 'ctr' is built in test # [ 7.914292] systemd-modules-load[325]: Module 'loop' is built in test # [ 7.917747] systemd[1]: Mounted Kernel Configuration File System. test # [ 7.922329] systemd[1]: modprobe@fuse.service: Deactivated successfully. test # [ 7.924314] systemd[1]: Finished Load Kernel Module fuse. test # [ 7.927201] systemd[1]: Finished Load Kernel Modules. test # [ 7.933827] systemd[1]: Mounting FUSE Control File System... test # [ 7.938316] systemd[1]: Starting Firewall... test # [ 7.941807] systemd[1]: Starting Apply Kernel Variables... test # [ 7.974337] EXT4-fs (vda): re-mounted e4b92456-3df9-414d-b5aa-ad5a662d1ac1. test # [ 7.971684] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 7.980971] systemd-oomd[326]: No swap; memory pressure usage will be degraded test # [ 8.009854] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 8.016086] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 8.037529] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 8.046991] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 8.053766] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 8.057359] systemd[1]: Starting Load/Save OS Random Seed... test # [ 8.058842] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.114733] systemd[1]: Mounted FUSE Control File System. test # [ 8.122123] systemd[1]: Finished Apply Kernel Variables. test # [ 8.130226] systemd[1]: Starting Network Name Resolution... test # [ 8.149242] systemd-journald[324]: Received client request to flush runtime journal. test # [ 8.221081] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 8.228762] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 8.240292] systemd[1]: Finished Load/Save OS Random Seed. test # [ 8.240889] systemd[1]: Reached target First Boot Complete. test # [ 8.241383] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 8.305577] systemd-resolved[353]: Positive Trust Anchors: test # [ 8.308839] systemd-resolved[353]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 8.312579] systemd-resolved[353]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 test # [ 8.317917] systemd-resolved[353]: 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.345311] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 8.346194] systemd[1]: Reached target Preparation for Local File Systems. test # [ 8.347903] systemd[1]: Starting Rule-based Manager for Device Events and Files... second # [ 8.374363] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 8.375232] systemd[1]: Stopped initrd-switch-root.service. second # [ 8.377380] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 8.380233] systemd[1]: Created slice Slice /system/getty. second # [ 8.381181] systemd[1]: Created slice User and Session Slice. second # [ 8.381780] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 8.382143] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 8.382445] systemd[1]: Expecting device /dev/hvc0... second # [ 8.382719] systemd[1]: Expecting device /dev/ttyAMA0... second # [ 8.382995] systemd[1]: Reached target Local Encrypted Volumes. second # [ 8.383272] systemd[1]: Stopped target initrd-fs.target. second # [ 8.383545] systemd[1]: Stopped target initrd-root-fs.target. second # [ 8.383830] systemd[1]: Stopped target initrd-switch-root.target. second # [ 8.384110] systemd[1]: Reached target Virtual Machines and Containers. second # [ 8.384415] systemd[1]: Reached target Path Units. second # [ 8.384691] systemd[1]: Reached target Remote File Systems. second # [ 8.384954] systemd[1]: Reached target Slice Units. second # [ 8.390872] systemd[1]: Reached target Swaps. second # [ 8.394725] systemd[1]: Listening on Query the User Interactively for a Password. second # [ 8.399413] systemd[1]: Listening on Process Core Dump Socket. second # [ 8.403199] systemd[1]: Listening on Credential Encryption/Decryption. second # [ 8.406932] systemd[1]: Listening on Factory Reset Management. second # [ 8.408564] systemd[1]: Listening on Hostname Service Socket. second # [ 8.413681] systemd[1]: Starting Journal Log Access Socket... second # [ 8.415419] systemd[1]: Listening on Journal Audit Socket. second # [ 8.419265] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 8.420908] systemd[1]: Listening on Network Management Metrics Varlink Socket. second # [ 8.422617] systemd[1]: Listening on Network Management Varlink Socket. second # [ 8.424430] systemd[1]: Listening on Network Management Netlink Socket. second # [ 8.426229] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 8.427882] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 8.430225] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 8.440538] systemd[1]: Listening on Disk Repartitioning Service Socket. test # [ 8.436847] systemd-udevd[365]: Using default interface naming scheme 'v261'. second # [ 8.442276] systemd[1]: Listening on Resolve Monitor Varlink Socket. second # [ 8.443823] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 8.445428] systemd[1]: Listening on udev Control Socket. second # [ 8.447232] systemd[1]: Listening on udev Varlink Socket. second # [ 8.451145] systemd[1]: Mounting Huge Pages File System... second # [ 8.455069] systemd[1]: Mounting POSIX Message Queue File System... second # [ 8.465824] systemd[1]: Mounting Kernel Debug File System... second # [ 8.475348] systemd[1]: Mounting Kernel Trace File System... second # [ 8.481769] systemd[1]: Starting Create List of Static Device Nodes... second # [ 8.494865] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 8.496345] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 8.505400] systemd[1]: Mounting Kernel Configuration File System... second # [ 8.507256] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 8.510662] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore second # [ 8.523487] systemd[1]: Starting Load Kernel Module fuse... second # [ 8.526731] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 8.551723] systemd[1]: Mounting /run/wrappers... second # [ 8.567556] systemd[1]: Starting Journal Service... test # [ 8.579652] systemd-resolved[353]: Using system hostname 'test'. second # [ 8.591609] systemd[1]: Starting Load Kernel Modules... test # [ 8.590522] systemd[1]: Started Network Name Resolution. second # [ 8.612255] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... test # [ 8.619817] systemd[1]: Mounted /run/wrappers. test # [ 8.621359] systemd[1]: Reached target Local File Systems. test # [ 8.626586] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 8.634200] fuse: init (API version 7.45) second # [ 8.634993] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 8.631919] systemd[1]: Starting register-nix-paths.service... second # [ 8.637427] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.635505] systemd[1]: Starting Create SUID/SGID Wrappers... test # [ 8.639682] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 8.659247] systemd[1]: Starting Coldplug All udev Devices... test # [ 8.668180] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 8.674602] systemd[1]: Listening on Journal Log Access Socket. test # [ 8.675124] systemd[1]: Starting Create System Files and Directories... second # [ 8.694982] systemd[1]: Mounted Huge Pages File System. second # [ 8.697553] systemd[1]: Mounted POSIX Message Queue File System. second # [ 8.699666] systemd[1]: Mounted Kernel Debug File System. second # [ 8.704596] systemd[1]: Mounted Kernel Trace File System. second # [ 8.708097] systemd[1]: Finished Create List of Static Device Nodes. second # [ 8.711089] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 8.715013] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 8.719509] systemd[1]: Mounted Kernel Configuration File System. second # [ 8.720097] systemd[1]: modprobe@fuse.service: Deactivated successfully. second # [ 8.722158] systemd[1]: Finished Load Kernel Module fuse. second # [ 8.723599] systemd[1]: Finished Load Kernel Modules. second # [ 8.733941] systemd[1]: Mounting FUSE Control File System... second # [ 8.735641] systemd-journald[304]: Collecting audit messages is enabled. second # [ 8.740957] systemd[1]: Queued start job for default target Multi-User System. second # [ 8.751143] EXT4-fs (vda): re-mounted 76eb3747-16b5-488f-93cc-511006339cf1. second # [ 8.752537] systemd[1]: Starting Firewall... second # [ 8.745385] systemd[1]: systemd-journald.service: Deactivated successfully. second # [ 8.749439] systemd-modules-load[305]: Module 'atkbd' is built in second # [ 8.751813] systemd-modules-load[305]: Module 'ctr' is built in second # [ 8.757203] systemd-modules-load[305]: Module 'loop' is built in second # [ 8.769511] systemd[1]: Starting Apply Kernel Variables... test # [ 8.770717] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 8.789422] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 8.802035] systemd[1]: Started Journal Service. test # [ 8.804518] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. test # [ 8.808645] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 8.808900] systemd-oomd[306]: No swap; memory pressure usage will be degraded second # [ 8.819615] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 8.825866] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. second # [ 8.863255] systemd[1]: Listening on Disk Image Download Service Socket. second # [ 8.874786] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 8.878151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 8.886265] systemd[1]: Finished Create System Files and Directories. second # [ 8.883422] systemd[1]: Starting Load/Save OS Random Seed... second # [ 8.889642] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.910471] systemd[1]: Starting Rebuild Journal Catalog... second # [ 8.906855] systemd[1]: Mounted FUSE Control File System. test # [ 8.913278] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 8.938211] systemd[1]: Finished Apply Kernel Variables. second # [ 8.950660] systemd[1]: Starting Network Name Resolution... second # [ 8.974263] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 8.987667] systemd-journald[304]: Received client request to flush runtime journal. test # [ 9.048913] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 9.045759] systemd[1]: Finished Load/Save OS Random Seed. second # [ 9.046601] systemd[1]: Reached target First Boot Complete. second # [ 9.058076] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 9.060838] systemd[1]: Finished Flush Journal to Persistent Storage. second # [ 9.120050] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 9.120704] systemd[1]: Reached target Preparation for Local File Systems. test # [ 9.128744] systemd[1]: Finished Rebuild Journal Catalog. second # [ 9.126189] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 9.136760] systemd[1]: Starting Update is Completed... second # [ 9.149529] systemd-resolved[333]: Positive Trust Anchors: second # [ 9.153356] systemd-resolved[333]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d second # [ 9.154696] systemd-resolved[333]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 second # [ 9.158769] systemd-resolved[333]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test test # [ 9.180292] systemd[1]: Finished Coldplug All udev Devices. test # [ 9.206469] systemd[1]: Finished Update is Completed. second # [ 9.261395] systemd-udevd[346]: Using default interface naming scheme 'v261'. test # [ 9.366161] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 9.380946] systemd[1]: Mounting /run/wrappers... second # [ 9.404306] systemd-resolved[333]: Using system hostname 'second'. second # [ 9.414326] systemd[1]: Started Network Name Resolution. second # [ 9.442215] systemd[1]: Mounted /run/wrappers. second # [ 9.444705] systemd[1]: Reached target Local File Systems. second # [ 9.449196] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 9.456126] systemd[1]: Starting register-nix-paths.service... second # [ 9.459634] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 9.464184] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 9.474710] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 9.492377] systemd[1]: Starting Create System Files and Directories... second # [ 9.581208] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. second # [ 9.590711] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 9.598065] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 9.599803] systemd[1]: Finished Create SUID/SGID Wrappers. second # [ 9.604288] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 9.638220] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 9.685552] systemd[1]: Finished Create System Files and Directories. second # [ 9.695574] systemd[1]: Starting Rebuild Journal Catalog... second # [ 9.698852] systemd[1]: Starting Record System Boot/Shutdown in UTMP... test # [ 9.717261] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. second # [ 9.807778] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 9.827871] systemd[1]: Finished Coldplug All udev Devices. second # [ 9.861236] systemd[1]: Finished Rebuild Journal Catalog. second # [ 9.868341] systemd[1]: Starting Update is Completed... test # [ 9.909655] systemd[1]: Finished register-nix-paths.service. test # [ 9.911037] systemd[1]: Reached target System Initialization. test # [ 9.914967] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 9.917301] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 9.921234] systemd[1]: Reached target Timer Units. test # [ 9.922293] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 9.924235] systemd[1]: Listening on Nix Daemon Socket. test # [ 9.928841] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 9.930865] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. test # [ 9.933569] systemd[1]: Reached target Socket Units. test # [ 9.936207] systemd[1]: Starting D-Bus System Message Bus... second # [ 9.934379] systemd[1]: Finished Update is Completed. test # [ 9.957215] systemd[1]: Finished Firewall. test # [ 9.958993] systemd[1]: Reached target Preparation for Network. test # [ 9.961802] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 9.966029] systemd[1]: Starting Network Management... test # [ 10.012084] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.027254] (udev-worker)[405]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.055824] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 10.136053] dbus-broker-launch[546]: Looking up NSS user entry for 'systemd-timesync'... test # [ 10.151659] dbus-broker-launch[546]: NSS returned no entry for 'systemd-timesync' test # [ 10.152515] dbus-broker-launch[546]: Invalid user-name in /nix/store/cn4zwjv26idrz8m4kyyvim8cqky73zxq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 10.200965] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 10.224194] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 10.226497] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' test # [ 10.230294] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/q3gr23jczqdkab4ynasfyv5pk0907sly-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'[ 10.241218] mousedev: PS/2 mouse device common for all mice test # test # [ 10.237148] dbus-broker-launch[546]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/50h0k21qqr8489rim5ww9gp74lvl1i34-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' test # [ 10.250978] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 10.251525] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' test # [ 10.249514] systemd[1]: Started D-Bus System Message Bus. test # [ 10.298727] dbus-broker-launch[546]: Ready test # [ 10.299544] systemd[1]: Reached target Basic System. test # [ 10.303266] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 10.306224] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 10.317891] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 10.318161] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 10.328064] systemd-networkd[548]: /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 # [ 10.333352] systemd-networkd[548]: /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 # [ 10.340223] systemd-networkd[548]: lo: Link UP test # [ 10.340647] systemd-networkd[548]: lo: Gained carrier second # [ 10.347243] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 10.352413] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 10.350358] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 10.361043] systemd-networkd[548]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 10.365327] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 10.364386] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. test # [ 10.372587] systemd-networkd[548]: eth1: Link UP test # [ 10.373181] systemd-networkd[548]: eth1: Gained carrier test # [ 10.373746] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 10.380347] systemd[1]: Starting Network Manager... test # [ 10.401582] systemd[1]: Started backdoor.service. test # [ 10.435829] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 10.455887] bfrwvyg79my69yafr053q6bzx4lix24v-wifi-secrets[559]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 10.468867] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 10.502562] systemd[1]: Starting Post-Boot Actions... test # [ 10.508780] 6zad8qjsgcihj3d5ws39j6s93s5yrjm7-wifi-secrets[560]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 10.535405] systemd[1]: Started Reset console on configuration changes. test # [ 10.541465] systemd[1]: Started Network Management. test # [ 10.548380] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. test # [ 10.558374] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 10.568386] vx4skfrgyqk0f8j1mp5lv936zif6nn10-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 10.581057] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test # [ 10.587520] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 10.604686] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. test # [ 10.610013] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # connecting to host... second # [ 10.668209] (udev-worker)[445]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.672584] (udev-worker)[442]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.681756] systemd[1]: Finished Post-Boot Actions. test: Guest shell says: b'Spawning backdoor root shell...\n' second # [ 10.706904] systemd[1]: Finished Firewall. test # [ 10.711019] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # [ 10.707745] systemd[1]: Reached target Preparation for Network. test # [ 10.724886] nsncd[566]: Jul 27 00:15:15.547 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test: connected to guest root shell second # [ 10.710058] systemd[1]: Listening on Network Management Resolve Hook Socket. test: (connecting took 11.12 seconds) test # [ 10.731960] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 10.716415] systemd[1]: Starting Network Management... test # [ 10.740640] systemd[1]: Finished Import lastlog data into lastlog2 database. second # [ 10.717712] systemd[1]: Finished register-nix-paths.service. test # [ 10.752318] systemd[1]: Reached target Host and Network Name Lookups. second # [ 10.718932] systemd[1]: Reached target System Initialization. test # [ 10.752988] systemd[1]: Reached target User and Group Name Lookups. second # [ 10.720491] systemd[1]: Started Discard unused filesystem blocks once a week. test: (finished: waiting for the VM to finish booting, in 11.12 seconds) second # [ 10.724997] systemd[1]: Started Daily Cleanup of Temporary Directories. second # [ 10.725553] systemd[1]: Reached target Timer Units. second # [ 10.726843] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 10.727405] systemd[1]: Listening on Nix Daemon Socket. second # [ 10.739322] systemd[1]: Listening on Authorization Manager Agent Helper. second # [ 10.742161] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. second # [ 10.742992] systemd[1]: Reached target Socket Units. second # [ 10.746325] systemd[1]: Starting D-Bus System Message Bus... test # [ 10.761843] systemd[1]: Starting User Login Management... test # [ 10.765324] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 10.837958] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. second # [ 10.854986] mousedev: PS/2 mouse device common for all mice second # [ 10.909175] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'... test # [ 10.927032] systemd[1]: Starting Hostname Service... test # [ 10.932486] systemd-logind[607]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) test # [ 10.933291] systemd-logind[607]: Watching system buttons on /dev/input/event0 (gpio-keys) test # [ 10.933943] systemd-logind[607]: New seat seat0. second # [ 10.941848] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 10.942173] systemd[1]: Started User Login Management. second # [ 10.938939] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync' second # [ 10.939740] dbus-broker-launch[530]: Invalid user-name in /nix/store/cn4zwjv26idrz8m4kyyvim8cqky73zxq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 10.952731] systemd[1]: Starting linger-users.service... second # [ 10.983341] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' second # [ 10.983848] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 10.996562] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' second # [ 10.998984] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/xgs4xjlwr0cqq20q5pf50b6rh69dp7yp-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 11.003028] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/q3gr23jczqdkab4ynasfyv5pk0907sly-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' second # [ 11.006789] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/50h0k21qqr8489rim5ww9gp74lvl1i34-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 11.015336] systemd[1]: Started D-Bus System Message Bus. test # [ 11.034416] systemd[1]: linger-users.service: Deactivated successfully. test # [ 11.040687] systemd[1]: Finished linger-users.service. second # [ 11.049167] systemd-networkd[528]: /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.057466] systemd[1]: Started Hostname Service. second # [ 11.056050] systemd-networkd[528]: /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 # [ 11.064834] systemd-networkd[528]: lo: Link UP second # [ 11.065461] systemd-networkd[528]: lo: Gained carrier second # [ 11.066870] systemd-networkd[528]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 11.072793] systemd-networkd[528]: eth1: Configuring with /etc/systemd/network/40-eth1.network. second # [ 11.076392] dbus-broker-launch[530]: Ready second # [ 11.080200] systemd[1]: Started Network Management. second # [ 11.081783] systemd[1]: Reached target Basic System. second # [ 11.084111] systemd-networkd[528]: eth1: Link UP second # [ 11.085712] systemd-networkd[528]: eth1: Gained carrier second # [ 11.086679] systemd-networkd[528]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # [ 11.093676] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 11.094707] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 11.107863] systemd[1]: Starting Network Manager... second # [ 11.121892] systemd[1]: Started backdoor.service. second # [ 11.146771] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 11.159129] systemd-networkd[548]: eth0: Link UP test # [ 11.159589] systemd-networkd[548]: eth0: Gained carrier second # [ 11.157873] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 11.179416] systemd[1]: Started Network Manager. second # [ 11.178010] systemd[1]: Starting Post-Boot Actions... test # [ 11.183181] systemd[1]: Reached target Network. test # [ 11.187997] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... test # [ 11.199709] systemd[1]: Starting Permit User Sessions... second # [ 11.213371] systemd[1]: Started Reset console on configuration changes. second # [ 11.239045] bfrwvyg79my69yafr053q6bzx4lix24v-wifi-secrets[539]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 11.250138] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # connecting to host... second # [ 11.287391] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 11.294407] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 11.343686] systemd[1]: Finished Permit User Sessions. test # [ 11.363186] systemd[1]: Started Getty on tty1. second # [ 11.363347] systemd[1]: Finished Post-Boot Actions. test # [ 11.370374] systemd[1]: Reached target Login Prompts. second # [ 11.395256] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 11.403821] systemd-resolved[353]: eth0: Bus client set default route setting: yes test # [ 11.409544] systemd-resolved[353]: eth0: Bus client set DNS server list to: 10.0.2.3 second # [ 11.408634] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 11.411055] systemd[1]: Reached target Host and Network Name Lookups. second # [ 11.417394] nsncd[544]: Jul 27 00:15:16.227 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 11.418506] systemd[1]: Reached target User and Group Name Lookups. test # [ 11.425490] NetworkManager[562]: [1785111316.2445] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 11.424430] systemd[1]: Starting User Login Management... test # [ 11.427300] NetworkManager[562]: [1785111316.2467] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 11.452081] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 11.483188] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. test # [ 11.484774] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. second # [ 11.479635] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 11.493698] systemd[1]: Reached target Multi-User System. test # [ 11.500625] systemd[1]: Startup finished in 751ms (kernel) + 4.661s (initrd) + 6.087s (userspace) = 11.500s. second # [ 11.569091] systemd[1]: Starting Hostname Service... second # [ 11.570947] systemd-logind[572]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) second # [ 11.577653] systemd-logind[572]: Watching system buttons on /dev/input/event0 (gpio-keys) second # [ 11.578327] systemd-logind[572]: New seat seat0. second # [ 11.581131] systemd[1]: Started User Login Management. second # [ 11.592245] systemd[1]: Starting linger-users.service... second # [ 11.667052] systemd[1]: linger-users.service: Deactivated successfully. second # [ 11.667668] systemd[1]: Finished linger-users.service. second # [ 11.701939] systemd[1]: Started Hostname Service. test # [ 11.777620] systemd-networkd[548]: eth1: Gained IPv6LL second # [ 11.794207] systemd-networkd[528]: eth0: Link UP second # [ 11.794657] systemd-networkd[528]: eth0: Gained carrier second # [ 11.812204] systemd[1]: Started Network Manager. second # [ 11.815433] systemd[1]: Reached target Network. second # [ 11.822720] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 11.827941] systemd[1]: Starting Permit User Sessions... second # [ 11.981516] systemd[1]: Finished Permit User Sessions. test: (finished: waiting for unit NetworkManager.service, in 12.35 seconds) test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection second # [ 12.001053] systemd[1]: Started Getty on tty1. second # [ 12.001820] systemd[1]: Reached target Login Prompts. test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds) cleanup kill QemuMachine (pid 47) second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) test # [ 12.079358] 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/ymm5c1kb7p2r6331bgcdxijayqhcbvqy-python3-3.14.6/bin/python3.14) (finished: cleanup, in 0.27 seconds) Traceback (most recent call last): File "/nix/store/p9f9jwakj2jislw4xxhxcw5sx05pqxq1-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in sys.exit(main()) ~~~~^^ File "/nix/store/p9f9jwakj2jislw4xxhxcw5sx05pqxq1-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/__init__.py", line 194, in main driver.run_tests() ~~~~~~~~~~~~~~~~^^ File "/nix/store/p9f9jwakj2jislw4xxhxcw5sx05pqxq1-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 434, in run_tests self.test_script() ~~~~~~~~~~~~~~~~^^ File "/nix/store/p9f9jwakj2jislw4xxhxcw5sx05pqxq1-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/driver.py", line 392, in test_script exec(self.tests, symbols, None) ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "", line 4, in AssertionError: Expected mock password in connection file: [connection] autoconnect=true id= type=wifi [wifi] mode=infrastructure ssid= [wifi-security] key-mgmt=wpa-psk psk=