Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600.0 seconds run the VM test script additionally exposed symbols: second, test, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh start all VMs second: starting vm test: starting vm test # Disk image does not exist, creating the virtualisation disk image... test: QEMU running (pid 48) test # Formatting '/build/vm-state-test/tmp.F48H2apCNs', fmt=raw size=1073741824 test # mke2fs 1.47.4 (6-Mar-2025) test # Discarding device blocks: 0/262144 done test # Creating filesystem with 262144 4k blocks and 65536 inodes test # Filesystem UUID: 1d24170d-8a37-4a40-8e4b-102d7a38e927 test # Superblock backups stored on blocks: test # 32768, 98304, 163840, 229376 test # test # Allocating group tables: 0/8 done test # Writing inode tables: 0/8 done test # Creating journal (8192 blocks): done test # Writing superblocks and filesystem accounting information: 0/8 done test # test # Virtualisation disk image created. second # Disk image does not exist, creating the virtualisation disk image... second # Formatting '/build/vm-state-second/tmp.DdB2ce2lPY', fmt=raw size=1073741824 second # mke2fs 1.47.4 (6-Mar-2025) second # Discarding device blocks: 0/262144 done second # Creating filesystem with 262144 4k blocks and 65536 inodes second # Filesystem UUID: 90ee2e54-7f24-49bb-bdab-c44d8cb03200 second # Superblock backups stored on blocks: second # 32768, 98304, 163840, 229376 second # second # Allocating group tables: 0/8 done second # Writing inode tables: 0/8 done second # Creating journal (8192 blocks): done second # Writing superblocks and filesystem accounting information: 0/8 done second # second # Virtualisation disk image created. second: QEMU running (pid 47) (finished: start all VMs, in 0.57 seconds) test: waiting for unit NetworkManager.service test: waiting for the VM to finish booting test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] test # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 test # [ 0.000000] KASLR enabled test # [ 0.000000] random: crng init done test # [ 0.000000] Machine model: linux,dummy-virt test # [ 0.000000] efi: UEFI not found. test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f] test # [ 0.000000] Zone ranges: test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] DMA32 empty test # [ 0.000000] Normal empty test # [ 0.000000] Device empty test # [ 0.000000] Movable zone start for each node test # [ 0.000000] Early memory node ranges test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 test # [ 0.000000] psci: probing for conduit method from DT. test # [ 0.000000] psci: PSCIv1.3 detected in firmware. test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs test # [ 0.000000] psci: Trusted OS migration not required test # [ 0.000000] psci: SMC Calling Convention v1.1 test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) test # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 test # [ 0.000000] Detected PIPT I-cache on CPU0 test # [ 0.000000] CPU features: detected: GICv3 CPU interface test # [ 0.000000] CPU features: detected: Spectre-v4 test # [ 0.000000] CPU features: detected: Spectre-BHB test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) test # [ 0.000000] CPU features: detected: ARM erratum 1418040 test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing test # [ 0.000000] alternatives: applying boot alternatives 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/sjzkqkvigxashyj0my0zc7w0nmrs31a6-nixos-system-test-test/init regInfo=/nix/store/qy5h9wy7ydhhbc5zxkyq0jzv7bbvjn7b-closure-info/registration console=ttyAMA0,115200n8 console=tty0 test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/qy5h9wy7ydhhbc5zxkyq0jzv7bbvjn7b-closure-info/registration", will be passed to user space. test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB test # [ 0.000000] software IO TLB: area num 1. test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) test # [ 0.000000] Fallback order for Node 0: 0 test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 test # [ 0.000000] Policy zone: DMA 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 test # [ 0.000000] allocated 2097152 bytes of page_ext test # [ 0.000000] ftrace: allocating 74885 entries in 294 pages test # [ 0.000000] ftrace: allocated 294 pages with 4 groups test # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.000000] rcu: RCU event tracing is enabled. 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. test # [ 0.000000] Rude variant of Tasks RCU enabled. test # [ 0.000000] Tracing variant of Tasks RCU enabled. test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. 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 test # [ 0.000000] GICv3: 256 SPIs implemented test # [ 0.000000] GICv3: 0 Extended SPIs implemented test # [ 0.000000] Root IRQ handler: gic_handle_irq test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns test # [ 0.000058] arm-pv: using stolen time PV test # [ 0.000407] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.000700] Console: colour dummy device 80x25 second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] test # [ 0.000713] printk: legacy console [tty0] enabled test # [ 0.000942] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) second # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 test # [ 0.000948] pid_max: default: 32768 minimum: 301 second # [ 0.000000] KASLR enabled second # [ 0.000000] random: crng init done test # [ 0.001021] LSM: initializing lsm=capability,landlock,yama,bpf,ima second # [ 0.000000] Machine model: linux,dummy-virt test # [ 0.001160] landlock: Up and running. second # [ 0.000000] efi: UEFI not found. test # [ 0.001162] Yama: becoming mindful. test # [ 0.001668] LSM support for eBPF active second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT test # [ 0.001826] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07700-0x7fc0ae7f] second # [ 0.000000] Zone ranges: test # [ 0.001848] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.003851] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.000000] DMA32 empty test # [ 0.004750] rcu: Hierarchical SRCU implementation. second # [ 0.000000] Normal empty second # [ 0.000000] Device empty test # [ 0.004756] rcu: Max phase no-delay instances is 1000. second # [ 0.000000] Movable zone start for each node test # [ 0.006007] fsl-mc MSI: its@8080000 domain created second # [ 0.000000] Early memory node ranges test # [ 0.006179] EFI services will not be available. second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] test # [ 0.006280] smp: Bringing up secondary CPUs ... test # [ 0.006310] smp: Brought up 1 node, 1 CPU test # [ 0.006313] SMP: Total of 1 processors activated. second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000 test # [ 0.006315] CPU: All CPU(s) started at EL1 second # [ 0.000000] psci: probing for conduit method from DT. test # [ 0.006328] CPU features: detected: 32-bit EL0 Support second # [ 0.000000] psci: PSCIv1.3 detected in firmware. second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs test # [ 0.006331] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.000000] psci: Trusted OS migration not required test # [ 0.006334] CPU features: detected: Common not Private translations second # [ 0.000000] psci: SMC Calling Convention v1.1 test # [ 0.006336] CPU features: detected: CRC32 instructions second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) test # [ 0.006338] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 test # [ 0.006341] CPU features: detected: Enhanced Virtualization Traps second # [ 0.000000] Detected PIPT I-cache on CPU0 test # [ 0.006352] CPU features: detected: RCpc load-acquire (LDAPR) second # [ 0.000000] CPU features: detected: GICv3 CPU interface test # [ 0.006354] CPU features: detected: LSE atomic instructions second # [ 0.000000] CPU features: detected: Spectre-v4 second # [ 0.000000] CPU features: detected: Spectre-BHB test # [ 0.006356] CPU features: detected: Privileged Access Never test # [ 0.006358] CPU features: detected: PMUv3 second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR test # [ 0.006360] CPU features: detected: RAS Extension Support second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) test # [ 0.006363] CPU features: detected: Speculative Store Bypassing Safe (SSBS) second # [ 0.000000] CPU features: detected: ARM erratum 1418040 test # [ 0.006392] alternatives: applying system-wide alternatives second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion test # [ 0.007910] CPU features: detected: Hardware dirty bit management on CPU0 second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing second # [ 0.000000] alternatives: applying boot alternatives test # [ 0.008166] Memory: 891464K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 115780K reserved, 32768K cma-reserved) test # [ 0.008651] devtmpfs: initialized test # [ 0.010260] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.010286] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). 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/k0jyhgd8hlg45n6j1wxm655ldxygdjlr-nixos-system-second-test/init regInfo=/nix/store/59qdsxgfdlmvyg8j7ax3458mzd5b75vc-closure-info/registration console=ttyAMA0,115200n8 console=tty0 test # [ 0.010437] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL test # [ 0.010442] 0 pages in range for non-PLT usage test # [ 0.010442] 508288 pages in range for PLT usage second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/59qdsxgfdlmvyg8j7ax3458mzd5b75vc-closure-info/registration", will be passed to user space. test # [ 0.010581] pinctrl core: initialized pinctrl subsystem test # [ 0.011454] DMI not present or invalid. second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes test # [ 0.015338] NET: Registered PF_NETLINK/PF_ROUTE protocol family second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) test # [ 0.018084] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) test # [ 0.018230] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB test # [ 0.018388] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.000000] software IO TLB: area num 1. test # [ 0.018414] audit: initializing netlink subsys (disabled) second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB) test # [ 0.019072] thermal_sys: Registered thermal governor 'fair_share' second # [ 0.000000] Fallback order for Node 0: 0 test # [ 0.019075] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 second # [ 0.000000] Policy zone: DMA test # [ 0.019078] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.019080] thermal_sys: Registered thermal governor 'user_space' second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off test # [ 0.019082] thermal_sys: Registered thermal governor 'power_allocator' second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 second # [ 0.000000] allocated 2097152 bytes of page_ext test # [ 0.019124] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 second # [ 0.000000] ftrace: allocating 74885 entries in 294 pages test # [ 0.019141] cpuidle: using governor ladder test # [ 0.019146] cpuidle: using governor menu second # [ 0.000000] ftrace: allocated 294 pages with 4 groups second # [ 0.000000] rcu: Hierarchical RCU implementation. test # [ 0.019291] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. second # [ 0.000000] rcu: RCU event tracing is enabled. test # [ 0.019315] ASID allocator initialised with 32768 entries second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. test # [ 0.019989] Serial: AMBA PL011 UART driver second # [ 0.000000] Trampoline variant of Tasks RCU enabled. test # [ 0.023417] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 second # [ 0.000000] Rude variant of Tasks RCU enabled. test # [ 0.023571] printk: console [ttyAMA0] enabled second # [ 0.000000] Tracing variant of Tasks RCU enabled. second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 second # [ 0.000000] GICv3: 256 SPIs implemented second # [ 0.000000] GICv3: 0 Extended SPIs implemented second # [ 0.000000] Root IRQ handler: gic_handle_irq second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) test # [ 0.097777] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) test # [ 0.097795] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 test # [ 0.097802] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 test # [ 0.097806] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. test # [ 0.097809] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages test # [ 0.097812] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns test # [ 0.097816] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040 test # [ 0.097819] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt). second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns second # [ 0.000059] arm-pv: using stolen time PV test # [ 0.103346] fbcon: Taking over console test # [ 0.103369] ACPI: Interpreter disabled. second # [ 0.000436] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) test # [ 0.104729] iommu: Default domain type: Translated second # [ 0.000705] Console: colour dummy device 80x25 test # [ 0.104742] iommu: DMA domain TLB invalidation policy: strict mode second # [ 0.000719] printk: legacy console [tty0] enabled test # [ 0.106005] SCSI subsystem initialized second # [ 0.000961] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000) second # [ 0.000967] pid_max: default: 32768 minimum: 301 second # [ 0.001040] LSM: initializing lsm=capability,landlock,yama,bpf,ima test # [ 0.106607] usbcore: registered new interface driver usbfs second # [ 0.001190] landlock: Up and running. test # [ 0.106641] usbcore: registered new interface driver hub second # [ 0.001193] Yama: becoming mindful. test # [ 0.106653] usbcore: registered new device driver usb second # [ 0.001621] LSM support for eBPF active test # [ 0.106874] pps_core: LinuxPPS API ver. 1 registered second # [ 0.001809] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.106881] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti second # [ 0.001831] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) test # [ 0.106888] PTP clock support registered test # [ 0.106930] EDAC MC: Ver: 3.0.0 second # [ 0.003780] cacheinfo: Unable to detect cache hierarchy for CPU 0 second # [ 0.004682] rcu: Hierarchical SRCU implementation. test # [ 0.110275] scmi_core: SCMI protocol bus registered second # [ 0.004688] rcu: Max phase no-delay instances is 1000. second # [ 0.005749] fsl-mc MSI: its@8080000 domain created second # [ 0.005909] EFI services will not be available. test # [ 0.111048] FPGA manager framework second # [ 0.005999] smp: Bringing up secondary CPUs ... second # [ 0.006028] smp: Brought up 1 node, 1 CPU second # [ 0.006031] SMP: Total of 1 processors activated. second # [ 0.006033] CPU: All CPU(s) started at EL1 second # [ 0.006046] CPU features: detected: 32-bit EL0 Support second # [ 0.006049] CPU features: detected: Data cache clean to the PoU not required for I/D coherence second # [ 0.006052] CPU features: detected: Common not Private translations second # [ 0.006054] CPU features: detected: CRC32 instructions second # [ 0.006056] CPU features: detected: Data cache clean to Point of Persistence second # [ 0.006059] CPU features: detected: Enhanced Virtualization Traps second # [ 0.006069] CPU features: detected: RCpc load-acquire (LDAPR) second # [ 0.006071] CPU features: detected: LSE atomic instructions second # [ 0.006073] CPU features: detected: Privileged Access Never second # [ 0.006075] CPU features: detected: PMUv3 second # [ 0.006077] CPU features: detected: RAS Extension Support test # [ 0.117910] vgaarb: loaded second # [ 0.006081] CPU features: detected: Speculative Store Bypassing Safe (SSBS) second # [ 0.006113] alternatives: applying system-wide alternatives test # [ 0.118471] clocksource: Switched to clocksource arch_sys_counter second # [ 0.007740] CPU features: detected: Hardware dirty bit management on CPU0 second # [ 0.007967] Memory: 891480K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 115784K reserved, 32768K cma-reserved) second # [ 0.008551] devtmpfs: initialized second # [ 0.010136] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.010161] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). second # [ 0.010310] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL second # [ 0.010314] 0 pages in range for non-PLT usage second # [ 0.010314] 508288 pages in range for PLT usage second # [ 0.010450] pinctrl core: initialized pinctrl subsystem second # [ 0.011234] DMI not present or invalid. second # [ 0.014853] NET: Registered PF_NETLINK/PF_ROUTE protocol family second # [ 0.017738] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations second # [ 0.017882] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations second # [ 0.018036] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations second # [ 0.018060] audit: initializing netlink subsys (disabled) second # [ 0.018697] thermal_sys: Registered thermal governor 'fair_share' second # [ 0.018699] thermal_sys: Registered thermal governor 'bang_bang' second # [ 0.018703] thermal_sys: Registered thermal governor 'step_wise' test # [ 0.127806] VFS: Disk quotas dquot_6.6.0 second # [ 0.018705] thermal_sys: Registered thermal governor 'user_space' second # [ 0.018707] thermal_sys: Registered thermal governor 'power_allocator' test # [ 0.127858] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) second # [ 0.018730] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 test # [ 0.129156] netfs: FS-Cache loaded test # [ 0.129310] pnp: PnP ACPI: disabled second # [ 0.018745] cpuidle: using governor ladder second # [ 0.018750] cpuidle: using governor menu second # [ 0.018883] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. second # [ 0.018906] ASID allocator initialised with 32768 entries second # [ 0.019565] Serial: AMBA PL011 UART driver second # [ 0.022878] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 second # [ 0.023064] printk: console [ttyAMA0] enabled test # [ 0.131864] NET: Registered PF_INET protocol family test # [ 0.132283] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) second # [ 0.097551] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages second # [ 0.097570] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page second # [ 0.097577] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages second # [ 0.097580] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page second # [ 0.097584] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages second # [ 0.097587] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page second # [ 0.097590] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages second # [ 0.097593] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page second # [ 0.102753] fbcon: Taking over console second # [ 0.102782] ACPI: Interpreter disabled. second # [ 0.109292] iommu: Default domain type: Translated second # [ 0.109308] iommu: DMA domain TLB invalidation policy: strict mode second # [ 0.109678] SCSI subsystem initialized second # [ 0.111129] usbcore: registered new interface driver usbfs second # [ 0.111166] usbcore: registered new interface driver hub second # [ 0.111179] usbcore: registered new device driver usb second # [ 0.111389] pps_core: LinuxPPS API ver. 1 registered second # [ 0.111395] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti second # [ 0.111401] PTP clock support registered second # [ 0.111432] EDAC MC: Ver: 3.0.0 second # [ 0.114647] scmi_core: SCMI protocol bus registered second # [ 0.115403] FPGA manager framework second # [ 0.116382] vgaarb: loaded second # [ 0.116820] clocksource: Switched to clocksource arch_sys_counter test # [ 0.157894] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) test # [ 0.157930] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) test # [ 0.157944] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) test # [ 0.157981] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.126658] VFS: Disk quotas dquot_6.6.0 test # [ 0.158049] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.126700] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) test # [ 0.158154] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) second # [ 0.129296] netfs: FS-Cache loaded test # [ 0.158184] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.129433] pnp: PnP ACPI: disabled test # [ 0.158255] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) test # [ 0.158381] NET: Registered PF_UNIX/PF_LOCAL protocol family test # [ 0.158419] NET: Registered PF_XDP protocol family test # [ 0.158445] PCI: CLS 0 bytes, default 64 test # [ 0.158582] Trying to unpack rootfs image as initramfs... second # [ 0.131953] NET: Registered PF_INET protocol family second # [ 0.132167] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) test # [ 0.172854] kvm [1]: HYP mode not available second # [ 0.158515] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) second # [ 0.158551] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) second # [ 0.158567] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) second # [ 0.158605] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) second # [ 0.158673] TCP: Hash tables configured (established 8192 bind 8192) second # [ 0.158771] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) second # [ 0.158802] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.158867] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) second # [ 0.159002] NET: Registered PF_UNIX/PF_LOCAL protocol family second # [ 0.159033] NET: Registered PF_XDP protocol family second # [ 0.159057] PCI: CLS 0 bytes, default 64 second # [ 0.159272] Trying to unpack rootfs image as initramfs... second # [ 0.170905] kvm [1]: HYP mode not available test # [ 0.240662] Initialise system trusted keyrings test # [ 0.246553] workingset: timestamp_bits=42 max_order=18 bucket_order=0 test # [ 0.247695] squashfs: version 4.0 (2009/01/31) Phillip Lougher test # [ 0.248194] 9p: Installing v9fs 9p2000 file system support test # [ 0.267570] Key type asymmetric registered test # [ 0.267604] Asymmetric key parser 'x509' registered test # [ 0.267693] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) test # [ 0.269103] io scheduler mq-deadline registered test # [ 0.269120] io scheduler kyber registered test # [ 0.276837] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.237906] Initialise system trusted keyrings test # [ 0.277676] ledtrig-cpu: registered to indicate activity on CPUs test # [ 0.278039] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: test # [ 0.278063] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 test # [ 0.278079] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.278085] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 test # [ 0.278139] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits test # [ 0.278171] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] test # [ 0.278259] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 test # [ 0.278283] pci_bus 0000:00: root bus resource [bus 00-ff] test # [ 0.278289] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.278293] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.278297] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] test # [ 0.278385] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint second # [ 0.244896] workingset: timestamp_bits=42 max_order=18 bucket_order=0 second # [ 0.246096] squashfs: version 4.0 (2009/01/31) Phillip Lougher test # [ 0.286446] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.246654] 9p: Installing v9fs 9p2000 file system support test # [ 0.290664] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] test # [ 0.290693] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.290716] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.290728] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.291117] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint test # [ 0.291252] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] test # [ 0.291265] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.291287] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.291626] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.291759] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] test # [ 0.291772] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.291793] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.292121] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.292250] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] test # [ 0.292262] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.292283] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.292623] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.292753] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] test # [ 0.292764] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.292784] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.293104] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.293246] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] test # [ 0.293260] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.293280] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.293606] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.266078] Key type asymmetric registered second # [ 0.266110] Asymmetric key parser 'x509' registered test # [ 0.293739] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] test # [ 0.293750] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.266175] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) test # [ 0.293776] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.267662] io scheduler mq-deadline registered second # [ 0.267679] io scheduler kyber registered test # [ 0.293787] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.294127] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint test # [ 0.294259] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.294280] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.272968] pl061_gpio 9030000.pl061: PL061 GPIO chip registered second # [ 0.273829] ledtrig-cpu: registered to indicate activity on CPUs second # [ 0.274181] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: second # [ 0.274204] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 test # [ 0.314739] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.274219] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 test # [ 0.314891] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.274225] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 test # [ 0.314914] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.274263] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits test # [ 0.315204] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint test # [ 0.315335] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.274294] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] test # [ 0.315531] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.274378] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 test # [ 0.315784] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] second # [ 0.274403] pci_bus 0000:00: root bus resource [bus 00-ff] test # [ 0.315799] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.274408] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] test # [ 0.315820] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.274412] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] test # [ 0.316159] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.274416] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] test # [ 0.316293] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.274541] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint test # [ 0.316305] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.316327] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.274988] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint second # [ 0.275124] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] test # [ 0.316767] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned second # [ 0.275137] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.316779] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned second # [ 0.275159] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.316785] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned second # [ 0.275171] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] test # [ 0.316822] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned second # [ 0.275496] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.275627] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] test # [ 0.316856] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned second # [ 0.275639] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.316889] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.275659] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.316922] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned second # [ 0.275985] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.316953] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned second # [ 0.276114] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] second # [ 0.276125] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.316988] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned second # [ 0.276146] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.317022] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned second # [ 0.276468] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.317055] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned second # [ 0.276597] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] test # [ 0.317087] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned second # [ 0.276609] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.317156] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned second # [ 0.276630] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.317189] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned test # [ 0.317203] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned test # [ 0.317232] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned test # [ 0.317246] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned test # [ 0.317261] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned test # [ 0.317275] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned test # [ 0.317289] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned test # [ 0.317303] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned test # [ 0.317317] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned test # [ 0.317331] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned test # [ 0.317346] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned test # [ 0.317360] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned test # [ 0.317374] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.317388] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned test # [ 0.317403] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned test # [ 0.317417] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned second # [ 0.297096] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint test # [ 0.317437] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned second # [ 0.297250] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] second # [ 0.297264] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.317452] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned test # [ 0.317465] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned second # [ 0.297286] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.317479] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned second # [ 0.297620] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint test # [ 0.317493] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.297752] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] test # [ 0.317511] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] second # [ 0.297764] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.317517] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] second # [ 0.297785] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.317521] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] second # [ 0.298119] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint test # [ 0.318319] pci 0000:00:0a.0: enabling device (0000 -> 0002) second # [ 0.298253] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] second # [ 0.298265] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.298290] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.298301] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] second # [ 0.298670] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint second # [ 0.298807] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.298828] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.299162] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint second # [ 0.299296] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.299317] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.299600] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint second # [ 0.299726] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] second # [ 0.299912] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint second # [ 0.300145] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] second # [ 0.300160] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] second # [ 0.300180] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] second # [ 0.300537] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint second # [ 0.300669] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] second # [ 0.300680] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] test # [ 0.354610] pci 0000:00:0a.0: quirk_usb_early_handoff+0x0/0xa60 took 35452 usecs second # [ 0.300700] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] test # [ 0.361012] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.321275] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned second # [ 0.321298] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned second # [ 0.321304] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned second # [ 0.321341] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned second # [ 0.321374] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned second # [ 0.321407] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned second # [ 0.321439] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned second # [ 0.321471] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned second # [ 0.321505] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned second # [ 0.321538] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned second # [ 0.321571] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned second # [ 0.321603] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned second # [ 0.321672] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned second # [ 0.321775] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned second # [ 0.321791] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned second # [ 0.321805] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned second # [ 0.321819] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned second # [ 0.321834] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned second # [ 0.321848] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned test # [ 0.371146] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) test # [ 0.374113] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) second # [ 0.321862] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned second # [ 0.321876] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned second # [ 0.321891] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned second # [ 0.321904] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned second # [ 0.321919] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned second # [ 0.321933] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned second # [ 0.321947] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned test # [ 0.377095] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) second # [ 0.321961] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned second # [ 0.321975] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned second # [ 0.321989] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned second # [ 0.322008] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned second # [ 0.322022] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned second # [ 0.322035] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned second # [ 0.322049] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned second # [ 0.322063] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned second # [ 0.322081] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] second # [ 0.322087] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] second # [ 0.322091] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] second # [ 0.322874] pci 0000:00:0a.0: enabling device (0000 -> 0002) test # [ 0.382978] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) test # [ 0.385538] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.353832] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) second # [ 0.355923] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) test # [ 0.395639] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.403046] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) test # [ 0.405083] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) second # [ 0.366859] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) test # [ 0.410971] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) test # [ 0.413486] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) second # [ 0.372950] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) second # [ 0.374961] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) second # [ 0.385324] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) second # [ 0.387413] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) test # [ 0.431237] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled second # [ 0.390593] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) second # [ 0.392575] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) test # [ 0.432903] msm_serial: driver initialized test # [ 0.432983] SuperH (H)SCI(F) driver initialized test # [ 0.433021] STM32 USART driver initialized second # [ 0.406216] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) second # [ 0.408664] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) test # [ 0.453816] loop: module loaded test # [ 0.453967] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 0.416887] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled test # [ 0.458692] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) second # [ 0.418889] msm_serial: driver initialized second # [ 0.418980] SuperH (H)SCI(F) driver initialized second # [ 0.419014] STM32 USART driver initialized test # [ 0.462936] megasas: 07.734.00.00-rc1 test # [ 0.463476] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] test # [ 0.479666] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.479714] Intel/Sharp Extended Query Table at 0x0031 test # [ 0.481677] Using buffer write method test # [ 0.481764] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] second # [ 0.445639] loop: module loaded second # [ 0.445787] virtio_blk virtio5: 1/0/0 default/read/poll queues second # [ 0.446414] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) test # [ 0.493100] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 test # [ 0.493137] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.453302] megasas: 07.734.00.00-rc1 second # [ 0.453900] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] test # [ 0.496155] Using buffer write method test # [ 0.496186] Concatenating MTD devices: test # [ 0.496189] (0): "0.flash" test # [ 0.496192] (1): "0.flash" test # [ 0.496195] into device "0.flash" second # [ 0.465997] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.466044] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.467895] Using buffer write method second # [ 0.467983] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] second # [ 0.472744] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 second # [ 0.472785] Intel/Sharp Extended Query Table at 0x0031 second # [ 0.483200] Using buffer write method second # [ 0.483238] Concatenating MTD devices: second # [ 0.483241] (0): "0.flash" second # [ 0.483244] (1): "0.flash" second # [ 0.483247] into device "0.flash" test # [ 0.739603] Freeing initrd memory: 26976K test # [ 0.746759] tun: Universal TUN/TAP device driver, 1.6 test # [ 0.749551] thunder_xcv, ver 1.0 test # [ 0.749583] thunder_bgx, ver 1.0 test # [ 0.749599] nicpf, ver 1.0 test # [ 0.749892] e1000: Intel(R) PRO/1000 Network Driver test # [ 0.749900] e1000: Copyright (c) 1999-2006 Intel Corporation. test # [ 0.749914] e1000e: Intel(R) PRO/1000 Network Driver test # [ 0.749921] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. test # [ 0.749934] igb: Intel(R) Gigabit Ethernet Network Driver test # [ 0.749937] igb: Copyright (c) 2007-2014 Intel Corporation. test # [ 0.749948] igbvf: Intel(R) Gigabit Virtual Function Network Driver test # [ 0.749951] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. test # [ 0.750015] sky2: driver version 1.30 test # [ 0.755468] usbcore: registered new interface driver usb-storage test # [ 0.755578] usbcore: registered new interface driver usbserial_generic test # [ 0.755600] usbserial: USB Serial support registered for generic test # [ 0.755917] hv_vmbus: registering driver hyperv_keyboard test # [ 0.758920] ehci-pci 0000:00:0a.0: EHCI Host Controller test # [ 0.758955] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 test # [ 0.759130] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 test # [ 0.760789] rtc-pl031 9010000.pl031: registered as rtc0 test # [ 0.760831] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T20:04:43 UTC (1788897883) test # [ 0.761026] i2c_dev: i2c /dev entries driver second # [ 0.724909] Freeing initrd memory: 26980K second # [ 0.731870] tun: Universal TUN/TAP device driver, 1.6 second # [ 0.734536] thunder_xcv, ver 1.0 second # [ 0.734567] thunder_bgx, ver 1.0 second # [ 0.734579] nicpf, ver 1.0 second # [ 0.734866] e1000: Intel(R) PRO/1000 Network Driver second # [ 0.734873] e1000: Copyright (c) 1999-2006 Intel Corporation. second # [ 0.734887] e1000e: Intel(R) PRO/1000 Network Driver second # [ 0.734893] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. second # [ 0.734907] igb: Intel(R) Gigabit Ethernet Network Driver second # [ 0.734910] igb: Copyright (c) 2007-2014 Intel Corporation. second # [ 0.734921] igbvf: Intel(R) Gigabit Virtual Function Network Driver second # [ 0.734924] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. second # [ 0.734985] sky2: driver version 1.30 second # [ 0.735773] usbcore: registered new interface driver usb-storage second # [ 0.735858] usbcore: registered new interface driver usbserial_generic second # [ 0.735879] usbserial: USB Serial support registered for generic second # [ 0.736149] hv_vmbus: registering driver hyperv_keyboard second # [ 0.743519] ehci-pci 0000:00:0a.0: EHCI Host Controller second # [ 0.743561] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 second # [ 0.743824] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 second # [ 0.745642] rtc-pl031 9010000.pl031: registered as rtc0 second # [ 0.745684] rtc-pl031 9010000.pl031: setting system clock to 2026-09-08T20:04:43 UTC (1788897883) second # [ 0.745903] i2c_dev: i2c /dev entries driver second # [ 0.748582] sdhci: Secure Digital Host Controller Interface driver second # [ 0.748600] sdhci: Copyright(c) Pierre Ossman second # [ 0.748730] Synopsys Designware Multimedia Card Interface Driver test # [ 0.763971] sdhci: Secure Digital Host Controller Interface driver test # [ 0.763990] sdhci: Copyright(c) Pierre Ossman second # [ 0.750242] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.751154] hid: raw HID events driver (C) Jiri Kosina test # [ 0.764125] Synopsys Designware Multimedia Card Interface Driver second # [ 0.751319] usbcore: registered new interface driver usbhid test # [ 0.764290] sdhci-pltfm: SDHCI platform and OF driver helper second # [ 0.751324] usbhid: USB HID core driver test # [ 0.765304] hid: raw HID events driver (C) Jiri Kosina second # [ 0.772933] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 test # [ 0.765490] usbcore: registered new interface driver usbhid test # [ 0.765496] usbhid: USB HID core driver second # [ 0.775403] hub 1-0:1.0: USB hub found second # [ 0.775440] hub 1-0:1.0: 6 ports detected second # [ 0.775755] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available test # [ 0.816329] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 second # [ 0.776526] drop_monitor: Initializing network drop monitor service second # [ 0.776710] NET: Registered PF_INET6 protocol family test # [ 0.816541] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available test # [ 0.817394] drop_monitor: Initializing network drop monitor service test # [ 0.817534] NET: Registered PF_INET6 protocol family second # [ 0.779689] Segment Routing with IPv6 test # [ 0.818050] hub 1-0:1.0: USB hub found second # [ 0.779708] In-situ OAM (IOAM) with IPv6 test # [ 0.818081] hub 1-0:1.0: 6 ports detected second # [ 0.779786] NET: Registered PF_PACKET protocol family test # [ 0.821705] Segment Routing with IPv6 test # [ 0.821744] In-situ OAM (IOAM) with IPv6 test # [ 0.821810] NET: Registered PF_PACKET protocol family second # [ 0.780975] 9pnet: Installing 9P2000 support second # [ 0.782730] Key type dns_resolver registered test # [ 0.823019] 9pnet: Installing 9P2000 support test # [ 0.824747] Key type dns_resolver registered second # [ 0.786745] registered taskstats version 1 second # [ 0.786896] Loading compiled-in X.509 certificates test # [ 0.828469] registered taskstats version 1 test # [ 0.828670] Loading compiled-in X.509 certificates second # [ 0.792341] Demotion targets for Node 0: null second # [ 0.792428] Key type .fscrypt registered second # [ 0.792434] Key type fscrypt-provisioning registered second # [ 0.792534] ima: No TPM chip found, activating TPM-bypass! test # [ 0.834204] Demotion targets for Node 0: null second # [ 0.792546] ima: Allocated hash algorithm: sha1 test # [ 0.834298] Key type .fscrypt registered second # [ 0.792598] ima: No architecture policies found test # [ 0.834304] Key type fscrypt-provisioning registered test # [ 0.834410] ima: No TPM chip found, activating TPM-bypass! test # [ 0.834424] ima: Allocated hash algorithm: sha1 second # [ 0.795591] input: gpio-keys as /devices/platform/gpio-keys/input/input0 test # [ 0.836599] ima: No architecture policies found test # [ 0.837612] input: gpio-keys as /devices/platform/gpio-keys/input/input0 second # [ 0.806030] clk: Disabling unused clocks second # [ 0.806058] PM: genpd: Disabling unused power domains second # [ 0.809269] Freeing unused kernel memory: 4736K test # [ 0.848433] clk: Disabling unused clocks second # [ 0.809372] Run /init as init process test # [ 0.848460] PM: genpd: Disabling unused power domains test # [ 0.851822] Freeing unused kernel memory: 4736K test # [ 0.851933] Run /init as init process second # [ 0.831469] systemd[1]: Successfully made /usr/ read-only. test # [ 0.873443] systemd[1]: Successfully made /usr/ read-only. second # [ 1.020871] usb 1-1: new high-speed USB device number 2 using ehci-pci test # [ 1.062527] usb 1-1: new high-speed USB device number 2 using ehci-pci second # [ 1.166291] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) second # [ 1.173255] systemd[1]: Detected virtualization qemu. test # [ 1.208302] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) second # [ 1.174397] systemd[1]: Detected architecture arm64. test # [ 1.215653] systemd[1]: Detected virtualization qemu. second # [ 1.176040] systemd[1]: Running in initrd. test # [ 1.216786] systemd[1]: Detected architecture arm64. test # [ 1.218269] systemd[1]: Running in initrd. second # [ 1.177831] systemd[1]: Initializing machine ID from random generator. second # [ 1.179856] systemd[1]: Hostname set to . test # [ 1.220084] systemd[1]: Initializing machine ID from random generator. test # [ 1.222121] systemd[1]: Hostname set to . second # [ 1.184018] 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.225944] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 second # [ 1.265063] 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.306699] 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.384885] usb 1-2: new high-speed USB device number 3 using ehci-pci test # [ 1.426523] usb 1-2: new high-speed USB device number 3 using ehci-pci test # [ 1.500121] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 1.462489] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 1.574462] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.578951] 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.539295] 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.580381] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 test # [ 1.584357] systemd[1]: Created slice Slice /system/modprobe. test # [ 1.585193] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 1.586073] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.544987] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 test # [ 1.586841] systemd[1]: Reached target Path Units. test # [ 1.587374] systemd[1]: Reached target Slice Units. test # [ 1.587906] systemd[1]: Reached target Swaps. test # [ 1.588468] systemd[1]: Reached target Timer Units. test # [ 1.589266] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 1.590276] systemd[1]: Listening on Journal Socket (/dev/log). test # [ 1.591124] systemd[1]: Listening on Journal Sockets. test # [ 1.591934] systemd[1]: Listening on udev Control Socket. test # [ 1.592645] systemd[1]: Listening on udev Kernel Socket. test # [ 1.593252] systemd[1]: Reached target Socket Units. second # [ 1.553544] systemd[1]: Queued start job for default target Initrd Default Target. test # [ 1.595187] systemd[1]: Starting Create List of Static Device Nodes... test # [ 1.602393] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 1.603340] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 1.563443] systemd[1]: Created slice Slice /system/modprobe. second # [ 1.564555] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 1.565898] systemd[1]: Expecting device /dev/disk/by-label/nixos... second # [ 1.566868] systemd[1]: Reached target Path Units. second # [ 1.567576] systemd[1]: Reached target Slice Units. second # [ 1.568352] systemd[1]: Reached target Swaps. second # [ 1.569098] systemd[1]: Reached target Timer Units. second # [ 1.570103] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 1.571280] systemd[1]: Listening on Journal Socket (/dev/log). second # [ 1.572313] systemd[1]: Listening on Journal Sockets. second # [ 1.573266] systemd[1]: Listening on udev Control Socket. second # [ 1.574072] systemd[1]: Listening on udev Kernel Socket. second # [ 1.574551] systemd[1]: Reached target Socket Units. second # [ 1.576234] systemd[1]: Starting Create List of Static Device Nodes... test # [ 1.615472] systemd[1]: Mounting Kernel Configuration File System... second # [ 1.584062] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 1.584933] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 1.589100] systemd[1]: Mounting Kernel Configuration File System... test # [ 1.634675] systemd[1]: Starting Journal Service... second # [ 1.597068] systemd[1]: Starting Journal Service... test # [ 1.642627] systemd[1]: Starting Load Kernel Modules... test # [ 1.643253] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 1.646709] systemd[1]: Starting Coldplug All udev Devices... second # [ 1.610444] systemd[1]: Starting Load Kernel Modules... second # [ 1.611004] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 1.620986] systemd[1]: Starting Coldplug All udev Devices... test # [ 1.666631] systemd[1]: Finished Create List of Static Device Nodes. second # [ 1.629056] systemd[1]: Finished Create List of Static Device Nodes. test # [ 1.667789] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.667998] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 1.630577] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 1.668223] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.633251] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 1.674996] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 1.634661] systemd[1]: Mounted Kernel Configuration File System. second # [ 1.645979] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.663168] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 1.706931] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.715224] systemd-journald[73]: Collecting audit messages is disabled. second # [ 1.677403] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.681171] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 1.726557] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.728597] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 1.690882] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. test # [ 1.734446] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 test # [ 1.735296] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 1.707318] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev test # [ 1.747736] [drm] features: -virgl +edid -resource_blob -host_visible test # [ 1.747754] [drm] features: -context_init test # [ 1.748271] [drm] number of scanouts: 1 test # [ 1.748288] [drm] number of cap sets: 0 test # [ 1.750330] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic test # [ 1.750350] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 second # [ 1.713127] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 second # [ 1.713403] [drm] features: -virgl +edid -resource_blob -host_visible second # [ 1.713409] [drm] features: -context_init second # [ 1.713894] [drm] number of scanouts: 1 second # [ 1.713909] [drm] number of cap sets: 0 second # [ 1.733274] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 1.733493] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.733524] systemd[1]: Reached target Local File Systems. second # [ 1.736167] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.781262] Console: switching to colour frame buffer device 160x50 second # [ 1.741184] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic second # [ 1.741205] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 test # [ 1.788343] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 1.788526] systemd[1]: Reached target Preparation for Local File Systems. second # [ 1.740912] systemd-modules-load[74]: Inserted module 'dm_mod' test # [ 1.788551] systemd[1]: Reached target Local File Systems. second # [ 1.741691] systemd-modules-load[74]: Module 'virtio_balloon' is built in second # [ 1.744299] systemd-modules-load[74]: Module 'virtio_console' is built in second # [ 1.754332] systemd[1]: Started Journal Service. test # [ 1.794876] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 1.802720] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device test # [ 1.800446] systemd-modules-load[74]: Inserted module 'dm_mod' second # [ 1.761173] Console: switching to colour frame buffer device 160x50 test # [ 1.801575] systemd-modules-load[74]: Module 'virtio_balloon' is built in test # [ 1.808752] systemd[1]: Started Journal Service. test # [ 1.805743] systemd-modules-load[74]: Module 'virtio_console' is built in test # [ 1.809222] systemd-modules-load[74]: Inserted module 'virtio_gpu' test # [ 1.810306] systemd-modules-load[74]: Module 'virtio_rng' is built in test # [ 1.820331] systemd[1]: Finished Load Kernel Modules. second # [ 1.785425] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device second # [ 1.780818] systemd[1]: Starting Create System Files and Directories... test # [ 1.824156] systemd[1]: Starting Apply Kernel Variables... second # [ 1.784839] systemd-modules-load[74]: Inserted module 'virtio_gpu' second # [ 1.785497] systemd-modules-load[74]: Module 'virtio_rng' is built in second # [ 1.801634] systemd[1]: Finished Load Kernel Modules. test # [ 1.849709] systemd[1]: Starting Create System Files and Directories... second # [ 1.814840] systemd[1]: Starting Apply Kernel Variables... second # [ 1.818829] systemd-udevd[80]: Using default interface naming scheme 'v261'. second # [ 1.829117] systemd[1]: Finished Create System Files and Directories. test # [ 1.872219] systemd-udevd[79]: Using default interface naming scheme 'v261'. test # [ 1.878368] systemd[1]: Finished Apply Kernel Variables. second # [ 1.839095] systemd[1]: Finished Apply Kernel Variables. test # [ 1.884662] systemd[1]: Finished Create System Files and Directories. second # [ 1.852115] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 1.899206] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 1.900116] systemd[1]: Starting Virtual Console Setup... test # [ 1.948074] systemd[1]: Starting Virtual Console Setup... second # [ 1.931824] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 1.936529] systemd[1]: Finished Virtual Console Setup. test # [ 1.980462] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 1.982710] systemd[1]: Finished Virtual Console Setup. second # [ 2.157427] systemd[1]: Finished Coldplug All udev Devices. second # [ 2.158024] systemd[1]: Reached target System Initialization. second # [ 2.158525] systemd[1]: Reached target Basic System. test # [ 2.205078] systemd[1]: Finished Coldplug All udev Devices. test # [ 2.205727] systemd[1]: Reached target System Initialization. test # [ 2.206638] systemd[1]: Reached target Basic System. second # [ 2.259720] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.303899] (udev-worker)[104]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.322131] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line. second # [ 2.287166] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line. test # [ 2.381668] systemd[1]: Found device /dev/disk/by-label/nixos. test # [ 2.389438] systemd[1]: Reached target Initrd Root Device. test # [ 2.393174] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... second # [ 2.355061] systemd[1]: Found device /dev/disk/by-label/nixos. second # [ 2.358864] systemd[1]: Reached target Initrd Root Device. second # [ 2.364646] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... test # [ 2.435637] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks test # [ 2.440455] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. second # [ 2.399615] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks second # [ 2.403343] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. test # [ 2.650118] systemd[1]: Mounting /sysroot... second # [ 2.614845] systemd[1]: Mounting /sysroot... test # [ 2.682278] EXT4-fs (vda): mounted filesystem 1d24170d-8a37-4a40-8e4b-102d7a38e927 r/w with ordered data mode. Quota mode: none. test # [ 2.680686] systemd[1]: Mounted /sysroot. test # [ 2.682242] systemd[1]: Reached target Initrd Root File System. second # [ 2.650166] EXT4-fs (vda): mounted filesystem 90ee2e54-7f24-49bb-bdab-c44d8cb03200 r/w with ordered data mode. Quota mode: none. test # [ 2.686820] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 2.646337] systemd[1]: Mounted /sysroot. second # [ 2.647852] systemd[1]: Reached target Initrd Root File System. second # [ 2.651928] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.695884] systemd[1]: Mounting /sysroot/nix/.rw-store... test # [ 2.706353] systemd[1]: Mounting /sysroot/run... second # [ 2.670255] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload. second # [ 2.674880] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)... second # [ 2.676083] systemd[1]: Reloading... test # [ 2.720384] systemd[1]: Mounting /sysroot/tmp/shared... test # [ 2.734535] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 2.768925] systemd[1]: Starting Mountpoints Configured in the Real Root... test # [ 2.777106] systemd[1]: Mounted /sysroot/nix/.ro-store. test # [ 2.778366] systemd[1]: Mounted /sysroot/run. test # [ 2.787965] systemd[1]: Mounted /sysroot/tmp/shared. test # [ 2.791651] systemd[1]: Mounted /sysroot/nix/.rw-store. test # [ 2.798323] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 2.804242] systemd-sysroot-fstab-check[126]: /sysroot should be mounted in the initrd, will request daemon-reload. test # [ 2.810573] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 2.817537] systemd[1]: Reload requested from client PID 126 ('systemd-sysroot') (unit initrd-parse-etc.service)... test # [ 2.820676] systemd[1]: Reloading... second # [ 2.850895] systemd[1]: Reloading finished in 173 ms. second # [ 2.871424] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace... second # [ 2.874253] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace... second # [ 2.876445] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 2.885141] systemd[1]: initrd-parse-etc.service: Deactivated successfully. second # [ 2.886402] systemd[1]: Finished Mountpoints Configured in the Real Root. second # [ 2.887878] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. second # [ 2.905252] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 2.906511] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 2.998947] systemd[1]: Reloading finished in 179 ms. test # [ 3.030764] systemd-sysroot-fstab-check[126]: Requesting initrd-fs.target/start/replace... test # [ 3.033492] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.034932] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.038789] systemd-sysroot-fstab-check[126]: Requesting swap.target/start/replace... test # [ 3.047532] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.050664] systemd[1]: initrd-parse-etc.service: Deactivated successfully. test # [ 3.052157] systemd[1]: Finished Mountpoints Configured in the Real Root. test # [ 3.054483] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. test # [ 3.072712] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.073429] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 3.134041] (udev-worker)[102]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory second # [ 3.141783] (udev-worker)[102]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/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.149225] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 3.150859] systemd[1]: Stopped Virtual Console Setup. second # [ 3.153078] systemd[1]: Stopping Virtual Console Setup... second # [ 3.156509] systemd[1]: Starting Virtual Console Setup... second # [ 3.179460] systemd-vconsole-setup[141]: Configuration of first virtual console was skipped, ignoring remaining ones. second # [ 3.182440] systemd[1]: Finished Virtual Console Setup. test # [ 3.258859] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory test # [ 3.262261] (udev-worker)[98]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/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.272956] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.274871] systemd[1]: Stopped Virtual Console Setup. test # [ 3.280202] systemd[1]: Stopping Virtual Console Setup... test # [ 3.280711] systemd[1]: Starting Virtual Console Setup... test # [ 3.299670] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones. test # [ 3.302305] systemd[1]: Finished Virtual Console Setup. test # [ 3.652604] systemd[1]: Mounting /sysroot/nix/store... second # [ 3.618249] systemd[1]: Mounting /sysroot/nix/.ro-store... second # [ 3.629987] systemd[1]: Mounting /sysroot/nix/.rw-store... second # [ 3.631839] systemd[1]: Mounting /sysroot/run... second # [ 3.644582] systemd[1]: Mounting /sysroot/tmp/shared... test # [ 3.705147] systemd[1]: Mounted /sysroot/nix/store. test # [ 3.708321] systemd[1]: Reached target Initrd File Systems. second # [ 3.667160] systemd[1]: Mounting /sysroot/tmp/xchg... test # [ 3.710202] systemd[1]: Starting Find NixOS closure... test # [ 3.717661] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 3.693766] systemd[1]: Mounted /sysroot/nix/.rw-store. second # [ 3.703749] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 3.706402] systemd[1]: Mounted /sysroot/nix/.ro-store. second # [ 3.709912] systemd[1]: Mounted /sysroot/run. second # [ 3.715421] systemd[1]: Mounted /sysroot/tmp/shared. second # [ 3.717359] systemd[1]: Mounted /sysroot/tmp/xchg. test # [ 3.769424] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 3.730780] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 3.731827] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.775989] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. test # [ 3.787681] systemd[1]: Finished Find NixOS closure. test # [ 3.790412] systemd[1]: Reached target Initrd Default Target. test # [ 3.796273] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... test # [ 3.818575] systemd[1]: Stopped target Initrd Default Target. test # [ 3.820621] systemd[1]: Stopped target Basic System. test # [ 3.824173] systemd[1]: Stopped target Initrd Root Device. test # [ 3.824976] systemd[1]: Stopped target Path Units. test # [ 3.825617] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. test # [ 3.828139] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. test # [ 3.829402] systemd[1]: Stopped target Slice Units. test # [ 3.831201] systemd[1]: Stopped target Socket Units. test # [ 3.836237] systemd[1]: Stopped target System Initialization. test # [ 3.837063] systemd[1]: Stopped target Swaps. test # [ 3.837796] systemd[1]: Stopped target Timer Units. test # [ 3.838415] systemd[1]: dbus.socket: Deactivated successfully. test # [ 3.839346] systemd[1]: Closed D-Bus System Message Bus Socket. test # [ 3.840457] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. test # [ 3.844123] systemd[1]: Stopped Find NixOS closure. test # [ 3.844923] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 3.846026] systemd[1]: Starting rw-sysroot-nix-store.service... test # [ 3.847298] systemd[1]: systemd-sysctl.service: Deactivated successfully. test # [ 3.850667] systemd[1]: Stopped Apply Kernel Variables. test # [ 3.852782] systemd[1]: systemd-modules-load.service: Deactivated successfully. test # [ 3.855179] systemd[1]: Stopped Load Kernel Modules. test # [ 3.859207] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. test # [ 3.866013] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. test # [ 3.868335] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. test # [ 3.875909] systemd[1]: Stopped Create System Files and Directories. test # [ 3.878136] systemd[1]: Stopped target Local File Systems. test # [ 3.878813] systemd[1]: Stopped target Preparation for Local File Systems. test # [ 3.879462] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. test # [ 3.884386] systemd[1]: Stopped Coldplug All udev Devices. test # [ 3.884949] systemd[1]: Stopping Rule-based Manager for Device Events and Files... test # [ 3.885854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. test # [ 3.886493] systemd[1]: Stopped Virtual Console Setup. test # [ 3.886964] systemd[1]: initrd-cleanup.service: Deactivated successfully. test # [ 3.887543] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. test # [ 3.892484] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 3.893143] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 3.893683] systemd[1]: systemd-udevd.service: Deactivated successfully. test # [ 3.894247] systemd[1]: Stopped Rule-based Manager for Device Events and Files. test # [ 3.894866] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. test # [ 3.895485] systemd[1]: Finished rw-sysroot-nix-store.service. test # [ 3.895992] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. test # [ 3.899156] systemd[1]: Closed udev Control Socket. test # [ 3.899623] systemd[1]: Starting Cleanup udev Database... test # [ 3.904196] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. test # [ 3.908154] systemd[1]: Stopped Create Static Device Nodes in /dev. test # [ 3.908958] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. test # [ 3.909684] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. test # [ 3.910320] systemd[1]: kmod-static-nodes.service: Deactivated successfully. test # [ 3.910947] systemd[1]: Stopped Create List of Static Device Nodes. test # [ 3.922861] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. test # [ 3.927106] systemd[1]: Finished Cleanup udev Database. test # [ 3.927638] systemd[1]: Reached target Switch Root. test # [ 3.929093] systemd[1]: Starting NixOS Activation... test # [ 4.053363] initrd-nixos-activation-start[179]: booting system configuration /nix/store/sjzkqkvigxashyj0my0zc7w0nmrs31a6-nixos-system-test-test test # [ 4.101061] initrd-nixos-activation-start[179]: running activation script... test # [ 4.463705] initrd-nixos-activation-start[202]: setting up /etc... test # [ 4.648307] initrd-nixos-activation-start[202]: setting up age secrets... second # [ 4.615246] systemd[1]: Mounting /sysroot/nix/store... second # [ 4.659027] systemd[1]: Mounted /sysroot/nix/store. second # [ 4.661396] systemd[1]: Reached target Initrd File Systems. second # [ 4.665337] systemd[1]: Starting Find NixOS closure... second # [ 4.677103] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... second # [ 4.713690] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. second # [ 4.717874] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. second # [ 4.735789] systemd[1]: Finished Find NixOS closure. second # [ 4.739044] systemd[1]: Reached target Initrd Default Target. second # [ 4.744486] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... second # [ 4.776517] systemd[1]: Stopped target Initrd Default Target. second # [ 4.780399] systemd[1]: Stopped target Basic System. second # [ 4.781490] systemd[1]: Stopped target Initrd Root Device. second # [ 4.782471] systemd[1]: Stopped target Path Units. second # [ 4.783696] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. second # [ 4.786777] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. second # [ 4.790018] systemd[1]: Stopped target Slice Units. second # [ 4.792616] systemd[1]: Stopped target Socket Units. second # [ 4.793303] systemd[1]: Stopped target System Initialization. second # [ 4.794038] systemd[1]: Stopped target Swaps. second # [ 4.794629] systemd[1]: Stopped target Timer Units. second # [ 4.795268] systemd[1]: dbus.socket: Deactivated successfully. second # [ 4.800203] systemd[1]: Closed D-Bus System Message Bus Socket. second # [ 4.800966] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. second # [ 4.801835] systemd[1]: Stopped Find NixOS closure. second # [ 4.802431] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 4.804513] systemd[1]: Starting rw-sysroot-nix-store.service... second # [ 4.808161] systemd[1]: systemd-sysctl.service: Deactivated successfully. second # [ 4.808932] systemd[1]: Stopped Apply Kernel Variables. second # [ 4.809685] systemd[1]: systemd-modules-load.service: Deactivated successfully. second # [ 4.810749] systemd[1]: Stopped Load Kernel Modules. second # [ 4.812239] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. second # [ 4.815940] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. second # [ 4.819300] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. second # [ 4.822408] systemd[1]: Stopped Create System Files and Directories. test # [ 4.869581] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. test # [ 4.871406] systemd[1]: Finished NixOS Activation. test # [ 4.872267] systemd[1]: Starting Switch Root... second # [ 4.834743] systemd[1]: Stopped target Local File Systems. second # [ 4.837674] systemd[1]: Stopped target Preparation for Local File Systems. second # [ 4.840359] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. second # [ 4.842273] systemd[1]: Stopped Coldplug All udev Devices. second # [ 4.846206] systemd[1]: Stopping Rule-based Manager for Device Events and Files... second # [ 4.847085] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. second # [ 4.849304] systemd[1]: Stopped Virtual Console Setup. test # [ 4.893796] systemd[1]: Switching root. second # [ 4.850994] systemd[1]: initrd-cleanup.service: Deactivated successfully. second # [ 4.851698] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. second # [ 4.854409] systemd[1]: systemd-udevd.service: Deactivated successfully. second # [ 4.855090] systemd[1]: Stopped Rule-based Manager for Device Events and Files. second # [ 4.856873] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 4.860153] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 4.861005] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. second # [ 4.861684] systemd[1]: Finished rw-sysroot-nix-store.service. second # [ 4.862910] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. second # [ 4.864247] systemd[1]: Closed udev Control Socket. second # [ 4.865702] systemd[1]: Starting Cleanup udev Database... second # [ 4.866324] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. second # [ 4.867028] systemd[1]: Stopped Create Static Device Nodes in /dev. second # [ 4.867605] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. second # [ 4.868782] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. second # [ 4.869437] systemd[1]: kmod-static-nodes.service: Deactivated successfully. second # [ 4.870056] systemd[1]: Stopped Create List of Static Device Nodes. second # [ 4.889058] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. second # [ 4.890089] systemd[1]: Finished Cleanup udev Database. second # [ 4.891473] systemd[1]: Reached target Switch Root. second # [ 4.893064] systemd[1]: Starting NixOS Activation... test # [ 5.071105] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). second # [ 5.070002] initrd-nixos-activation-start[178]: booting system configuration /nix/store/k0jyhgd8hlg45n6j1wxm655ldxygdjlr-nixos-system-second-test second # [ 5.133563] initrd-nixos-activation-start[178]: running activation script... second # [ 5.536901] initrd-nixos-activation-start[201]: setting up /etc... test # [ 5.605023] systemd[1]: systemd 261.2 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.608788] systemd[1]: Detected virtualization qemu. test # [ 5.609924] systemd[1]: Detected architecture arm64. test # [ 5.611514] systemd[1]: Detected first boot. test # [ 5.615262] systemd[1]: Initializing machine ID from random generator. second # [ 5.716881] initrd-nixos-activation-start[201]: setting up age secrets... test # [ 5.902429] systemd[1]: bpf-restrict-fs: LSM BPF program attached second # [ 5.881599] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. second # [ 5.883327] systemd[1]: Finished NixOS Activation. second # [ 5.884129] systemd[1]: Starting Switch Root... second # [ 5.897018] systemd[1]: Switching root. test # [ 6.059412] systemd[1]: Applying preset policy. second # [ 6.079452] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). test # [ 6.594744] systemd[1]: Populated /etc with preset unit settings. second # [ 6.644108] systemd[1]: systemd 261.2 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.647702] systemd[1]: Detected virtualization qemu. second # [ 6.648689] systemd[1]: Detected architecture arm64. second # [ 6.650050] systemd[1]: Detected first boot. second # [ 6.653662] systemd[1]: Initializing machine ID from random generator. second # [ 6.905857] systemd[1]: bpf-restrict-fs: LSM BPF program attached test # [ 7.042560] systemd[1]: initrd-switch-root.service: Deactivated successfully. test # [ 7.043433] systemd[1]: Stopped initrd-switch-root.service. test # [ 7.045374] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. test # [ 7.048971] systemd[1]: Created slice Slice /system/getty. test # [ 7.050747] systemd[1]: Created slice User and Session Slice. test # [ 7.050876] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. test # [ 7.050951] systemd[1]: Started Forward Password Requests to Wall Directory Watch. test # [ 7.051401] systemd[1]: Expecting device /dev/hvc0... test # [ 7.051682] systemd[1]: Expecting device /dev/ttyAMA0... test # [ 7.051959] systemd[1]: Reached target Local Encrypted Volumes. test # [ 7.052236] systemd[1]: Stopped target initrd-fs.target. test # [ 7.052494] systemd[1]: Stopped target initrd-root-fs.target. test # [ 7.052757] systemd[1]: Stopped target initrd-switch-root.target. test # [ 7.053020] systemd[1]: Reached target Virtual Machines and Containers. test # [ 7.053315] systemd[1]: Reached target Path Units. test # [ 7.053578] systemd[1]: Reached target Remote File Systems. test # [ 7.053829] systemd[1]: Reached target Slice Units. test # [ 7.054078] systemd[1]: Reached target Swaps. test # [ 7.063178] systemd[1]: Listening on Query the User Interactively for a Password. test # [ 7.067098] systemd[1]: Listening on Process Core Dump Socket. test # [ 7.070129] systemd[1]: Listening on Credential Encryption/Decryption. test # [ 7.073318] systemd[1]: Listening on Factory Reset Management. test # [ 7.074785] systemd[1]: Listening on Hostname Service Socket. test # [ 7.078867] systemd[1]: Starting Journal Log Access Socket... test # [ 7.080920] systemd[1]: Listening on Journal Audit Socket. test # [ 7.085101] systemd[1]: Listening on Console Output Muting Service Socket. test # [ 7.085687] systemd[1]: Listening on Network Management Metrics Varlink Socket. test # [ 7.086136] systemd[1]: Listening on Network Management Varlink Socket. test # [ 7.088421] systemd[1]: Listening on Network Management Netlink Socket. test # [ 7.089678] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. test # [ 7.091232] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os test # [ 7.093500] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki test # [ 7.100796] systemd[1]: Listening on Disk Repartitioning Service Socket. test # [ 7.102427] systemd[1]: Listening on Resolve Monitor Varlink Socket. test # [ 7.104003] systemd[1]: Listening on Resolve Service Varlink Socket. test # [ 7.105434] systemd[1]: Listening on udev Control Socket. test # [ 7.106856] systemd[1]: Listening on udev Varlink Socket. test # [ 7.110162] systemd[1]: Mounting Huge Pages File System... second # [ 7.073248] systemd[1]: Applying preset policy. test # [ 7.114951] systemd[1]: Mounting POSIX Message Queue File System... test # [ 7.122438] systemd[1]: Mounting Kernel Debug File System... test # [ 7.131237] systemd[1]: Mounting Kernel Trace File System... test # [ 7.135979] systemd[1]: Starting Create List of Static Device Nodes... test # [ 7.150920] systemd[1]: Starting Load Kernel Module 9pnet_virtio... test # [ 7.152189] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 7.157656] systemd[1]: Mounting Kernel Configuration File System... test # [ 7.162903] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm test # [ 7.167711] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore test # [ 7.193037] systemd[1]: Starting Load Kernel Module fuse... test # [ 7.195820] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 7.233541] systemd[1]: Starting Journal Service... test # [ 7.262509] systemd[1]: Starting Load Kernel Modules... test # [ 7.288832] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... test # [ 7.303853] systemd[1]: Starting Remount Root and Kernel File Systems... test # [ 7.306316] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 7.329753] systemd[1]: Starting Coldplug All udev Devices... test # [ 7.346538] fuse: init (API version 7.45) test # [ 7.362442] systemd[1]: Listening on Journal Log Access Socket. test # [ 7.367966] systemd[1]: Mounted Huge Pages File System. test # [ 7.370732] systemd-journald[327]: Collecting audit messages is enabled. test # [ 7.372666] systemd[1]: Mounted POSIX Message Queue File System. test # [ 7.377529] systemd[1]: Mounted Kernel Debug File System. test # [ 7.375666] systemd[1]: Queued start job for default target Multi-User System. test # [ 7.383055] systemd[1]: Started Journal Service. test # [ 7.389281] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 7.396445] systemd[1]: Mounted Kernel Trace File System. test # [ 7.397060] systemd[1]: Finished Create List of Static Device Nodes. test # [ 7.397706] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. test # [ 7.398416] systemd[1]: Finished Load Kernel Module 9pnet_virtio. test # [ 7.399056] systemd[1]: Mounted Kernel Configuration File System. test # [ 7.399675] systemd[1]: modprobe@fuse.service: Deactivated successfully. test # [ 7.413252] systemd-modules-load[328]: Module 'atkbd' is built in test # [ 7.414754] systemd[1]: Finished Load Kernel Module fuse. test # [ 7.421286] systemd-modules-load[328]: Module 'ctr' is built in test # [ 7.421929] systemd-modules-load[328]: Module 'loop' is built in test # [ 7.422506] systemd[1]: Mounting FUSE Control File System... test # [ 7.423045] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... test # [ 7.429890] systemd[1]: Finished Load Kernel Modules. test # [ 7.463770] EXT4-fs (vda): re-mounted 1d24170d-8a37-4a40-8e4b-102d7a38e927. test # [ 7.469006] systemd[1]: Finished Remount Root and Kernel File Systems. test # [ 7.483855] systemd-oomd[330]: No swap; memory pressure usage will be degraded second # [ 7.452712] systemd[1]: Populated /etc with preset unit settings. test # [ 7.490115] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 7.496595] systemd[1]: Starting Firewall... test # [ 7.501256] systemd[1]: Starting Flush Journal to Persistent Storage... test # [ 7.505688] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore test # [ 7.512199] systemd[1]: Starting Load/Save OS Random Seed... test # [ 7.559725] systemd[1]: Starting Apply Kernel Variables... test # [ 7.561483] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 7.568236] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 7.572300] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. test # [ 7.597281] systemd[1]: Starting Create Static Device Nodes in /dev... test # [ 7.605236] systemd[1]: Finished Load/Save OS Random Seed. test # [ 7.628406] systemd[1]: Mounted FUSE Control File System. test # [ 7.640212] systemd-journald[327]: Received client request to flush runtime journal. test # [ 7.753624] systemd[1]: Reached target First Boot Complete. test # [ 7.759909] systemd[1]: Finished Apply Kernel Variables. test # [ 7.761995] systemd[1]: Starting Network Name Resolution... test # [ 7.768656] systemd[1]: Finished Create Static Device Nodes in /dev. test # [ 7.772588] systemd[1]: Reached target Preparation for Local File Systems. test # [ 7.774708] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 7.778344] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 7.868881] systemd-resolved[359]: Positive Trust Anchors: test # [ 7.871517] systemd-resolved[359]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d test # [ 7.875671] systemd-resolved[359]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 test # [ 7.880969] systemd-resolved[359]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test second # [ 7.874700] systemd[1]: initrd-switch-root.service: Deactivated successfully. second # [ 7.875637] systemd[1]: Stopped initrd-switch-root.service. test # [ 7.911426] systemd-udevd[363]: Using default interface naming scheme 'v261'. second # [ 7.878056] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. second # [ 7.880503] systemd[1]: Created slice Slice /system/getty. second # [ 7.881829] systemd[1]: Created slice User and Session Slice. second # [ 7.882583] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. second # [ 7.884070] systemd[1]: Started Forward Password Requests to Wall Directory Watch. second # [ 7.884778] systemd[1]: Expecting device /dev/hvc0... second # [ 7.885563] systemd[1]: Expecting device /dev/ttyAMA0... second # [ 7.885611] systemd[1]: Reached target Local Encrypted Volumes. second # [ 7.885647] systemd[1]: Stopped target initrd-fs.target. second # [ 7.885677] systemd[1]: Stopped target initrd-root-fs.target. second # [ 7.886137] systemd[1]: Stopped target initrd-switch-root.target. second # [ 7.886448] systemd[1]: Reached target Virtual Machines and Containers. second # [ 7.886745] systemd[1]: Reached target Path Units. second # [ 7.887012] systemd[1]: Reached target Remote File Systems. second # [ 7.887264] systemd[1]: Reached target Slice Units. second # [ 7.887522] systemd[1]: Reached target Swaps. second # [ 7.894757] systemd[1]: Listening on Query the User Interactively for a Password. second # [ 7.899051] systemd[1]: Listening on Process Core Dump Socket. second # [ 7.902049] systemd[1]: Listening on Credential Encryption/Decryption. second # [ 7.905122] systemd[1]: Listening on Factory Reset Management. second # [ 7.906196] systemd[1]: Listening on Hostname Service Socket. second # [ 7.910360] systemd[1]: Starting Journal Log Access Socket... second # [ 7.912384] systemd[1]: Listening on Journal Audit Socket. second # [ 7.915922] systemd[1]: Listening on Console Output Muting Service Socket. second # [ 7.918131] systemd[1]: Listening on Network Management Metrics Varlink Socket. second # [ 7.920698] systemd[1]: Listening on Network Management Varlink Socket. second # [ 7.921300] systemd[1]: Listening on Network Management Netlink Socket. second # [ 7.921784] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. second # [ 7.922099] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os second # [ 7.922359] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki second # [ 7.932447] systemd[1]: Listening on Disk Repartitioning Service Socket. second # [ 7.933815] systemd[1]: Listening on Resolve Monitor Varlink Socket. second # [ 7.935380] systemd[1]: Listening on Resolve Service Varlink Socket. second # [ 7.936995] systemd[1]: Listening on udev Control Socket. second # [ 7.938506] systemd[1]: Listening on udev Varlink Socket. second # [ 7.942062] systemd[1]: Mounting Huge Pages File System... second # [ 7.948492] systemd[1]: Mounting POSIX Message Queue File System... second # [ 7.955747] systemd[1]: Mounting Kernel Debug File System... second # [ 7.960660] systemd[1]: Mounting Kernel Trace File System... second # [ 7.970056] systemd[1]: Starting Create List of Static Device Nodes... second # [ 7.984928] systemd[1]: Starting Load Kernel Module 9pnet_virtio... second # [ 7.985985] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 7.997889] systemd[1]: Mounting Kernel Configuration File System... second # [ 7.999216] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm second # [ 8.002439] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore test # [ 8.047904] systemd[1]: Mounting /run/wrappers... second # [ 8.079722] systemd[1]: Starting Load Kernel Module fuse... second # [ 8.084028] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 test # [ 8.129440] systemd[1]: Mounted /run/wrappers. test # [ 8.136286] systemd[1]: Reached target Local File Systems. test # [ 8.140508] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 8.106460] systemd[1]: Starting Journal Service... test # [ 8.148308] systemd-resolved[359]: Using system hostname 'test'. test # [ 8.155674] systemd[1]: Starting register-nix-paths.service... second # [ 8.123863] systemd[1]: Starting Load Kernel Modules... test # [ 8.163284] systemd[1]: Starting Create SUID/SGID Wrappers... test # [ 8.168270] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. test # [ 8.180144] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 8.149959] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... second # [ 8.155001] systemd[1]: Starting Remount Root and Kernel File Systems... second # [ 8.164405] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os second # [ 8.191588] fuse: init (API version 7.45) test # [ 8.227528] systemd[1]: Starting Create System Files and Directories... second # [ 8.198226] systemd[1]: Starting Coldplug All udev Devices... second # [ 8.204370] systemd-journald[306]: Collecting audit messages is enabled. second # [ 8.211216] systemd[1]: Queued start job for default target Multi-User System. test # [ 8.257103] systemd[1]: Started Network Name Resolution. second # [ 8.217193] systemd[1]: systemd-journald.service: Deactivated successfully. test # [ 8.262434] systemd[1]: Started Rule-based Manager for Device Events and Files. second # [ 8.219361] systemd-modules-load[308]: Module 'atkbd' is built in second # [ 8.227672] systemd-modules-load[308]: Module 'ctr' is built in second # [ 8.237296] systemd[1]: Started Journal Service. second # [ 8.232559] systemd-modules-load[308]: Module 'loop' is built in second # [ 8.238953] systemd[1]: Listening on Journal Log Access Socket. second # [ 8.242373] systemd[1]: Mounted Huge Pages File System. second # [ 8.245211] systemd[1]: Mounted POSIX Message Queue File System. second # [ 8.250337] systemd[1]: Mounted Kernel Debug File System. second # [ 8.254382] systemd[1]: Mounted Kernel Trace File System. second # [ 8.257560] systemd[1]: Finished Create List of Static Device Nodes. second # [ 8.260731] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. second # [ 8.271624] EXT4-fs (vda): re-mounted 90ee2e54-7f24-49bb-bdab-c44d8cb03200. second # [ 8.268360] systemd[1]: Finished Load Kernel Module 9pnet_virtio. second # [ 8.268989] systemd[1]: Mounted Kernel Configuration File System. second # [ 8.269553] systemd[1]: modprobe@fuse.service: Deactivated successfully. second # [ 8.270170] systemd[1]: Finished Load Kernel Module fuse. second # [ 8.270677] systemd[1]: Finished Load Kernel Modules. second # [ 8.294541] systemd[1]: Mounting FUSE Control File System... second # [ 8.300098] systemd[1]: Starting Firewall... second # [ 8.317211] systemd[1]: Starting Apply Kernel Variables... second # [ 8.334282] systemd-oomd[309]: No swap; memory pressure usage will be degraded second # [ 8.347316] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... second # [ 8.356244] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. test # [ 8.408672] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. second # [ 8.368942] systemd[1]: Finished Remount Root and Kernel File Systems. second # [ 8.372370] systemd[1]: Listening on Disk Image Download Service Socket. test # [ 8.417088] systemd[1]: Finished Save Transient machine-id to Disk. second # [ 8.378050] systemd[1]: Starting Flush Journal to Persistent Storage... second # [ 8.378771] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore second # [ 8.391168] systemd[1]: Starting Load/Save OS Random Seed... second # [ 8.396263] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os test # [ 8.451066] systemd[1]: Finished Create System Files and Directories. test # [ 8.466061] systemd[1]: Starting Rebuild Journal Catalog... test # [ 8.468803] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 8.477451] systemd[1]: Finished Apply Kernel Variables. second # [ 8.489450] systemd-journald[306]: Received client request to flush runtime journal. test # [ 8.601595] systemd[1]: Finished Coldplug All udev Devices. test # [ 8.606240] systemd[1]: Finished Record System Boot/Shutdown in UTMP. second # [ 8.566068] systemd[1]: Starting Network Name Resolution... second # [ 8.566692] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. second # [ 8.567336] systemd[1]: Starting Create Static Device Nodes in /dev... second # [ 8.567976] systemd[1]: Finished Load/Save OS Random Seed. second # [ 8.578143] systemd[1]: Mounted FUSE Control File System. second # [ 8.579610] systemd[1]: Reached target First Boot Complete. second # [ 8.586783] systemd[1]: Finished Flush Journal to Persistent Storage. test # [ 8.668192] systemd[1]: Finished Rebuild Journal Catalog. test # [ 8.677573] systemd[1]: Starting Update is Completed... second # [ 8.673748] systemd[1]: Finished Create Static Device Nodes in /dev. second # [ 8.676964] systemd[1]: Reached target Preparation for Local File Systems. second # [ 8.678825] systemd[1]: Starting Rule-based Manager for Device Events and Files... test # [ 8.740496] systemd[1]: Finished Update is Completed. second # [ 8.709590] systemd-resolved[335]: Positive Trust Anchors: second # [ 8.713009] systemd-resolved[335]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d second # [ 8.718061] systemd-resolved[335]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 test # [ 8.775658] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs second # [ 8.723744] systemd-resolved[335]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test second # [ 8.823274] systemd-udevd[349]: Using default interface naming scheme 'v261'. second # [ 8.870394] systemd[1]: Mounting /run/wrappers... second # [ 8.951112] systemd[1]: Mounted /run/wrappers. second # [ 8.951760] systemd[1]: Reached target Local File Systems. second # [ 8.959223] systemd[1]: Listening on Boot Loader Control Service Socket. second # [ 8.969972] systemd[1]: Starting register-nix-paths.service... second # [ 8.977383] systemd[1]: Starting Create SUID/SGID Wrappers... second # [ 8.978094] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. second # [ 8.993232] systemd[1]: Starting Save Transient machine-id to Disk... second # [ 8.995919] systemd-resolved[335]: Using system hostname 'second'. second # [ 9.024575] systemd[1]: Starting Create System Files and Directories... second # [ 9.027378] systemd[1]: Started Network Name Resolution. test # [ 9.157119] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. test # [ 9.160617] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 9.163596] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. second # [ 9.149928] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. second # [ 9.158638] systemd[1]: Finished Save Transient machine-id to Disk. test # [ 9.231117] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. second # [ 9.233595] systemd[1]: Finished Create System Files and Directories. second # [ 9.258695] systemd[1]: Starting Rebuild Journal Catalog... second # [ 9.261409] systemd[1]: Starting Record System Boot/Shutdown in UTMP... second # [ 9.262171] systemd[1]: Started Rule-based Manager for Device Events and Files. test # [ 9.372355] systemd[1]: Finished Firewall. test # [ 9.372954] systemd[1]: Reached target Preparation for Network. test # [ 9.375059] systemd[1]: Listening on Network Management Resolve Hook Socket. test # [ 9.379540] systemd[1]: Starting Network Management... second # [ 9.400576] systemd[1]: Finished Record System Boot/Shutdown in UTMP. test # [ 9.446506] systemd[1]: Finished register-nix-paths.service. test # [ 9.450061] systemd[1]: Reached target System Initialization. test # [ 9.452173] systemd[1]: Started Discard unused filesystem blocks once a week. test # [ 9.457225] systemd[1]: Started Daily Cleanup of Temporary Directories. test # [ 9.459642] systemd[1]: Reached target Timer Units. test # [ 9.460521] systemd[1]: Listening on D-Bus System Message Bus Socket. test # [ 9.461103] systemd[1]: Listening on Nix Daemon Socket. test # [ 9.471091] systemd[1]: Listening on Authorization Manager Agent Helper. test # [ 9.472178] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. test # [ 9.474514] systemd[1]: Reached target Socket Units. test # [ 9.477410] systemd[1]: Starting D-Bus System Message Bus... second # [ 9.484785] systemd[1]: Finished Rebuild Journal Catalog. second # [ 9.506516] systemd[1]: Starting Update is Completed... second # [ 9.509568] systemd[1]: Finished Coldplug All udev Devices. test # [ 9.571448] (udev-worker)[404]: Network interface NamePolicy= disabled on kernel command line. test # [ 9.600132] (udev-worker)[403]: Network interface NamePolicy= disabled on kernel command line. test # [ 9.612975] cfg80211: Loading compiled-in X.509 certificates for regulatory database second # [ 9.575715] systemd[1]: Finished Update is Completed. test # [ 9.643771] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' test # [ 9.644298] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' test # [ 9.641163] dbus-broker-launch[551]: Looking up NSS user entry for 'systemd-timesync'... test # [ 9.650991] dbus-broker-launch[551]: NSS returned no entry for 'systemd-timesync' test # [ 9.652363] dbus-broker-launch[551]: Invalid user-name in /nix/store/024a16lrl5bks2rq7c078hn805ds6dd4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" test # [ 9.684966] dbus-broker-launch[551]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' test # [ 9.695430] 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 # [ 9.705049] dbus-broker-launch[551]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' test # [ 9.713067] 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 # [ 9.722552] dbus-broker-launch[551]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/9prxmvwvdr9mfqbb38w7jq4kicc7zi18-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 9.726641] systemd-networkd[548]: lo: Link UP test # [ 9.732819] systemd-networkd[548]: lo: Gained carrier test # [ 9.734118] dbus-broker-launch[551]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/5cpm90flydbxw9km2kl7pk8i1i5sc3nk-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' test # [ 9.743522] systemd[1]: Started D-Bus System Message Bus. test # [ 9.744158] systemd[1]: Reached target Basic System. test # [ 9.744668] systemd[1]: Starting Network Manager Script Dispatcher Service... test # [ 9.745316] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 9.745947] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 9.753825] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... test # [ 9.779284] dbus-broker-launch[551]: Ready test # [ 9.783330] systemd[1]: Starting Network Manager... test # [ 9.789856] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 9.799985] systemd-networkd[548]: eth1: Configuring with /etc/systemd/network/40-eth1.network. test # [ 9.802189] systemd-networkd[548]: eth1: Link UP test # [ 9.806021] systemd-networkd[548]: eth1: Gained carrier test # [ 9.808132] systemd-networkd[548]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 9.825727] systemd[1]: Started backdoor.service. second # [ 9.818006] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs test # [ 9.870024] systemd[1]: Starting Import lastlog data into lastlog2 database... test # [ 9.902900] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[561]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 9.919285] kmrn99zb7hfffrbx2s86i3g3dg0y4036-wifi-secrets[563]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 9.928223] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 9.945534] r3qn2wrxq8bfm2mry46agf2zjadxngay-wifi-secrets[562]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets test # [ 9.954648] systemd[1]: Starting Post-Boot Actions... second # [ 9.918061] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. second # [ 9.920185] systemd[1]: Finished Create SUID/SGID Wrappers. test # [ 9.996579] systemd[1]: Started Reset console on configuration changes. test # [ 10.000634] systemd[1]: Started Network Management. test # [ 10.015737] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. test # [ 10.024212] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 10.032340] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully. test # [ 10.050799] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # [ 10.053942] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully. test # [ 10.064932] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. test # connecting to host... second # [ 10.064847] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. test # [ 10.118474] systemd[1]: Finished Post-Boot Actions. test: Guest shell says: b'Spawning backdoor root shell...\n' test # [ 10.165062] systemd[1]: Finished Import lastlog data into lastlog2 database. test # [ 10.177813] systemd[1]: Started Network Manager Script Dispatcher Service. test # [ 10.188733] mousedev: PS/2 mouse device common for all mice test: connected to guest root shell test # [ 10.187207] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... second # [ 10.145455] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. test # [ 10.191326] systemd[1]: Started Name Service Cache Daemon (nsncd). test: (connecting took 10.43 seconds) test # [ 10.193453] nsncd[569]: Sep 08 20:04:52.938 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" test: (finished: waiting for the VM to finish booting, in 10.43 seconds) test # [ 10.201540] systemd[1]: Reached target Host and Network Name Lookups. test # [ 10.202194] systemd[1]: Reached target User and Group Name Lookups. test # [ 10.224491] systemd[1]: Starting User Login Management... second # [ 10.195586] systemd[1]: Finished Firewall. second # [ 10.196379] systemd[1]: Reached target Preparation for Network. second # [ 10.199571] systemd[1]: Listening on Network Management Resolve Hook Socket. second # [ 10.203557] systemd[1]: Starting Network Management... test # [ 10.285985] systemd[1]: Starting Hostname Service... second # [ 10.274009] systemd[1]: Finished register-nix-paths.service. second # [ 10.276873] systemd[1]: Reached target System Initialization. second # [ 10.278205] systemd[1]: Started Discard unused filesystem blocks once a week. second # [ 10.284501] systemd[1]: Started Daily Cleanup of Temporary Directories. second # [ 10.285145] systemd[1]: Reached target Timer Units. second # [ 10.285599] systemd[1]: Listening on D-Bus System Message Bus Socket. second # [ 10.286163] systemd[1]: Listening on Nix Daemon Socket. second # [ 10.293125] systemd[1]: Listening on Authorization Manager Agent Helper. second # [ 10.295351] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. second # [ 10.298217] systemd[1]: Reached target Socket Units. second # [ 10.300533] systemd[1]: Starting D-Bus System Message Bus... test # [ 10.356108] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 10.408789] systemd-logind[616]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) test # [ 10.420224] systemd-logind[616]: Watching system buttons on /dev/input/event0 (gpio-keys) test # [ 10.421038] systemd-logind[616]: New seat seat0. test # [ 10.421504] systemd[1]: Started User Login Management. test # [ 10.425910] systemd[1]: Starting linger-users.service... test # [ 10.452964] systemd[1]: Started Hostname Service. second # [ 10.438047] cfg80211: Loading compiled-in X.509 certificates for regulatory database test # [ 10.490747] systemd[1]: linger-users.service: Deactivated successfully. test # [ 10.494487] systemd[1]: Finished linger-users.service. second # [ 10.470926] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' second # [ 10.471494] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' second # [ 10.470695] dbus-broker-launch[530]: Looking up NSS user entry for 'systemd-timesync'... second # [ 10.482876] dbus-broker-launch[530]: NSS returned no entry for 'systemd-timesync' second # [ 10.484836] dbus-broker-launch[530]: Invalid user-name in /nix/store/024a16lrl5bks2rq7c078hn805ds6dd4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" second # [ 10.515955] systemd-networkd[527]: /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.567665] systemd-networkd[548]: eth0: Link UP test # [ 10.568318] systemd-networkd[548]: eth0: Gained carrier second # [ 10.522184] systemd-networkd[527]: /etc/systemd/network/99-wireless-client-dhcp.network: No valid settings found in the [Match] section, ignoring file. To match all interfaces, add Name=* in the [Match] section. second # [ 10.531930] systemd-networkd[527]: lo: Link UP second # [ 10.534063] systemd-networkd[527]: lo: Gained carrier second # [ 10.537330] (udev-worker)[459]: Network interface NamePolicy= disabled on kernel command line. second # [ 10.539438] systemd[1]: Started Network Management. second # [ 10.544850] (udev-worker)[466]: Network interface NamePolicy= disabled on kernel command line. test # [ 10.592676] systemd[1]: Started Network Manager. test # [ 10.595038] systemd[1]: Reached target Network. second # [ 10.546950] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service' second # [ 10.556948] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/pdjzsjaza8krvfmvr6a1j515biym3hbw-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service' second # [ 10.558762] systemd[1]: Starting Enable Persistent Storage in systemd-networkd... test # [ 10.601679] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 10.559430] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/9prxmvwvdr9mfqbb38w7jq4kicc7zi18-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service' test # [ 10.610964] systemd[1]: Starting Permit User Sessions... second # [ 10.575306] dbus-broker-launch[530]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/5cpm90flydbxw9km2kl7pk8i1i5sc3nk-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service' second # [ 10.585971] systemd[1]: Started D-Bus System Message Bus. second # [ 10.588656] systemd[1]: Reached target Basic System. second # [ 10.590742] systemd[1]: Starting Network Manager Script Dispatcher Service... second # [ 10.594205] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager... second # [ 10.605448] systemd[1]: Starting Network Manager... second # [ 10.645220] systemd[1]: Started backdoor.service. second # [ 10.656671] dbus-broker-launch[530]: Ready second # [ 10.669410] systemd[1]: Starting Import lastlog data into lastlog2 database... second # [ 10.700555] systemd[1]: Starting Name Service Cache Daemon (nsncd)... test # [ 10.765524] systemd[1]: Finished Permit User Sessions. second # [ 10.724130] systemd[1]: Starting Post-Boot Actions... test # [ 10.786545] systemd[1]: Started Getty on tty1. test # [ 10.792798] systemd[1]: Reached target Login Prompts. second # [ 10.777003] systemd[1]: Started Reset console on configuration changes. test # [ 10.830479] systemd-resolved[359]: eth0: Bus client set default route setting: yes test # [ 10.834471] systemd-resolved[359]: eth0: Bus client set DNS server list to: 10.0.2.3 second # [ 10.800501] dhnniqqyxyx1kvmbmrrk9766fbhx5chi-wifi-secrets[542]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets second # [ 10.823320] systemd[1]: Finished Enable Persistent Storage in systemd-networkd. test # [ 10.866985] NetworkManager[564]: [1788897893.6089] keyfile: load: "/var/run/NetworkManager/system-connections/open.nmconnection": failed to load connection: invalid connection: connection.id: property is empty test # [ 10.874918] NetworkManager[564]: [1788897893.6118] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty second # [ 10.842045] systemd-networkd[527]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network second # connecting to host... second # [ 10.858028] systemd-networkd[527]: eth1: Configuring with /etc/systemd/network/40-eth1.network. second # [ 10.858835] systemd-networkd[527]: eth1: Link UP second # [ 10.859262] systemd-networkd[527]: eth1: Gained carrier second # [ 10.859699] systemd-networkd[527]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network test # [ 10.910066] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully. test # [ 10.911687] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created. second # [ 10.890917] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully. second # [ 10.896997] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager. second # [ 10.978646] systemd[1]: Finished Post-Boot Actions. test # [ 11.023980] systemd[1]: Reached target Multi-User System. test # [ 11.026089] systemd[1]: Startup finished in 851ms (kernel) + 4.292s (initrd) + 5.881s (userspace) = 11.026s. second # [ 11.007833] systemd[1]: Finished Import lastlog data into lastlog2 database. second # [ 11.034513] systemd[1]: Started Network Manager Script Dispatcher Service. second # [ 11.039045] nsncd[546]: Sep 08 20:04:53.799 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" second # [ 11.046094] systemd[1]: Started Name Service Cache Daemon (nsncd). second # [ 11.046722] systemd[1]: Reached target Host and Network Name Lookups. second # [ 11.047258] systemd[1]: Reached target User and Group Name Lookups. second # [ 11.053804] systemd[1]: Starting User Login Management... second # [ 11.111630] mousedev: PS/2 mouse device common for all mice second # [ 11.142156] systemd[1]: Starting Hostname Service... second # [ 11.195937] systemd-logind[583]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) second # [ 11.201237] systemd-logind[583]: Watching system buttons on /dev/input/event0 (gpio-keys) second # [ 11.201946] systemd-logind[583]: New seat seat0. second # [ 11.206133] systemd[1]: Started User Login Management. second # [ 11.211165] systemd[1]: Starting linger-users.service... second # [ 11.285521] systemd[1]: Started Hostname Service. second # [ 11.300145] systemd[1]: linger-users.service: Deactivated successfully. second # [ 11.302087] systemd[1]: Finished linger-users.service. test # [ 11.425702] systemd-networkd[548]: eth1: Gained IPv6LL second # [ 11.388148] systemd-networkd[527]: eth0: Link UP second # [ 11.389438] systemd-networkd[527]: eth0: Gained carrier test: (finished: waiting for unit NetworkManager.service, in 11.69 seconds) test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection second # [ 11.413689] systemd[1]: Started Network Manager. second # [ 11.414996] systemd[1]: Reached target Network. second # [ 11.422133] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created... second # [ 11.430404] systemd[1]: Starting Permit User Sessions... test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.03 seconds) test: must succeed: cat /run/secrets/NetworkManager/wifi-secrets test: (finished: must succeed: cat /run/secrets/NetworkManager/wifi-secrets, in 0.04 seconds) test: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection test: (finished: must succeed: cat /run/NetworkManager/system-connections/open.nmconnection, in 0.04 seconds) (finished: run the VM test script, in 12.36 seconds) second # [ 11.574268] systemd[1]: Finished Permit User Sessions. test script finished in 12.44s cleanup kill QemuMachine (pid 47) second # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) test # [ 11.680942] 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/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.29 seconds)