vm-test-run-wifi
checks.aarch64-linux.wifi
· build #809
· raw
1build01: building ri64pss2lm70ka5pgv3x9g5i28ghb10d-vm-test-run-wifi.drv2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7additionally exposed symbols:8 second, test,9 vlan1,10 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_ssh11start all VMs12second: starting vm13test: starting vm14second # Disk image does not exist, creating the virtualisation disk image...15second: QEMU running (pid 14)16second # Formatting '/build/vm-state-second/tmp.Wss1Mna8QS', fmt=raw size=107374182417test # Disk image does not exist, creating the virtualisation disk image...18second # mke2fs 1.47.4 (6-Mar-2025)19test # Formatting '/build/vm-state-test/tmp.0K7Eq4Cyxe', fmt=raw size=107374182420second # Discarding device blocks: 0/262144 done21test # mke2fs 1.47.4 (6-Mar-2025)22second # Creating filesystem with 262144 4k blocks and 65536 inodes23test # Discarding device blocks: 0/262144 done24second # Filesystem UUID: 1f30eb8b-f6c6-49c0-85e1-d8e37c8927a825test # Creating filesystem with 262144 4k blocks and 65536 inodes26test: QEMU running (pid 15)27test # Filesystem UUID: 6d68b939-8020-4051-9b5e-d317edf4a33c28second # Superblock backups stored on blocks:29test # Superblock backups stored on blocks:30second # 32768, 98304, 163840, 22937631test # 32768, 98304, 163840, 22937632second # 33test # 34second # Allocating group tables: 0/8 done35test # Allocating group tables: 0/8 done36second # Writing inode tables: 0/8 done37test # Writing inode tables: 0/8 done38second # Creating journal (8192 blocks): done39test # Creating journal (8192 blocks): done40second # Writing superblocks and filesystem accounting information: 0/8 done41test # Writing superblocks and filesystem accounting information: 0/8 done42second # 43test # 44second # Virtualisation disk image created.45test # Virtualisation disk image created.46(finished: start all VMs, in 0.54 seconds)47test: waiting for unit NetworkManager.service48test: waiting for the VM to finish booting49second # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]50second # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 202651second # [ 0.000000] KASLR enabled52second # [ 0.000000] random: crng init done53second # [ 0.000000] Machine model: linux,dummy-virt54second # [ 0.000000] efi: UEFI not found.55second # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT56second # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]57second # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]58second # [ 0.000000] Zone ranges:59second # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]60second # [ 0.000000] DMA32 empty61second # [ 0.000000] Normal empty62second # [ 0.000000] Device empty63second # [ 0.000000] Movable zone start for each node64second # [ 0.000000] Early memory node ranges65second # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]66second # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]67second # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca0000068second # [ 0.000000] psci: probing for conduit method from DT.69second # [ 0.000000] psci: PSCIv1.3 detected in firmware.70second # [ 0.000000] psci: Using standard PSCI v0.2 function IDs71second # [ 0.000000] psci: Trusted OS migration not required72second # [ 0.000000] psci: SMC Calling Convention v1.173second # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)74second # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u31129675second # [ 0.000000] Detected PIPT I-cache on CPU076second # [ 0.000000] CPU features: detected: GICv3 CPU interface77second # [ 0.000000] CPU features: detected: Spectre-v478second # [ 0.000000] CPU features: detected: Spectre-BHB79second # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR80second # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)81second # [ 0.000000] CPU features: detected: ARM erratum 141804082second # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion83second # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing84second # [ 0.000000] alternatives: applying boot alternatives85second # [ 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/s614ay0b3m9f2hds0vf6jxk9bx9j93nz-nixos-system-second-test/init regInfo=/nix/store/kxrnvzrjbm9l06p8zjza49zl975fwd64-closure-info/registration console=ttyAMA0,115200n8 console=tty086second # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/kxrnvzrjbm9l06p8zjza49zl975fwd64-closure-info/registration", will be passed to user space.87second # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes88second # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)89second # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)90second # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB91second # [ 0.000000] software IO TLB: area num 1.92second # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)93second # [ 0.000000] Fallback order for Node 0: 094second # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214495second # [ 0.000000] Policy zone: DMA96second # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off97second # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=198second # [ 0.000000] allocated 2097152 bytes of page_ext99second # [ 0.000000] ftrace: allocating 74832 entries in 294 pages100second # [ 0.000000] ftrace: allocated 294 pages with 4 groups101second # [ 0.000000] rcu: Hierarchical RCU implementation.102second # [ 0.000000] rcu: RCU event tracing is enabled.103second # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.104second # [ 0.000000] Trampoline variant of Tasks RCU enabled.105second # [ 0.000000] Rude variant of Tasks RCU enabled.106second # [ 0.000000] Tracing variant of Tasks RCU enabled.107second # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.108second # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1109second # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.110second # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.111second # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.112second # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0113second # [ 0.000000] GICv3: 256 SPIs implemented114second # [ 0.000000] GICv3: 0 Extended SPIs implemented115second # [ 0.000000] Root IRQ handler: gic_handle_irq116second # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI117test # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]118second # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0119second # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000120second # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]121test # [ 0.000000] Linux version 6.18.54 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 25 14:35:54 UTC 2026122test # [ 0.000000] KASLR enabled123test # [ 0.000000] random: crng init done124second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)125test # [ 0.000000] Machine model: linux,dummy-virt126test # [ 0.000000] efi: UEFI not found.127second # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)128test # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT129second # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000130test # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]131second # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000132test # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fc07740-0x7fc0aebf]133test # [ 0.000000] Zone ranges:134second # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.135test # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]136test # [ 0.000000] DMA32 empty137test # [ 0.000000] Normal empty138second # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns139test # [ 0.000000] Device empty140test # [ 0.000000] Movable zone start for each node141second # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040142test # [ 0.000000] Early memory node ranges143second # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).144test # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]145test # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]146second # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns147test # [ 0.000000] cma: Reserved 32 MiB at 0x000000007ca00000148test # [ 0.000000] psci: probing for conduit method from DT.149second # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns150second # [ 0.000058] arm-pv: using stolen time PV151test # [ 0.000000] psci: PSCIv1.3 detected in firmware.152test # [ 0.000000] psci: Using standard PSCI v0.2 function IDs153second # [ 0.000340] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)154test # [ 0.000000] psci: Trusted OS migration not required155second # [ 0.000625] Console: colour dummy device 80x25156test # [ 0.000000] psci: SMC Calling Convention v1.1157second # [ 0.000636] printk: legacy console [tty0] enabled158test # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)159second # [ 0.000842] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)160test # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u311296161test # [ 0.000000] Detected PIPT I-cache on CPU0162second # [ 0.000847] pid_max: default: 32768 minimum: 301163test # [ 0.000000] CPU features: detected: GICv3 CPU interface164second # [ 0.000921] LSM: initializing lsm=capability,landlock,yama,bpf,ima165test # [ 0.000000] CPU features: detected: Spectre-v4166second # [ 0.001028] landlock: Up and running.167second # [ 0.001030] Yama: becoming mindful.168test # [ 0.000000] CPU features: detected: Spectre-BHB169second # [ 0.001355] LSM support for eBPF active170test # [ 0.000000] CPU features: kernel page table isolation forced ON by KASLR171test # [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI)172test # [ 0.000000] CPU features: detected: ARM erratum 1418040173second # [ 0.001496] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)174test # [ 0.000000] CPU features: detected: Broken broadcast TLBI completion175second # [ 0.001515] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)176test # [ 0.000000] CPU features: detected: SSBS not fully self-synchronizing177second # [ 0.004218] rcu: Hierarchical SRCU implementation.178test # [ 0.000000] alternatives: applying boot alternatives179second # [ 0.004226] rcu: Max phase no-delay instances is 1000.180second # [ 0.005138] fsl-mc MSI: its@8080000 domain created181second # [ 0.005319] EFI services will not be available.182second # [ 0.005409] smp: Bringing up secondary CPUs ...183second # [ 0.005442] smp: Brought up 1 node, 1 CPU184second # [ 0.005444] SMP: Total of 1 processors activated.185second # [ 0.005446] CPU: All CPU(s) started at EL1186test # [ 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/vfs9dmici0qj2ixr6gsxb1n9p1z1d6yj-nixos-system-test-test/init regInfo=/nix/store/dg0ls64gm8dyi4r0vfq08piwaixby15a-closure-info/registration console=ttyAMA0,115200n8 console=tty0187second # [ 0.005458] CPU features: detected: 32-bit EL0 Support188second # [ 0.005461] CPU features: detected: Data cache clean to the PoU not required for I/D coherence189test # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/dg0ls64gm8dyi4r0vfq08piwaixby15a-closure-info/registration", will be passed to user space.190second # [ 0.005464] CPU features: detected: Common not Private translations191test # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes192second # [ 0.005466] CPU features: detected: CRC32 instructions193test # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)194second # [ 0.005467] CPU features: detected: Data cache clean to Point of Persistence195second # [ 0.005470] CPU features: detected: Enhanced Virtualization Traps196test # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)197second # [ 0.005480] CPU features: detected: RCpc load-acquire (LDAPR)198test # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB199test # [ 0.000000] software IO TLB: area num 1.200second # [ 0.005482] CPU features: detected: LSE atomic instructions201second # [ 0.005484] CPU features: detected: Privileged Access Never202test # [ 0.000000] software IO TLB: mapped [mem 0x000000007c900000-0x000000007ca00000] (1MB)203second # [ 0.005486] CPU features: detected: PMUv3204test # [ 0.000000] Fallback order for Node 0: 0205second # [ 0.005488] CPU features: detected: RAS Extension Support206test # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144207test # [ 0.000000] Policy zone: DMA208second # [ 0.005492] CPU features: detected: Speculative Store Bypassing Safe (SSBS)209test # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off210second # [ 0.005512] alternatives: applying system-wide alternatives211test # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1212second # [ 0.006891] CPU features: detected: Hardware dirty bit management on CPU0213test # [ 0.000000] allocated 2097152 bytes of page_ext214test # [ 0.000000] ftrace: allocating 74832 entries in 294 pages215test # [ 0.000000] ftrace: allocated 294 pages with 4 groups216second # [ 0.007126] Memory: 892684K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114364K reserved, 32768K cma-reserved)217test # [ 0.000000] rcu: Hierarchical RCU implementation.218second # [ 0.007575] devtmpfs: initialized219test # [ 0.000000] rcu: RCU event tracing is enabled.220second # [ 0.009012] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)221test # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.222second # [ 0.009034] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).223test # [ 0.000000] Trampoline variant of Tasks RCU enabled.224test # [ 0.000000] Rude variant of Tasks RCU enabled.225second # [ 0.009175] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL226test # [ 0.000000] Tracing variant of Tasks RCU enabled.227second # [ 0.009178] 0 pages in range for non-PLT usage228second # [ 0.009179] 508272 pages in range for PLT usage229test # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.230second # [ 0.009301] pinctrl core: initialized pinctrl subsystem231test # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1232second # [ 0.010048] DMI not present or invalid.233second # [ 0.013137] NET: Registered PF_NETLINK/PF_ROUTE protocol family234test # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.235second # [ 0.015448] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations236test # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.237second # [ 0.015594] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations238test # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.239second # [ 0.015764] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations240test # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0241test # [ 0.000000] GICv3: 256 SPIs implemented242second # [ 0.015788] audit: initializing netlink subsys (disabled)243test # [ 0.000000] GICv3: 0 Extended SPIs implemented244second # [ 0.016113] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1245test # [ 0.000000] Root IRQ handler: gic_handle_irq246test # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI247second # [ 0.016407] thermal_sys: Registered thermal governor 'fair_share'248test # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0249second # [ 0.016409] thermal_sys: Registered thermal governor 'bang_bang'250test # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000251second # [ 0.016412] thermal_sys: Registered thermal governor 'step_wise'252test # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]253second # [ 0.016414] thermal_sys: Registered thermal governor 'user_space'254test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)255second # [ 0.016416] thermal_sys: Registered thermal governor 'power_allocator'256second # [ 0.016444] cpuidle: using governor ladder257second # [ 0.016450] cpuidle: using governor menu258test # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)259second # [ 0.016565] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.260second # [ 0.016585] ASID allocator initialised with 32768 entries261test # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000262second # [ 0.017218] Serial: AMBA PL011 UART driver263test # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000264second # [ 0.020608] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1265test # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.266second # [ 0.020775] printk: console [ttyAMA0] enabled267test # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns268test # [ 0.000000] arch_timer: Enabling local workaround for ARM erratum 1418040269test # [ 0.000000] arch_timer: cp15 timer running at 25.00MHz (virt).270test # [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns271test # [ 0.000000] sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns272test # [ 0.000056] arm-pv: using stolen time PV273test # [ 0.000320] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)274test # [ 0.000566] Console: colour dummy device 80x25275test # [ 0.000577] printk: legacy console [tty0] enabled276test # [ 0.000785] Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=100000)277test # [ 0.000790] pid_max: default: 32768 minimum: 301278test # [ 0.000857] LSM: initializing lsm=capability,landlock,yama,bpf,ima279test # [ 0.001013] landlock: Up and running.280test # [ 0.001015] Yama: becoming mindful.281test # [ 0.001324] LSM support for eBPF active282test # [ 0.001475] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)283test # [ 0.001494] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)284test # [ 0.003862] rcu: Hierarchical SRCU implementation.285test # [ 0.003868] rcu: Max phase no-delay instances is 1000.286test # [ 0.004877] fsl-mc MSI: its@8080000 domain created287test # [ 0.005064] EFI services will not be available.288test # [ 0.005144] smp: Bringing up secondary CPUs ...289test # [ 0.005174] smp: Brought up 1 node, 1 CPU290test # [ 0.005177] SMP: Total of 1 processors activated.291second # [ 0.093594] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages292test # [ 0.005178] CPU: All CPU(s) started at EL1293test # [ 0.005190] CPU features: detected: 32-bit EL0 Support294second # [ 0.093609] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page295second # [ 0.093612] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages296test # [ 0.005193] CPU features: detected: Data cache clean to the PoU not required for I/D coherence297second # [ 0.093616] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page298test # [ 0.005196] CPU features: detected: Common not Private translations299test # [ 0.005197] CPU features: detected: CRC32 instructions300second # [ 0.093618] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages301test # [ 0.005199] CPU features: detected: Data cache clean to Point of Persistence302second # [ 0.093620] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page303test # [ 0.005202] CPU features: detected: Enhanced Virtualization Traps304second # [ 0.093622] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages305test # [ 0.005211] CPU features: detected: RCpc load-acquire (LDAPR)306second # [ 0.093624] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page307test # [ 0.005214] CPU features: detected: LSE atomic instructions308second # [ 0.094589] fbcon: Taking over console309second # [ 0.094600] ACPI: Interpreter disabled.310test # [ 0.005216] CPU features: detected: Privileged Access Never311second # [ 0.095250] iommu: Default domain type: Translated312test # [ 0.005218] CPU features: detected: PMUv3313test # [ 0.005219] CPU features: detected: RAS Extension Support314second # [ 0.095254] iommu: DMA domain TLB invalidation policy: strict mode315second # [ 0.095522] SCSI subsystem initialized316test # [ 0.005223] CPU features: detected: Speculative Store Bypassing Safe (SSBS)317second # [ 0.097434] usbcore: registered new interface driver usbfs318test # [ 0.005243] alternatives: applying system-wide alternatives319second # [ 0.097464] usbcore: registered new interface driver hub320test # [ 0.006640] CPU features: detected: Hardware dirty bit management on CPU0321second # [ 0.097478] usbcore: registered new device driver usb322second # [ 0.097685] pps_core: LinuxPPS API ver. 1 registered323test # [ 0.006854] Memory: 892884K/1048576K available (24320K kernel code, 7090K rwdata, 26572K rodata, 4736K init, 1103K bss, 114368K reserved, 32768K cma-reserved)324second # [ 0.097688] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>325test # [ 0.007305] devtmpfs: initialized326second # [ 0.097693] PTP clock support registered327test # [ 0.008692] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)328second # [ 0.097724] EDAC MC: Ver: 3.0.0329test # [ 0.008718] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).330test # [ 0.008854] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL331test # [ 0.008857] 0 pages in range for non-PLT usage332test # [ 0.008858] 508272 pages in range for PLT usage333test # [ 0.008978] pinctrl core: initialized pinctrl subsystem334test # [ 0.009740] DMI not present or invalid.335test # [ 0.012901] NET: Registered PF_NETLINK/PF_ROUTE protocol family336test # [ 0.015219] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations337second # [ 0.106573] scmi_core: SCMI protocol bus registered338test # [ 0.015368] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations339second # [ 0.106908] FPGA manager framework340second # [ 0.109926] vgaarb: loaded341test # [ 0.015541] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations342test # [ 0.015565] audit: initializing netlink subsys (disabled)343test # [ 0.016100] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1344test # [ 0.016189] thermal_sys: Registered thermal governor 'fair_share'345test # [ 0.016190] thermal_sys: Registered thermal governor 'bang_bang'346test # [ 0.016193] thermal_sys: Registered thermal governor 'step_wise'347test # [ 0.016195] thermal_sys: Registered thermal governor 'user_space'348test # [ 0.016197] thermal_sys: Registered thermal governor 'power_allocator'349second # [ 0.111037] clocksource: Switched to clocksource arch_sys_counter350test # [ 0.016224] cpuidle: using governor ladder351test # [ 0.016230] cpuidle: using governor menu352test # [ 0.016350] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.353test # [ 0.016370] ASID allocator initialised with 32768 entries354test # [ 0.017015] Serial: AMBA PL011 UART driver355test # [ 0.020448] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1356test # [ 0.020613] printk: console [ttyAMA0] enabled357second # [ 0.121011] VFS: Disk quotas dquot_6.6.0358second # [ 0.121037] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)359second # [ 0.122436] netfs: FS-Cache loaded360second # [ 0.122538] pnp: PnP ACPI: disabled361second # [ 0.125831] NET: Registered PF_INET protocol family362second # [ 0.126004] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)363test # [ 0.092350] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages364test # [ 0.092364] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page365test # [ 0.092367] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages366test # [ 0.092371] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page367test # [ 0.092374] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages368test # [ 0.092375] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page369test # [ 0.092378] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages370test # [ 0.092380] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page371test # [ 0.093353] fbcon: Taking over console372test # [ 0.093363] ACPI: Interpreter disabled.373test # [ 0.094028] iommu: Default domain type: Translated374test # [ 0.094032] iommu: DMA domain TLB invalidation policy: strict mode375test # [ 0.094315] SCSI subsystem initialized376test # [ 0.094534] usbcore: registered new interface driver usbfs377test # [ 0.094564] usbcore: registered new interface driver hub378test # [ 0.094579] usbcore: registered new device driver usb379test # [ 0.094803] pps_core: LinuxPPS API ver. 1 registered380test # [ 0.094806] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>381test # [ 0.094811] PTP clock support registered382test # [ 0.094838] EDAC MC: Ver: 3.0.0383test # [ 0.104207] scmi_core: SCMI protocol bus registered384test # [ 0.104519] FPGA manager framework385test # [ 0.108128] vgaarb: loaded386test # [ 0.109179] clocksource: Switched to clocksource arch_sys_counter387second # [ 0.149441] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)388second # [ 0.149464] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389second # [ 0.149475] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)390test # [ 0.117953] VFS: Disk quotas dquot_6.6.0391second # [ 0.149510] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)392test # [ 0.117982] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)393second # [ 0.149576] TCP: Hash tables configured (established 8192 bind 8192)394test # [ 0.119494] netfs: FS-Cache loaded395test # [ 0.119584] pnp: PnP ACPI: disabled396second # [ 0.149659] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)397second # [ 0.149713] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)398second # [ 0.149735] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)399second # [ 0.149857] NET: Registered PF_UNIX/PF_LOCAL protocol family400second # [ 0.149911] NET: Registered PF_XDP protocol family401second # [ 0.149931] PCI: CLS 0 bytes, default 64402second # [ 0.150203] Trying to unpack rootfs image as initramfs...403test # [ 0.122765] NET: Registered PF_INET protocol family404test # [ 0.122945] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)405second # [ 0.163060] kvm [1]: HYP mode not available406test # [ 0.146700] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)407test # [ 0.146723] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)408test # [ 0.146736] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)409test # [ 0.146772] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)410test # [ 0.146838] TCP: Hash tables configured (established 8192 bind 8192)411test # [ 0.146925] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)412test # [ 0.146950] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)413test # [ 0.146972] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)414test # [ 0.147115] NET: Registered PF_UNIX/PF_LOCAL protocol family415test # [ 0.147152] NET: Registered PF_XDP protocol family416test # [ 0.147172] PCI: CLS 0 bytes, default 64417test # [ 0.147390] Trying to unpack rootfs image as initramfs...418test # [ 0.155321] kvm [1]: HYP mode not available419second # [ 0.227446] Initialise system trusted keyrings420second # [ 0.227565] workingset: timestamp_bits=42 max_order=18 bucket_order=0421second # [ 0.227936] squashfs: version 4.0 (2009/01/31) Phillip Lougher422second # [ 0.227972] 9p: Installing v9fs 9p2000 file system support423second # [ 0.246795] Key type asymmetric registered424second # [ 0.246814] Asymmetric key parser 'x509' registered425second # [ 0.246884] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)426second # [ 0.255093] io scheduler mq-deadline registered427second # [ 0.255102] io scheduler kyber registered428second # [ 0.257387] pl061_gpio 9030000.pl061: PL061 GPIO chip registered429test # [ 0.229564] Initialise system trusted keyrings430test # [ 0.229685] workingset: timestamp_bits=42 max_order=18 bucket_order=0431test # [ 0.230057] squashfs: version 4.0 (2009/01/31) Phillip Lougher432test # [ 0.230101] 9p: Installing v9fs 9p2000 file system support433second # [ 0.260222] ledtrig-cpu: registered to indicate activity on CPUs434second # [ 0.260605] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:435second # [ 0.260623] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000436second # [ 0.260636] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000437second # [ 0.260641] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000438second # [ 0.260666] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits439second # [ 0.260687] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]440second # [ 0.260756] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00441second # [ 0.260772] pci_bus 0000:00: root bus resource [bus 00-ff]442second # [ 0.260775] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]443second # [ 0.260778] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]444second # [ 0.260780] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]445second # [ 0.260852] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint446second # [ 0.261279] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint447second # [ 0.261391] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]448second # [ 0.261399] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]449second # [ 0.261418] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]450second # [ 0.261428] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]451second # [ 0.261699] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint452second # [ 0.261808] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]453second # [ 0.261817] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]454second # [ 0.261836] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]455second # [ 0.262115] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint456second # [ 0.262223] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]457second # [ 0.262231] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]458second # [ 0.262249] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]459test # [ 0.248885] Key type asymmetric registered460test # [ 0.248902] Asymmetric key parser 'x509' registered461second # [ 0.262517] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint462test # [ 0.248961] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)463second # [ 0.262625] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]464second # [ 0.262633] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]465second # [ 0.262651] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]466second # [ 0.262938] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint467second # [ 0.283790] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]468second # [ 0.283803] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]469second # [ 0.283821] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]470second # [ 0.284157] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint471second # [ 0.284268] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]472second # [ 0.284276] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]473second # [ 0.284295] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]474second # [ 0.284561] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint475second # [ 0.284671] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]476second # [ 0.284679] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]477second # [ 0.284697] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]478second # [ 0.284710] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]479test # [ 0.257232] io scheduler mq-deadline registered480test # [ 0.257241] io scheduler kyber registered481second # [ 0.284987] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint482second # [ 0.285098] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]483test # [ 0.259619] pl061_gpio 9030000.pl061: PL061 GPIO chip registered484test # [ 0.259948] ledtrig-cpu: registered to indicate activity on CPUs485second # [ 0.285116] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]486test # [ 0.260254] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:487second # [ 0.285388] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint488second # [ 0.285499] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]489test # [ 0.260270] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000490second # [ 0.285517] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]491test # [ 0.260283] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000492second # [ 0.285758] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint493test # [ 0.260288] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000494second # [ 0.285864] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]495test # [ 0.260324] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits496second # [ 0.286021] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint497second # [ 0.286218] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]498test # [ 0.260343] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]499second # [ 0.286227] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]500test # [ 0.260421] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00501test # [ 0.260437] pci_bus 0000:00: root bus resource [bus 00-ff]502second # [ 0.286245] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]503test # [ 0.260441] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]504second # [ 0.286524] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint505test # [ 0.260443] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]506second # [ 0.286633] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]507second # [ 0.286641] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]508test # [ 0.260446] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]509second # [ 0.286659] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]510test # [ 0.260531] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint511test # [ 0.260960] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint512test # [ 0.261072] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]513test # [ 0.261081] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]514test # [ 0.261101] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]515test # [ 0.261110] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]516second # [ 0.307098] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned517second # [ 0.307109] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned518second # [ 0.307112] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned519second # [ 0.307166] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned520test # [ 0.277461] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint521test # [ 0.277577] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]522second # [ 0.307197] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned523test # [ 0.277586] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]524second # [ 0.307226] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned525test # [ 0.277604] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]526second # [ 0.307256] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned527test # [ 0.277890] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint528test # [ 0.277999] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]529second # [ 0.307286] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned530test # [ 0.278008] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]531second # [ 0.307315] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned532test # [ 0.278026] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]533second # [ 0.307345] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned534test # [ 0.278293] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint535second # [ 0.307375] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned536second # [ 0.307405] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned537second # [ 0.307499] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned538second # [ 0.307528] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned539second # [ 0.307540] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned540second # [ 0.307552] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned541second # [ 0.307565] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned542test # [ 0.278400] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]543second # [ 0.307577] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned544test # [ 0.278408] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]545second # [ 0.307589] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned546test # [ 0.278427] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]547second # [ 0.307601] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned548test # [ 0.278698] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint549second # [ 0.307614] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned550test # [ 0.278805] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]551second # [ 0.307626] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned552test # [ 0.278813] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]553second # [ 0.307639] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned554test # [ 0.278832] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]555second # [ 0.307652] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned556test # [ 0.279109] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint557second # [ 0.307665] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned558test # [ 0.279216] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]559second # [ 0.307677] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned560test # [ 0.279225] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]561second # [ 0.307689] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned562test # [ 0.279243] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]563second # [ 0.307701] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned564test # [ 0.279516] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint565second # [ 0.307714] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned566test # [ 0.279626] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]567second # [ 0.307732] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned568test # [ 0.279634] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]569second # [ 0.307744] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned570test # [ 0.279653] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]571second # [ 0.307756] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned572test # [ 0.279666] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]573second # [ 0.307769] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned574test # [ 0.279958] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint575second # [ 0.307781] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned576test # [ 0.280072] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]577second # [ 0.307798] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]578second # [ 0.307802] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]579test # [ 0.280090] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]580second # [ 0.307805] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]581test # [ 0.280361] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint582second # [ 0.308473] pci 0000:00:0a.0: enabling device (0000 -> 0002)583test # [ 0.280474] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]584test # [ 0.280492] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]585test # [ 0.280735] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint586test # [ 0.280844] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]587test # [ 0.281007] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint588test # [ 0.285875] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]589test # [ 0.285885] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]590test # [ 0.285904] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]591test # [ 0.286211] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint592test # [ 0.286322] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]593test # [ 0.286330] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]594test # [ 0.286349] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]595test # [ 0.286754] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned596test # [ 0.286761] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned597test # [ 0.286764] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned598test # [ 0.286795] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned599second # [ 0.335141] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)600test # [ 0.286824] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned601second # [ 0.337152] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)602test # [ 0.286854] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned603second # [ 0.339030] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)604test # [ 0.286883] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned605test # [ 0.286912] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned606test # [ 0.286941] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned607test # [ 0.286971] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned608test # [ 0.287000] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned609test # [ 0.287029] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned610test # [ 0.287117] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned611test # [ 0.287146] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned612test # [ 0.287158] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned613test # [ 0.287171] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned614test # [ 0.287183] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned615test # [ 0.287259] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned616test # [ 0.287272] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned617test # [ 0.287284] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned618test # [ 0.287297] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned619test # [ 0.287309] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned620test # [ 0.287321] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned621test # [ 0.287334] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned622test # [ 0.287347] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned623test # [ 0.287359] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned624test # [ 0.287372] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned625test # [ 0.287383] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned626test # [ 0.287396] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned627test # [ 0.287413] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned628test # [ 0.287426] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned629test # [ 0.287438] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned630test # [ 0.287450] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned631test # [ 0.287462] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned632test # [ 0.287478] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]633test # [ 0.287483] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]634test # [ 0.287485] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]635test # [ 0.288168] pci 0000:00:0a.0: enabling device (0000 -> 0002)636second # [ 0.356864] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)637second # [ 0.358546] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)638second # [ 0.361561] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)639second # [ 0.364227] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)640test # [ 0.338538] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)641test # [ 0.340579] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)642second # [ 0.375493] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)643second # [ 0.377120] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)644second # [ 0.380086] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)645second # [ 0.382305] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)646test # [ 0.351333] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)647test # [ 0.353766] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)648test # [ 0.355673] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)649second # [ 0.393664] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled650second # [ 0.394644] msm_serial: driver initialized651second # [ 0.394719] SuperH (H)SCI(F) driver initialized652second # [ 0.394769] STM32 USART driver initialized653test # [ 0.365615] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)654test # [ 0.367515] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)655test # [ 0.377332] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)656test # [ 0.379557] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)657test # [ 0.381747] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)658test # [ 0.383882] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)659second # [ 0.417660] loop: module loaded660second # [ 0.417783] virtio_blk virtio5: 1/0/0 default/read/poll queues661second # [ 0.418348] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)662test # [ 0.395598] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled663test # [ 0.396553] msm_serial: driver initialized664test # [ 0.396623] SuperH (H)SCI(F) driver initialized665test # [ 0.396664] STM32 USART driver initialized666second # [ 0.427408] megasas: 07.734.00.00-rc1667second # [ 0.427866] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]668second # [ 0.433349] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000669second # [ 0.433372] Intel/Sharp Extended Query Table at 0x0031670second # [ 0.443064] Using buffer write method671second # [ 0.443098] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]672second # [ 0.445853] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000673second # [ 0.445868] Intel/Sharp Extended Query Table at 0x0031674second # [ 0.449638] Using buffer write method675second # [ 0.449649] Concatenating MTD devices:676second # [ 0.449651] (0): "0.flash"677second # [ 0.449654] (1): "0.flash"678second # [ 0.449655] into device "0.flash"679test # [ 0.422113] loop: module loaded680test # [ 0.422243] virtio_blk virtio5: 1/0/0 default/read/poll queues681test # [ 0.422845] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682test # [ 0.425590] megasas: 07.734.00.00-rc1683test # [ 0.426106] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]684test # [ 0.450337] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000685test # [ 0.450364] Intel/Sharp Extended Query Table at 0x0031686test # [ 0.452062] Using buffer write method687test # [ 0.452114] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]688test # [ 0.462827] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689test # [ 0.462842] Intel/Sharp Extended Query Table at 0x0031690test # [ 0.464685] Using buffer write method691test # [ 0.464698] Concatenating MTD devices:692test # [ 0.464700] (0): "0.flash"693test # [ 0.464702] (1): "0.flash"694test # [ 0.464703] into device "0.flash"695second # [ 0.642880] Freeing initrd memory: 25500K696second # [ 0.649732] tun: Universal TUN/TAP device driver, 1.6697second # [ 0.652350] thunder_xcv, ver 1.0698second # [ 0.652365] thunder_bgx, ver 1.0699second # [ 0.652373] nicpf, ver 1.0700second # [ 0.652689] e1000: Intel(R) PRO/1000 Network Driver701second # [ 0.652693] e1000: Copyright (c) 1999-2006 Intel Corporation.702second # [ 0.652705] e1000e: Intel(R) PRO/1000 Network Driver703second # [ 0.652709] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.704second # [ 0.652721] igb: Intel(R) Gigabit Ethernet Network Driver705second # [ 0.652722] igb: Copyright (c) 2007-2014 Intel Corporation.706second # [ 0.652732] igbvf: Intel(R) Gigabit Virtual Function Network Driver707second # [ 0.652734] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.708second # [ 0.652795] sky2: driver version 1.30709second # [ 0.653610] usbcore: registered new interface driver usb-storage710second # [ 0.653651] usbcore: registered new interface driver usbserial_generic711second # [ 0.653668] usbserial: USB Serial support registered for generic712second # [ 0.653956] hv_vmbus: registering driver hyperv_keyboard713second # [ 0.654984] ehci-pci 0000:00:0a.0: EHCI Host Controller714second # [ 0.655009] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1715second # [ 0.662520] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000716second # [ 0.662699] rtc-pl031 9010000.pl031: registered as rtc0717second # [ 0.662726] rtc-pl031 9010000.pl031: setting system clock to 2026-09-30T00:04:00 UTC (1790726640)718second # [ 0.662919] i2c_dev: i2c /dev entries driver719second # [ 0.666396] sdhci: Secure Digital Host Controller Interface driver720second # [ 0.666401] sdhci: Copyright(c) Pierre Ossman721second # [ 0.666545] Synopsys Designware Multimedia Card Interface Driver722second # [ 0.666718] sdhci-pltfm: SDHCI platform and OF driver helper723test # [ 0.648951] Freeing initrd memory: 25504K724test # [ 0.655846] tun: Universal TUN/TAP device driver, 1.6725test # [ 0.658511] thunder_xcv, ver 1.0726test # [ 0.658528] thunder_bgx, ver 1.0727test # [ 0.658537] nicpf, ver 1.0728test # [ 0.658838] e1000: Intel(R) PRO/1000 Network Driver729test # [ 0.658841] e1000: Copyright (c) 1999-2006 Intel Corporation.730test # [ 0.658854] e1000e: Intel(R) PRO/1000 Network Driver731test # [ 0.658860] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.732test # [ 0.658872] igb: Intel(R) Gigabit Ethernet Network Driver733test # [ 0.658874] igb: Copyright (c) 2007-2014 Intel Corporation.734test # [ 0.658883] igbvf: Intel(R) Gigabit Virtual Function Network Driver735test # [ 0.658885] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.736test # [ 0.658948] sky2: driver version 1.30737test # [ 0.659838] usbcore: registered new interface driver usb-storage738test # [ 0.659953] usbcore: registered new interface driver usbserial_generic739test # [ 0.659972] usbserial: USB Serial support registered for generic740test # [ 0.660277] hv_vmbus: registering driver hyperv_keyboard741test # [ 0.661377] ehci-pci 0000:00:0a.0: EHCI Host Controller742test # [ 0.661405] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1743test # [ 0.661594] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000744second # [ 0.669452] hid: raw HID events driver (C) Jiri Kosina745second # [ 0.669593] usbcore: registered new interface driver usbhid746test # [ 0.669280] rtc-pl031 9010000.pl031: registered as rtc0747second # [ 0.669595] usbhid: USB HID core driver748test # [ 0.669315] rtc-pl031 9010000.pl031: setting system clock to 2026-09-30T00:04:00 UTC (1790726640)749test # [ 0.669491] i2c_dev: i2c /dev entries driver750test # [ 0.671068] sdhci: Secure Digital Host Controller Interface driver751test # [ 0.671087] sdhci: Copyright(c) Pierre Ossman752test # [ 0.671276] Synopsys Designware Multimedia Card Interface Driver753test # [ 0.671461] sdhci-pltfm: SDHCI platform and OF driver helper754test # [ 0.672314] hid: raw HID events driver (C) Jiri Kosina755test # [ 0.672476] usbcore: registered new interface driver usbhid756second # [ 0.712136] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00757test # [ 0.672479] usbhid: USB HID core driver758second # [ 0.712521] hub 1-0:1.0: USB hub found759test # [ 0.679215] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00760second # [ 0.712585] hub 1-0:1.0: 6 ports detected761test # [ 0.679593] hub 1-0:1.0: USB hub found762test # [ 0.679618] hub 1-0:1.0: 6 ports detected763second # [ 0.712891] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available764second # [ 0.713694] drop_monitor: Initializing network drop monitor service765test # [ 0.685090] hw perfevents: enabled with armv8_pmuv3 PMU driver, 7 (0,8000003f) counters available766second # [ 0.713813] NET: Registered PF_INET6 protocol family767second # [ 0.714455] Segment Routing with IPv6768second # [ 0.714474] In-situ OAM (IOAM) with IPv6769second # [ 0.714518] NET: Registered PF_PACKET protocol family770second # [ 0.714610] 9pnet: Installing 9P2000 support771test # [ 0.686638] drop_monitor: Initializing network drop monitor service772test # [ 0.686807] NET: Registered PF_INET6 protocol family773test # [ 0.687437] Segment Routing with IPv6774test # [ 0.687467] In-situ OAM (IOAM) with IPv6775test # [ 0.687513] NET: Registered PF_PACKET protocol family776test # [ 0.687605] 9pnet: Installing 9P2000 support777second # [ 0.720125] Key type dns_resolver registered778second # [ 0.722983] registered taskstats version 1779test # [ 0.691340] Key type dns_resolver registered780second # [ 0.723810] Loading compiled-in X.509 certificates781test # [ 0.694535] registered taskstats version 1782test # [ 0.694694] Loading compiled-in X.509 certificates783second # [ 0.729008] Demotion targets for Node 0: null784second # [ 0.729082] Key type .fscrypt registered785second # [ 0.729084] Key type fscrypt-provisioning registered786second # [ 0.729185] ima: No TPM chip found, activating TPM-bypass!787second # [ 0.729195] ima: Allocated hash algorithm: sha1788second # [ 0.729245] ima: No architecture policies found789test # [ 0.700116] Demotion targets for Node 0: null790test # [ 0.700188] Key type .fscrypt registered791second # [ 0.729692] input: gpio-keys as /devices/platform/gpio-keys/input/input0792test # [ 0.700191] Key type fscrypt-provisioning registered793test # [ 0.700295] ima: No TPM chip found, activating TPM-bypass!794test # [ 0.700306] ima: Allocated hash algorithm: sha1795test # [ 0.700355] ima: No architecture policies found796test # [ 0.700824] input: gpio-keys as /devices/platform/gpio-keys/input/input0797second # [ 0.742124] clk: Disabling unused clocks798second # [ 0.742133] PM: genpd: Disabling unused power domains799second # [ 0.745363] Freeing unused kernel memory: 4736K800second # [ 0.745447] Run /init as init process801test # [ 0.713551] clk: Disabling unused clocks802test # [ 0.713561] PM: genpd: Disabling unused power domains803test # [ 0.716026] Freeing unused kernel memory: 4736K804test # [ 0.716121] Run /init as init process805second # [ 0.765342] systemd[1]: Successfully made /usr/ read-only.806test # [ 0.739678] systemd[1]: Successfully made /usr/ read-only.807test # [ 0.925231] usb 1-1: new high-speed USB device number 2 using ehci-pci808second # [ 0.963085] usb 1-1: new high-speed USB device number 2 using ehci-pci809second # [ 1.099387] systemd[1]: systemd 260.4 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)810second # [ 1.099418] systemd[1]: Detected virtualization qemu.811second # [ 1.099456] systemd[1]: Detected architecture arm64.812second # [ 1.099466] systemd[1]: Running in initrd.813second # [ 1.100480] systemd[1]: Initializing machine ID from random generator.814test # [ 1.073696] systemd[1]: systemd 260.4 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)815second # [ 1.100832] systemd[1]: Hostname set to <second>.816test # [ 1.073745] systemd[1]: Detected virtualization qemu.817test # [ 1.073863] systemd[1]: Detected architecture arm64.818test # [ 1.073877] systemd[1]: Running in initrd.819test # [ 1.074900] systemd[1]: Initializing machine ID from random generator.820test # [ 1.075199] systemd[1]: Hostname set to <test>.821test # [ 1.091718] 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/input1822second # [ 1.129774] 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/input1823test # [ 1.177399] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0824second # [ 1.215233] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0825second # [ 1.218446] systemd[1]: Queued start job for default target Initrd Default Target.826test # [ 1.195307] systemd[1]: Queued start job for default target Initrd Default Target.827second # [ 1.228589] systemd[1]: Created slice Slice /system/modprobe.828second # [ 1.228754] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.829second # [ 1.228778] systemd[1]: Expecting device /dev/disk/by-label/nixos...830second # [ 1.228799] systemd[1]: Reached target Path Units.831second # [ 1.228812] systemd[1]: Reached target Slice Units.832second # [ 1.228827] systemd[1]: Reached target Swaps.833second # [ 1.228841] systemd[1]: Reached target Timer Units.834second # [ 1.228991] systemd[1]: Listening on D-Bus System Message Bus Socket.835second # [ 1.229113] systemd[1]: Listening on Journal Socket (/dev/log).836second # [ 1.229229] systemd[1]: Listening on Journal Sockets.837second # [ 1.229302] systemd[1]: Listening on udev Control Socket.838second # [ 1.229389] systemd[1]: Listening on udev Kernel Socket.839second # [ 1.229409] systemd[1]: Reached target Socket Units.840test # [ 1.202947] systemd[1]: Created slice Slice /system/modprobe.841second # [ 1.230474] systemd[1]: Starting Create List of Static Device Nodes...842test # [ 1.203268] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.843test # [ 1.203300] systemd[1]: Expecting device /dev/disk/by-label/nixos...844test # [ 1.203323] systemd[1]: Reached target Path Units.845test # [ 1.203338] systemd[1]: Reached target Slice Units.846test # [ 1.203355] systemd[1]: Reached target Swaps.847test # [ 1.203372] systemd[1]: Reached target Timer Units.848test # [ 1.203550] systemd[1]: Listening on D-Bus System Message Bus Socket.849test # [ 1.203692] systemd[1]: Listening on Journal Socket (/dev/log).850test # [ 1.203853] systemd[1]: Listening on Journal Sockets.851test # [ 1.203941] systemd[1]: Listening on udev Control Socket.852test # [ 1.203999] systemd[1]: Listening on udev Kernel Socket.853test # [ 1.204020] systemd[1]: Reached target Socket Units.854test # [ 1.205276] systemd[1]: Starting Create List of Static Device Nodes...855second # [ 1.245407] systemd[1]: Starting Load Kernel Module 9pnet_virtio...856second # [ 1.245452] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs857second # [ 1.246350] systemd[1]: Mounting Kernel Configuration File System...858test # [ 1.221104] systemd[1]: Starting Load Kernel Module 9pnet_virtio...859test # [ 1.221158] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs860second # [ 1.254792] systemd[1]: Starting Journal Service...861test # [ 1.224093] systemd[1]: Mounting Kernel Configuration File System...862test # [ 1.233359] systemd[1]: Starting Journal Service...863second # [ 1.275165] systemd[1]: Starting Load Kernel Modules...864second # [ 1.275218] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki865test # [ 1.250298] systemd[1]: Starting Load Kernel Modules...866test # [ 1.250344] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki867test # [ 1.258834] systemd[1]: Starting Coldplug All udev Devices...868test # [ 1.260111] systemd[1]: Finished Create List of Static Device Nodes.869test # [ 1.260857] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.870second # [ 1.287186] systemd[1]: Starting Coldplug All udev Devices...871second # [ 1.295961] systemd[1]: Finished Create List of Static Device Nodes.872second # [ 1.296999] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.873second # [ 1.297179] systemd[1]: Finished Load Kernel Module 9pnet_virtio.874second # [ 1.297365] systemd[1]: Mounted Kernel Configuration File System.875test # [ 1.269841] systemd[1]: Finished Load Kernel Module 9pnet_virtio.876test # [ 1.270207] systemd[1]: Mounted Kernel Configuration File System.877second # [ 1.306603] systemd-journald[73]: Collecting audit messages is disabled.878second # [ 1.312655] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...879test # [ 1.293401] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...880test # [ 1.297244] usb 1-2: new high-speed USB device number 3 using ehci-pci881test # [ 1.301813] systemd-journald[73]: Collecting audit messages is disabled.882second # [ 1.339078] usb 1-2: new high-speed USB device number 3 using ehci-pci883second # [ 1.339669] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.884second # [ 1.340731] systemd[1]: Starting Create Static Device Nodes in /dev...885test # [ 1.316222] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.886test # [ 1.325243] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev887second # [ 1.361307] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.888test # [ 1.330380] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.889test # [ 1.331377] systemd[1]: Starting Create Static Device Nodes in /dev...890test # [ 1.343076] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0891test # [ 1.343292] [drm] features: -virgl +edid -resource_blob -host_visible892test # [ 1.343294] [drm] features: -context_init893test # [ 1.343757] [drm] number of scanouts: 1894test # [ 1.343766] [drm] number of cap sets: 0895second # [ 1.375154] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev896test # [ 1.347346] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic897test # [ 1.347352] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0898second # [ 1.383650] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0899second # [ 1.383846] [drm] features: -virgl +edid -resource_blob -host_visible900second # [ 1.383848] [drm] features: -context_init901second # [ 1.384290] [drm] number of scanouts: 1902second # [ 1.384298] [drm] number of cap sets: 0903second # [ 1.385007] systemd[1]: Finished Create Static Device Nodes in /dev.904second # [ 1.385197] systemd[1]: Reached target Preparation for Local File Systems.905second # [ 1.385217] systemd[1]: Reached target Local File Systems.906second # [ 1.390647] systemd[1]: Starting Rule-based Manager for Device Events and Files...907second # [ 1.392355] systemd-modules-load[74]: Inserted module 'dm_mod'908second # [ 1.393101] systemd-modules-load[74]: Module 'virtio_balloon' is built in909second # [ 1.400948] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic910second # [ 1.400954] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0911second # [ 1.398513] systemd-modules-load[74]: Module 'virtio_console' is built in912test # [ 1.369571] Console: switching to colour frame buffer device 160x50913second # [ 1.404386] systemd[1]: Started Journal Service.914test # [ 1.382523] systemd[1]: Finished Create Static Device Nodes in /dev.915test # [ 1.382704] systemd[1]: Reached target Preparation for Local File Systems.916test # [ 1.382722] systemd[1]: Reached target Local File Systems.917test # [ 1.387142] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device918test # [ 1.387430] systemd[1]: Starting Rule-based Manager for Device Events and Files...919second # [ 1.424971] Console: switching to colour frame buffer device 160x50920test # [ 1.395117] systemd-modules-load[74]: Inserted module 'dm_mod'921test # [ 1.395822] systemd-modules-load[74]: Module 'virtio_balloon' is built in[ 1.397910] systemd[1]: Started Journal Service.922test # 923test # [ 1.397025] systemd-modules-load[74]: Module 'virtio_console' is built in924test # [ 1.399083] systemd-modules-load[74]: Inserted module 'virtio_gpu'925second # [ 1.429001] systemd[1]: Starting Create System Files and Directories...926test # [ 1.401920] systemd-modules-load[74]: Module 'virtio_rng' is built in927test # [ 1.404343] systemd[1]: Finished Load Kernel Modules.928test # [ 1.411729] systemd[1]: Starting Apply Kernel Variables...929second # [ 1.447842] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device930second # [ 1.448897] systemd-modules-load[74]: Inserted module 'virtio_gpu'931second # [ 1.449536] systemd-modules-load[74]: Module 'virtio_rng' is built in932test # [ 1.420908] systemd[1]: Starting Create System Files and Directories...933second # [ 1.454933] systemd[1]: Finished Load Kernel Modules.934second # [ 1.455422] systemd[1]: Starting Apply Kernel Variables...935second # [ 1.466794] systemd-udevd[81]: Using default interface naming scheme 'v260'.936second # [ 1.468858] systemd[1]: Finished Create System Files and Directories.937test # [ 1.454348] 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/input2938test # [ 1.454548] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0939second # [ 1.492837] 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/input2940second # [ 1.493033] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0941test # [ 1.460153] systemd[1]: Finished Apply Kernel Variables.942second # [ 1.490815] systemd[1]: Finished Apply Kernel Variables.943test # [ 1.465801] systemd-udevd[81]: Using default interface naming scheme 'v260'.944test # [ 1.467878] systemd[1]: Finished Create System Files and Directories.945second # [ 1.506324] systemd[1]: Started Rule-based Manager for Device Events and Files.946test # [ 1.490966] systemd[1]: Started Rule-based Manager for Device Events and Files.947second # [ 1.556138] systemd[1]: Starting Virtual Console Setup...948test # [ 1.540089] systemd[1]: Starting Virtual Console Setup...949second # [ 1.604462] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.950second # [ 1.608131] systemd[1]: Finished Virtual Console Setup.951test # [ 1.589388] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.952test # [ 1.592162] systemd[1]: Finished Virtual Console Setup.953second # [ 1.875923] systemd[1]: Finished Coldplug All udev Devices.954second # [ 1.876636] systemd[1]: Reached target System Initialization.955second # [ 1.877148] systemd[1]: Reached target Basic System.956test # [ 1.861382] systemd[1]: Finished Coldplug All udev Devices.957test # [ 1.861962] systemd[1]: Reached target System Initialization.958test # [ 1.862433] systemd[1]: Reached target Basic System.959second # [ 1.970578] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.960second # [ 1.993192] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.961test # [ 1.975382] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.962test # [ 1.985870] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.963second # [ 2.041103] systemd[1]: Found device /dev/disk/by-label/nixos.964second # [ 2.042550] systemd[1]: Reached target Initrd Root Device.965second # [ 2.044665] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...966test # [ 2.020953] systemd[1]: Found device /dev/disk/by-label/nixos.967test # [ 2.023227] systemd[1]: Reached target Initrd Root Device.968test # [ 2.025588] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...969second # [ 2.090450] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks970test # [ 2.072203] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks971second # [ 2.106091] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.972test # [ 2.079339] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.973second # [ 2.284166] systemd[1]: Mounting /sysroot...974test # [ 2.260448] systemd[1]: Mounting /sysroot...975second # [ 2.311323] systemd[1]: Mounted /sysroot.976second # [ 2.315885] EXT4-fs (vda): mounted filesystem 1f30eb8b-f6c6-49c0-85e1-d8e37c8927a8 r/w with ordered data mode. Quota mode: none.977second # [ 2.312961] systemd[1]: Reached target Initrd Root File System.978second # [ 2.314750] systemd[1]: Starting Mountpoints Configured in the Real Root...979test # [ 2.290988] EXT4-fs (vda): mounted filesystem 6d68b939-8020-4051-9b5e-d317edf4a33c r/w with ordered data mode. Quota mode: none.980test # [ 2.289340] systemd[1]: Mounted /sysroot.981test # [ 2.291425] systemd[1]: Reached target Initrd Root File System.982test # [ 2.292764] systemd[1]: Starting Mountpoints Configured in the Real Root...983second # [ 2.334641] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.984second # [ 2.340495] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...985second # [ 2.342454] systemd[1]: Reloading...986test # [ 2.315065] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.987test # [ 2.319725] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...988test # [ 2.322826] systemd[1]: Reloading...989second # [ 2.513925] systemd[1]: Reloading finished in 174 ms.990second # [ 2.524085] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...991test # [ 2.497368] systemd[1]: Reloading finished in 176 ms.992second # [ 2.527303] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...993second # [ 2.528993] systemd[1]: Starting Load Kernel Module 9pnet_virtio...994test # [ 2.504697] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...995test # [ 2.505433] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...996second # [ 2.535560] systemd[1]: initrd-parse-etc.service: Deactivated successfully.997second # [ 2.538478] systemd[1]: Finished Mountpoints Configured in the Real Root.998test # [ 2.508879] systemd[1]: Starting Load Kernel Module 9pnet_virtio...999second # [ 2.539116] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1000test # [ 2.512106] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1001test # [ 2.515527] systemd[1]: Finished Mountpoints Configured in the Real Root.1002test # [ 2.516282] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1003second # [ 2.555631] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1004second # [ 2.556701] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1005test # [ 2.531758] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1006test # [ 2.532864] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1007second # [ 2.869800] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/lib/udev/mtd_probe": No such file or directory1008second # [ 2.876748] (udev-worker)[101]: mtd0ro: /nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/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 directory1009second # [ 2.883284] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1010second # [ 2.884955] systemd[1]: Stopped Virtual Console Setup.1011second # [ 2.886294] systemd[1]: Stopping Virtual Console Setup...1012second # [ 2.888348] systemd[1]: Starting Virtual Console Setup...1013test # [ 2.856809] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/lib/udev/mtd_probe": No such file or directory1014test # [ 2.860222] (udev-worker)[95]: mtd0ro: /nix/store/vbj8zd206qm6g50xygfw68fqzf71fmfa-systemd-260.4/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 directory1015test # [ 2.884355] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1016test # [ 2.885118] systemd[1]: Stopped Virtual Console Setup.1017second # [ 2.915159] systemd-vconsole-setup[142]: Configuration of first virtual console was skipped, ignoring remaining ones.1018second # [ 2.917786] systemd[1]: Finished Virtual Console Setup.1019test # [ 2.888123] systemd[1]: Stopping Virtual Console Setup...1020test # [ 2.888777] systemd[1]: Starting Virtual Console Setup...1021test # [ 2.896916] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1022test # [ 2.897790] systemd[1]: Stopped Virtual Console Setup.1023test # [ 2.899201] systemd[1]: Starting Virtual Console Setup...1024test # [ 2.918354] systemd-vconsole-setup[144]: Configuration of first virtual console was skipped, ignoring remaining ones.1025test # [ 2.920573] systemd[1]: Finished Virtual Console Setup.1026second # [ 3.286089] systemd[1]: Mounting /sysroot/nix/.ro-store...1027test # [ 3.258684] systemd[1]: Mounting /sysroot/nix/.ro-store...1028second # [ 3.297680] systemd[1]: Mounting /sysroot/nix/.rw-store...1029test # [ 3.268293] systemd[1]: Mounting /sysroot/nix/.rw-store...1030second # [ 3.300199] systemd[1]: Mounting /sysroot/run...1031test # [ 3.277732] systemd[1]: Mounting /sysroot/run...1032second # [ 3.312718] systemd[1]: Mounting /sysroot/tmp/shared...1033test # [ 3.289655] systemd[1]: Mounting /sysroot/tmp/shared...1034second # [ 3.325938] systemd[1]: Mounting /sysroot/tmp/xchg...1035test # [ 3.311579] systemd[1]: Mounting /sysroot/tmp/xchg...1036test # [ 3.325255] systemd[1]: Mounted /sysroot/nix/.rw-store.1037second # [ 3.356673] systemd[1]: Mounted /sysroot/nix/.rw-store.1038second # [ 3.366802] systemd[1]: Mounted /sysroot/nix/.ro-store.1039second # [ 3.369340] systemd[1]: Mounted /sysroot/run.1040test # [ 3.339356] systemd[1]: Starting rw-sysroot-nix-store.service...1041test # [ 3.341920] systemd[1]: Mounted /sysroot/run.1042second # [ 3.374299] systemd[1]: Mounted /sysroot/tmp/shared.1043test # [ 3.346386] systemd[1]: Mounted /sysroot/nix/.ro-store.1044second # [ 3.377333] systemd[1]: Mounted /sysroot/tmp/xchg.1045second # [ 3.380275] systemd[1]: Starting rw-sysroot-nix-store.service...1046test # [ 3.351353] systemd[1]: Mounted /sysroot/tmp/shared.1047test # [ 3.362300] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1048test # [ 3.363516] systemd[1]: Finished rw-sysroot-nix-store.service.1049test # [ 3.366519] systemd[1]: Mounted /sysroot/tmp/xchg.1050second # [ 3.397210] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1051second # [ 3.398287] systemd[1]: Finished rw-sysroot-nix-store.service.1052second # [ 3.400374] systemd[1]: Mounting /sysroot/nix/store...1053second # [ 3.433848] systemd[1]: Mounted /sysroot/nix/store.1054second # [ 3.435398] systemd[1]: Reached target Initrd File Systems.1055second # [ 3.438364] systemd[1]: Starting Find NixOS closure...1056second # [ 3.444900] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1057second # [ 3.472543] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1058second # [ 3.483030] systemd[1]: Finished Find NixOS closure.1059second # [ 3.485509] systemd[1]: Reached target Initrd Default Target.1060second # [ 3.486755] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1061second # [ 3.515225] systemd[1]: Stopped target Initrd Default Target.1062second # [ 3.520051] systemd[1]: Stopped target Basic System.1063second # [ 3.520748] systemd[1]: Stopped target Initrd Root Device.1064second # [ 3.521508] systemd[1]: Stopped target Path Units.1065second # [ 3.522360] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1066second # [ 3.523272] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1067second # [ 3.526420] systemd[1]: Stopped target Slice Units.1068second # [ 3.527430] systemd[1]: Stopped target Socket Units.1069second # [ 3.532180] systemd[1]: Stopped target System Initialization.1070second # [ 3.532828] systemd[1]: Stopped target Swaps.1071second # [ 3.533367] systemd[1]: Stopped target Timer Units.1072second # [ 3.534159] systemd[1]: dbus.socket: Deactivated successfully.1073second # [ 3.534811] systemd[1]: Closed D-Bus System Message Bus Socket.1074second # [ 3.535656] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1075second # [ 3.537495] systemd[1]: Stopped Find NixOS closure.1076second # [ 3.538730] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1077second # [ 3.544162] systemd[1]: Starting rw-sysroot-nix-store.service...1078second # [ 3.544997] systemd[1]: systemd-sysctl.service: Deactivated successfully.1079second # [ 3.545544] systemd[1]: Stopped Apply Kernel Variables.1080second # [ 3.545985] systemd[1]: systemd-modules-load.service: Deactivated successfully.1081second # [ 3.546563] systemd[1]: Stopped Load Kernel Modules.1082second # [ 3.547105] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1083second # [ 3.547757] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1084second # [ 3.549535] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1085second # [ 3.556563] systemd[1]: Stopped Create System Files and Directories.1086second # [ 3.557751] systemd[1]: Stopped target Local File Systems.1087second # [ 3.560527] systemd[1]: Stopped target Preparation for Local File Systems.1088second # [ 3.563044] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1089second # [ 3.566118] systemd[1]: Stopped Coldplug All udev Devices.1090second # [ 3.568658] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1091second # [ 3.569373] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1092second # [ 3.574638] systemd[1]: Stopped Virtual Console Setup.1093second # [ 3.575115] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1094second # [ 3.576291] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1095second # [ 3.577095] systemd[1]: initrd-cleanup.service: Deactivated successfully.1096second # [ 3.578554] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1097second # [ 3.580197] systemd[1]: systemd-udevd.service: Deactivated successfully.1098second # [ 3.580756] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1099second # [ 3.582267] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1100second # [ 3.583024] systemd[1]: Finished rw-sysroot-nix-store.service.1101second # [ 3.584375] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1102second # [ 3.588147] systemd[1]: Closed udev Control Socket.1103second # [ 3.588622] systemd[1]: Starting Cleanup udev Database...1104second # [ 3.589094] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1105second # [ 3.589727] systemd[1]: Stopped Create Static Device Nodes in /dev.1106second # [ 3.590256] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1107second # [ 3.590927] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1108second # [ 3.591529] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1109second # [ 3.593204] systemd[1]: Stopped Create List of Static Device Nodes.1110second # [ 3.616583] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1111second # [ 3.618264] systemd[1]: Finished Cleanup udev Database.1112second # [ 3.618796] systemd[1]: Reached target Switch Root.1113second # [ 3.619560] systemd[1]: Starting NixOS Activation...1114second # [ 3.762465] initrd-nixos-activation-start[179]: booting system configuration /nix/store/s614ay0b3m9f2hds0vf6jxk9bx9j93nz-nixos-system-second-test1115second # [ 3.814771] initrd-nixos-activation-start[179]: running activation script...1116second # [ 4.256335] initrd-nixos-activation-start[202]: setting up /etc...1117test # [ 4.256969] systemd[1]: Mounting /sysroot/nix/store...1118test # [ 4.301779] systemd[1]: Mounted /sysroot/nix/store.1119test # [ 4.304230] systemd[1]: Reached target Initrd File Systems.1120test # [ 4.306698] systemd[1]: Starting Find NixOS closure...1121test # [ 4.313908] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1122test # [ 4.357401] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1123test # [ 4.360394] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1124test # [ 4.375001] systemd[1]: Finished Find NixOS closure.1125test # [ 4.377099] systemd[1]: Reached target Initrd Default Target.1126test # [ 4.378470] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1127test # [ 4.402530] systemd[1]: Stopped target Initrd Default Target.1128test # [ 4.403984] systemd[1]: Stopped target Basic System.1129test # [ 4.405230] systemd[1]: Stopped target Initrd Root Device.1130test # [ 4.408108] systemd[1]: Stopped target Path Units.1131test # [ 4.408887] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1132test # [ 4.409757] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1133test # [ 4.411712] systemd[1]: Stopped target Slice Units.1134test # [ 4.413636] systemd[1]: Stopped target Socket Units.1135test # [ 4.414273] systemd[1]: Stopped target System Initialization.1136test # [ 4.416153] systemd[1]: Stopped target Swaps.1137test # [ 4.417032] systemd[1]: Stopped target Timer Units.1138test # [ 4.420125] systemd[1]: dbus.socket: Deactivated successfully.1139test # [ 4.420816] systemd[1]: Closed D-Bus System Message Bus Socket.1140test # [ 4.421495] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1141test # [ 4.423038] systemd[1]: Stopped Find NixOS closure.1142test # [ 4.424745] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1143test # [ 4.426352] systemd[1]: Starting rw-sysroot-nix-store.service...1144test # [ 4.428565] systemd[1]: systemd-sysctl.service: Deactivated successfully.1145test # [ 4.432603] systemd[1]: Stopped Apply Kernel Variables.1146test # [ 4.433168] systemd[1]: systemd-modules-load.service: Deactivated successfully.1147test # [ 4.435336] systemd[1]: Stopped Load Kernel Modules.1148test # [ 4.437805] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1149test # [ 4.440146] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1150test # [ 4.443148] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1151test # [ 4.443829] systemd[1]: Stopped Create System Files and Directories.1152test # [ 4.445387] systemd[1]: Stopped target Local File Systems.1153test # [ 4.446369] systemd[1]: Stopped target Preparation for Local File Systems.1154test # [ 4.449221] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1155test # [ 4.450347] systemd[1]: Stopped Coldplug All udev Devices.1156test # [ 4.450887] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1157test # [ 4.451518] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1158test # [ 4.457717] systemd[1]: Stopped Virtual Console Setup.1159test # [ 4.458254] systemd[1]: initrd-cleanup.service: Deactivated successfully.1160test # [ 4.460855] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1161test # [ 4.462122] systemd[1]: systemd-udevd.service: Deactivated successfully.1162test # [ 4.462880] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1163test # [ 4.464203] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1164test # [ 4.465827] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1165test # [ 4.466556] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1166test # [ 4.468353] systemd[1]: Finished rw-sysroot-nix-store.service.1167test # [ 4.469099] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1168second # [ 4.499442] initrd-nixos-activation-start[202]: setting up age secrets...1169test # [ 4.472240] systemd[1]: Closed udev Control Socket.1170test # [ 4.472706] systemd[1]: Starting Cleanup udev Database...1171test # [ 4.473156] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1172test # [ 4.473763] systemd[1]: Stopped Create Static Device Nodes in /dev.1173test # [ 4.474277] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1174test # [ 4.474914] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1175test # [ 4.475487] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1176test # [ 4.478386] systemd[1]: Stopped Create List of Static Device Nodes.1177test # [ 4.499312] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1178test # [ 4.501484] systemd[1]: Finished Cleanup udev Database.1179test # [ 4.501996] systemd[1]: Reached target Switch Root.1180test # [ 4.502704] systemd[1]: Starting NixOS Activation...1181second # [ 4.715387] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1182second # [ 4.717170] systemd[1]: Finished NixOS Activation.1183second # [ 4.717876] systemd[1]: Starting Switch Root...1184test # [ 4.697506] initrd-nixos-activation-start[181]: booting system configuration /nix/store/vfs9dmici0qj2ixr6gsxb1n9p1z1d6yj-nixos-system-test-test1185second # [ 4.736149] systemd[1]: Switching root.1186second # [ 4.782412] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1187test # [ 4.767428] initrd-nixos-activation-start[181]: running activation script...1188test # [ 5.230084] initrd-nixos-activation-start[204]: setting up /etc...1189second # [ 5.332456] systemd[1]: systemd 260.4 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)1190second # [ 5.332546] systemd[1]: Detected virtualization qemu.1191second # [ 5.332592] systemd[1]: Detected architecture arm64.1192second # [ 5.332701] systemd[1]: Detected first boot.1193second # [ 5.348293] systemd[1]: Initializing machine ID from random generator.1194test # [ 5.444455] initrd-nixos-activation-start[204]: setting up age secrets...1195second # [ 5.605002] systemd[1]: bpf-restrict-fs: LSM BPF program attached1196test # [ 5.706300] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1197test # [ 5.707957] systemd[1]: Finished NixOS Activation.1198test # [ 5.708765] systemd[1]: Starting Switch Root...1199second # [ 5.756815] systemd[1]: Applying preset policy.1200test # [ 5.728944] systemd[1]: Switching root.1201test # [ 5.781870] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1202second # [ 6.349108] systemd[1]: Populated /etc with preset unit settings.1203test # [ 6.365646] systemd[1]: systemd 260.4 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)1204test # [ 6.365735] systemd[1]: Detected virtualization qemu.1205test # [ 6.365781] systemd[1]: Detected architecture arm64.1206test # [ 6.365895] systemd[1]: Detected first boot.1207test # [ 6.381916] systemd[1]: Initializing machine ID from random generator.1208test # [ 6.677659] systemd[1]: bpf-restrict-fs: LSM BPF program attached1209test # [ 6.860372] systemd[1]: Applying preset policy.1210second # [ 6.905259] systemd[1]: initrd-switch-root.service: Deactivated successfully.1211second # [ 6.905558] systemd[1]: Stopped initrd-switch-root.service.1212second # [ 6.906563] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1213second # [ 6.909890] systemd[1]: Created slice Slice /system/getty.1214second # [ 6.910442] systemd[1]: Created slice User and Session Slice.1215second # [ 6.910623] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1216second # [ 6.913213] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1217second # [ 6.913325] systemd[1]: Expecting device /dev/hvc0...1218second # [ 6.913854] systemd[1]: Expecting device /dev/ttyAMA0...1219second # [ 6.914384] systemd[1]: Reached target Local Encrypted Volumes.1220second # [ 6.914985] systemd[1]: Stopped target initrd-fs.target.1221second # [ 6.918226] systemd[1]: Stopped target initrd-root-fs.target.1222second # [ 6.918909] systemd[1]: Stopped target initrd-switch-root.target.1223second # [ 6.920439] systemd[1]: Reached target Virtual Machines and Containers.1224second # [ 6.920986] systemd[1]: Reached target Path Units.1225second # [ 6.921521] systemd[1]: Reached target Remote File Systems.1226second # [ 6.922060] systemd[1]: Reached target Slice Units.1227second # [ 6.922603] systemd[1]: Reached target Swaps.1228second # [ 6.928972] systemd[1]: Listening on Process Core Dump Socket.1229second # [ 6.932627] systemd[1]: Listening on Credential Encryption/Decryption.1230second # [ 6.937659] systemd[1]: Starting Journal Log Access Socket...1231second # [ 6.938771] systemd[1]: Listening on Journal Audit Socket.1232second # [ 6.940869] systemd[1]: Listening on Network Management Metrics Varlink Socket.1233second # [ 6.941489] systemd[1]: Listening on Network Management Netlink Socket.1234second # [ 6.942180] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1235second # [ 6.942694] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1236second # [ 6.946345] systemd[1]: Listening on udev Control Socket.1237second # [ 6.950757] systemd[1]: Mounting Huge Pages File System...1238second # [ 6.954076] systemd[1]: Mounting POSIX Message Queue File System...1239second # [ 6.958057] systemd[1]: Mounting Kernel Debug File System...1240second # [ 6.964367] systemd[1]: Mounting Kernel Trace File System...1241second # [ 6.973369] systemd[1]: Starting Create List of Static Device Nodes...1242second # [ 6.981054] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1243second # [ 6.983646] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1244second # [ 6.994552] systemd[1]: Mounting Kernel Configuration File System...1245second # [ 6.996538] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1246second # [ 6.997325] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1247second # [ 7.010473] systemd[1]: Starting Load Kernel Module fuse...1248second # [ 7.014555] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671249second # [ 7.064627] systemd[1]: Starting Journal Service...1250second # [ 7.092210] systemd[1]: Starting Load Kernel Modules...1251second # [ 7.119098] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1252second # [ 7.134587] systemd[1]: Starting Remount Root and Kernel File Systems...1253second # [ 7.137260] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1254second # [ 7.149792] systemd[1]: Starting Coldplug All udev Devices...1255second # [ 7.172758] systemd[1]: Listening on Journal Log Access Socket.1256second # [ 7.187918] systemd[1]: Mounted Huge Pages File System.1257second # [ 7.201523] systemd[1]: Mounted POSIX Message Queue File System.1258second # [ 7.203902] systemd[1]: Mounted Kernel Debug File System.1259second # [ 7.208684] systemd[1]: Mounted Kernel Trace File System.1260second # [ 7.209873] fuse: init (API version 7.45)1261second # [ 7.213476] systemd[1]: Finished Create List of Static Device Nodes.1262second # [ 7.215387] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1263second # [ 7.220974] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1264second # [ 7.222606] systemd-journald[301]: Collecting audit messages is enabled.1265second # [ 7.224876] systemd[1]: Mounted Kernel Configuration File System.1266second # [ 7.228545] systemd[1]: modprobe@fuse.service: Deactivated successfully.1267second # [ 7.232227] systemd[1]: Finished Load Kernel Module fuse.1268second # [ 7.234854] systemd[1]: Finished Load Kernel Modules.1269second # [ 7.238029] systemd[1]: Queued start job for default target Multi-User System.1270second # [ 7.239195] systemd[1]: systemd-journald.service: Deactivated successfully.1271second # [ 7.239956] systemd-modules-load[302]: Module 'atkbd' is built in1272second # [ 7.240834] systemd-modules-load[302]: Module 'ctr' is built in1273second # [ 7.249441] systemd[1]: Mounting FUSE Control File System...1274second # [ 7.246613] systemd-modules-load[302]: Module 'loop' is built in1275second # [ 7.255572] systemd[1]: Starting Firewall...1276second # [ 7.281899] systemd[1]: Starting Apply Kernel Variables...1277second # [ 7.294463] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1278second # [ 7.296438] EXT4-fs (vda): re-mounted 1f30eb8b-f6c6-49c0-85e1-d8e37c8927a8.1279second # [ 7.310068] systemd[1]: Started Journal Service.1280second # [ 7.305620] systemd-oomd[303]: No swap; memory pressure usage will be degraded1281second # [ 7.321968] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1282second # [ 7.325947] systemd[1]: Finished Remount Root and Kernel File Systems.1283second # [ 7.391208] systemd[1]: Starting Flush Journal to Persistent Storage...1284second # [ 7.392583] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1285second # [ 7.403813] systemd[1]: Starting Load/Save OS Random Seed...1286second # [ 7.411387] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1287second # [ 7.412399] systemd[1]: Mounted FUSE Control File System.1288second # [ 7.438574] systemd[1]: Finished Apply Kernel Variables.1289second # [ 7.449249] systemd[1]: Starting Network Name Resolution...1290test # [ 7.452666] systemd[1]: Populated /etc with preset unit settings.1291second # [ 7.515650] systemd-journald[301]: Received client request to flush runtime journal.1292second # [ 7.584929] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1293second # [ 7.591412] systemd[1]: Starting Create Static Device Nodes in /dev...1294second # [ 7.600342] systemd[1]: Finished Load/Save OS Random Seed.1295second # [ 7.601402] systemd[1]: Reached target First Boot Complete.1296second # [ 7.604335] systemd[1]: Finished Flush Journal to Persistent Storage.1297second # [ 7.658228] systemd-resolved[330]: Positive Trust Anchors:1298second # [ 7.660588] systemd-resolved[330]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1299second # [ 7.663859] systemd-resolved[330]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161300second # [ 7.670409] systemd-resolved[330]: 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 test1301second # [ 7.698230] systemd[1]: Finished Create Static Device Nodes in /dev.1302second # [ 7.704254] systemd[1]: Reached target Preparation for Local File Systems.1303second # [ 7.706360] systemd[1]: Starting Rule-based Manager for Device Events and Files...1304second # [ 7.814212] systemd-udevd[346]: Using default interface naming scheme 'v260'.1305second # [ 7.901625] systemd[1]: Mounting /run/wrappers...1306second # [ 7.922512] systemd-resolved[330]: Using system hostname 'second'.1307second # [ 7.928067] systemd[1]: Started Network Name Resolution.1308second # [ 7.967102] systemd[1]: Mounted /run/wrappers.1309second # [ 7.968310] systemd[1]: Reached target Local File Systems.1310second # [ 7.973408] systemd[1]: Listening on Boot Loader Control Service Socket.1311second # [ 7.977740] systemd[1]: Starting register-nix-paths.service...1312second # [ 7.980344] systemd[1]: Starting Create SUID/SGID Wrappers...1313second # [ 7.981434] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1314second # [ 7.992264] systemd[1]: Starting Save Transient machine-id to Disk...1315second # [ 8.000093] systemd[1]: Starting Create System Files and Directories...1316test # [ 8.022655] systemd[1]: initrd-switch-root.service: Deactivated successfully.1317test # [ 8.022941] systemd[1]: Stopped initrd-switch-root.service.1318test # [ 8.023962] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1319test # [ 8.024568] systemd[1]: Created slice Slice /system/getty.1320test # [ 8.024999] systemd[1]: Created slice User and Session Slice.1321test # [ 8.029087] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1322test # [ 8.030917] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1323test # [ 8.031452] systemd[1]: Expecting device /dev/hvc0...1324test # [ 8.032029] systemd[1]: Expecting device /dev/ttyAMA0...1325test # [ 8.032638] systemd[1]: Reached target Local Encrypted Volumes.1326test # [ 8.035602] systemd[1]: Stopped target initrd-fs.target.1327test # [ 8.036101] systemd[1]: Stopped target initrd-root-fs.target.1328test # [ 8.036667] systemd[1]: Stopped target initrd-switch-root.target.1329test # [ 8.039053] systemd[1]: Reached target Virtual Machines and Containers.1330test # [ 8.039548] systemd[1]: Reached target Path Units.1331test # [ 8.040105] systemd[1]: Reached target Remote File Systems.1332test # [ 8.040677] systemd[1]: Reached target Slice Units.1333test # [ 8.043483] systemd[1]: Reached target Swaps.1334test # [ 8.047911] systemd[1]: Listening on Process Core Dump Socket.1335test # [ 8.051696] systemd[1]: Listening on Credential Encryption/Decryption.1336test # [ 8.056641] systemd[1]: Starting Journal Log Access Socket...1337test # [ 8.058594] systemd[1]: Listening on Journal Audit Socket.1338test # [ 8.059239] systemd[1]: Listening on Network Management Metrics Varlink Socket.1339test # [ 8.059846] systemd[1]: Listening on Network Management Netlink Socket.1340test # [ 8.060502] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1341test # [ 8.060992] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1342test # [ 8.065109] systemd[1]: Listening on udev Control Socket.1343test # [ 8.069526] systemd[1]: Mounting Huge Pages File System...1344test # [ 8.072398] systemd[1]: Mounting POSIX Message Queue File System...1345test # [ 8.077472] systemd[1]: Mounting Kernel Debug File System...1346test # [ 8.082614] systemd[1]: Mounting Kernel Trace File System...1347test # [ 8.090557] systemd[1]: Starting Create List of Static Device Nodes...1348test # [ 8.102039] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1349test # [ 8.102549] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1350test # [ 8.115142] systemd[1]: Mounting Kernel Configuration File System...1351test # [ 8.116087] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1352test # [ 8.116762] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1353second # [ 8.149514] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1354test # [ 8.128988] systemd[1]: Starting Load Kernel Module fuse...1355second # [ 8.154775] systemd[1]: Finished Save Transient machine-id to Disk.1356test # [ 8.132013] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671357second # [ 8.194834] systemd[1]: Started Rule-based Manager for Device Events and Files.1358test # [ 8.172716] systemd[1]: Starting Journal Service...1359test # [ 8.177788] systemd[1]: Starting Load Kernel Modules...1360second # [ 8.218807] systemd[1]: Finished Create System Files and Directories.1361test # [ 8.205710] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1362second # [ 8.236324] systemd[1]: Starting Rebuild Journal Catalog...1363second # [ 8.239949] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1364test # [ 8.227944] systemd[1]: Starting Remount Root and Kernel File Systems...1365test # [ 8.232159] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1366test # [ 8.255039] systemd[1]: Starting Coldplug All udev Devices...1367test # [ 8.281839] fuse: init (API version 7.45)1368test # [ 8.282995] systemd[1]: Listening on Journal Log Access Socket.1369test # [ 8.284120] systemd[1]: Mounted Huge Pages File System.1370test # [ 8.284909] systemd[1]: Mounted POSIX Message Queue File System.1371test # [ 8.293638] systemd[1]: Mounted Kernel Debug File System.1372test # [ 8.295993] systemd[1]: Mounted Kernel Trace File System.1373test # [ 8.301954] systemd[1]: Finished Create List of Static Device Nodes.1374test # [ 8.305155] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1375test # [ 8.310201] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1376test # [ 8.312369] systemd[1]: Mounted Kernel Configuration File System.1377test # [ 8.317505] systemd[1]: modprobe@fuse.service: Deactivated successfully.1378test # [ 8.322112] systemd[1]: Finished Load Kernel Module fuse.1379test # [ 8.334489] systemd[1]: Mounting FUSE Control File System...1380second # [ 8.375131] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1381test # [ 8.346512] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1382test # [ 8.353786] systemd[1]: Finished Load Kernel Modules.1383test # [ 8.369755] systemd-journald[325]: Collecting audit messages is enabled.1384test # [ 8.375305] systemd[1]: Queued start job for default target Multi-User System.1385test # [ 8.383934] systemd[1]: systemd-journald.service: Deactivated successfully.[ 8.385275] EXT4-fs (vda): re-mounted 6d68b939-8020-4051-9b5e-d317edf4a33c.1386test # 1387test # [ 8.390039] systemd-modules-load[326]: Module 'atkbd' is built in1388test # [ 8.394286] systemd[1]: Starting Firewall...1389test # [ 8.394502] systemd-modules-load[326]: Module 'ctr' is built in1390test # [ 8.398510] systemd-modules-load[326]: Module 'loop' is built in1391test # [ 8.414283] systemd[1]: Starting Apply Kernel Variables...1392test # [ 8.415358] systemd[1]: Started Journal Service.1393second # [ 8.458924] systemd[1]: Finished Rebuild Journal Catalog.1394test # [ 8.436405] systemd[1]: Finished Remount Root and Kernel File Systems.1395test # [ 8.440815] systemd-oomd[327]: No swap; memory pressure usage will be degraded1396second # [ 8.476515] systemd[1]: Starting Update is Completed...1397test # [ 8.454967] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1398test # [ 8.492290] systemd[1]: Starting Flush Journal to Persistent Storage...1399test # [ 8.494245] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1400second # [ 8.527818] systemd[1]: Finished Coldplug All udev Devices.1401test # [ 8.499952] systemd[1]: Starting Load/Save OS Random Seed...1402test # [ 8.505149] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1403test # [ 8.509331] systemd[1]: Mounted FUSE Control File System.1404second # [ 8.562107] systemd[1]: Finished Update is Completed.1405test # [ 8.550872] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1406test # [ 8.553940] systemd[1]: Starting Create Static Device Nodes in /dev...1407test # [ 8.587040] systemd[1]: Finished Apply Kernel Variables.1408test # [ 8.601874] systemd[1]: Starting Network Name Resolution...1409test # [ 8.612286] systemd-journald[325]: Received client request to flush runtime journal.1410test # [ 8.668548] systemd[1]: Finished Load/Save OS Random Seed.1411test # [ 8.672885] systemd[1]: Reached target First Boot Complete.1412test # [ 8.679406] systemd[1]: Finished Flush Journal to Persistent Storage.1413test # [ 8.698928] systemd[1]: Finished Create Static Device Nodes in /dev.1414test # [ 8.699555] systemd[1]: Reached target Preparation for Local File Systems.1415test # [ 8.709707] systemd[1]: Starting Rule-based Manager for Device Events and Files...1416second # [ 8.776131] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1417test # [ 8.791284] systemd-resolved[356]: Positive Trust Anchors:1418test # [ 8.792107] systemd-resolved[356]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d1419test # [ 8.794145] systemd-resolved[356]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b161420test # [ 8.798384] systemd-resolved[356]: 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 test1421test # [ 8.852183] systemd-udevd[363]: Using default interface naming scheme 'v260'.1422test # [ 9.016461] systemd-resolved[356]: Using system hostname 'test'.1423test # [ 9.025632] systemd[1]: Mounting /run/wrappers...1424test # [ 9.032187] systemd[1]: Started Network Name Resolution.1425second # [ 9.068843] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1426test # [ 9.097957] systemd[1]: Mounted /run/wrappers.1427test # [ 9.098580] systemd[1]: Reached target Local File Systems.1428second # [ 9.133723] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1429test # [ 9.104123] systemd[1]: Listening on Boot Loader Control Service Socket.1430second # [ 9.136798] systemd[1]: Finished Create SUID/SGID Wrappers.1431test # [ 9.108683] systemd[1]: Starting register-nix-paths.service...1432second # [ 9.140241] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1433test # [ 9.119691] systemd[1]: Starting Create SUID/SGID Wrappers...1434test # [ 9.122550] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1435test # [ 9.126272] systemd[1]: Starting Save Transient machine-id to Disk...1436test # [ 9.137656] systemd[1]: Starting Create System Files and Directories...1437test # [ 9.197922] systemd[1]: Started Rule-based Manager for Device Events and Files.1438second # [ 9.317272] systemd[1]: Finished register-nix-paths.service.1439test # [ 9.288547] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1440second # [ 9.319838] systemd[1]: Reached target System Initialization.1441second # [ 9.322480] systemd[1]: Started Discard unused filesystem blocks once a week.1442second # [ 9.324484] systemd[1]: Started Daily Cleanup of Temporary Directories.1443second # [ 9.328957] systemd[1]: Reached target Timer Units.1444second # [ 9.330768] systemd[1]: Listening on D-Bus System Message Bus Socket.1445second # [ 9.333352] systemd[1]: Listening on Nix Daemon Socket.1446second # [ 9.336936] systemd[1]: Listening on Authorization Manager Agent Helper.1447test # [ 9.309210] systemd[1]: Finished Save Transient machine-id to Disk.1448second # [ 9.339141] systemd[1]: Listening on Hostname Service Socket.1449second # [ 9.342651] systemd[1]: Reached target Socket Units.1450second # [ 9.344584] systemd[1]: Starting D-Bus System Message Bus...1451second # [ 9.369265] systemd[1]: Finished Firewall.1452second # [ 9.372234] systemd[1]: Reached target Preparation for Network.1453second # [ 9.376520] systemd[1]: Starting Network Management...1454test # [ 9.379770] systemd[1]: Finished Create System Files and Directories.1455test # [ 9.395126] systemd[1]: Starting Rebuild Journal Catalog...1456test # [ 9.412614] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1457second # [ 9.468730] (udev-worker)[453]: Network interface NamePolicy= disabled on kernel command line.1458second # [ 9.481831] (udev-worker)[449]: Network interface NamePolicy= disabled on kernel command line.1459second # [ 9.549761] dbus-broker-launch[532]: Looking up NSS user entry for 'systemd-timesync'...1460test # [ 9.529251] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1461second # [ 9.576835] dbus-broker-launch[532]: NSS returned no entry for 'systemd-timesync'1462second # [ 9.579278] dbus-broker-launch[532]: Invalid user-name in /nix/store/s3qds9d5y4dgflsgdjkj7pfnrbsm10sr-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1463second # [ 9.622363] cfg80211: Loading compiled-in X.509 certificates for regulatory database1464second # [ 9.645606] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1465test # [ 9.621383] systemd[1]: Finished Rebuild Journal Catalog.1466second # [ 9.649643] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1467test # [ 9.629826] systemd[1]: Starting Update is Completed...1468test # [ 9.633302] systemd[1]: Finished Coldplug All udev Devices.1469second # [ 9.655677] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/sx40vhhwgyvayv82kxrdfsb24z1wvcrg-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1470second # [ 9.671772] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1471second # [ 9.672273] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1472second # [ 9.671811] dbus-broker-launch[532]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1473second # [ 9.682335] systemd[1]: Started D-Bus System Message Bus.1474second # [ 9.685772] systemd[1]: Reached target Basic System.1475second # [ 9.686870] systemd[1]: Starting Network Manager Script Dispatcher Service...1476second # [ 9.693212] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1477second # [ 9.700188] systemd[1]: Starting Network Manager...1478second # [ 9.710449] systemd[1]: Started backdoor.service.1479test # [ 9.696832] systemd[1]: Finished Update is Completed.1480second # [ 9.733962] dbus-broker-launch[532]: Ready1481second # [ 9.751874] systemd[1]: Starting Import lastlog data into lastlog2 database...1482second # [ 9.769925] systemd-networkd[535]: /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.1483second # [ 9.780867] systemd-networkd[535]: /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.1484second # [ 9.791287] systemd-networkd[535]: lo: Link UP1485second # [ 9.795888] systemd-networkd[535]: lo: Gained carrier1486second # [ 9.803524] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1487test # [ 9.788876] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1488second # [ 9.819534] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1489second # [ 9.828634] systemd-networkd[535]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1490second # [ 9.838708] mousedev: PS/2 mouse device common for all mice1491second # [ 9.840554] systemd-networkd[535]: eth1: Link UP1492second # [ 9.844471] systemd-networkd[535]: eth1: Gained carrier1493second # [ 9.848615] systemd-networkd[535]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1494second # [ 9.857471] systemd[1]: Starting Post-Boot Actions...1495second # [ 9.864657] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[544]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1496second # [ 9.886094] systemd[1]: Started Reset console on configuration changes.1497second # [ 9.898779] systemd[1]: Started Network Management.1498second # [ 9.919999] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1499second # [ 9.933280] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1500second # connecting to host...1501second # [ 10.017757] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1502second # [ 10.023477] systemd[1]: Finished Post-Boot Actions.1503second # [ 10.075171] systemd[1]: Started Name Service Cache Daemon (nsncd).1504second # [ 10.075862] systemd[1]: Reached target Host and Network Name Lookups.1505second # [ 10.078250] nsncd[551]: Sep 30 00:04:09.921 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1506second # [ 10.079476] systemd[1]: Reached target User and Group Name Lookups.1507second # [ 10.083124] systemd[1]: Starting User Login Management...1508second # [ 10.109922] systemd[1]: Finished Import lastlog data into lastlog2 database.1509test # [ 10.087823] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1510second # [ 10.144193] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1511second # [ 10.150450] systemd[1]: Started Network Manager Script Dispatcher Service.1512test # [ 10.123958] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1513second # [ 10.242980] systemd-logind[580]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1514second # [ 10.248276] systemd-logind[580]: Watching system buttons on /dev/input/event0 (gpio-keys)1515second # [ 10.249033] systemd-logind[580]: New seat seat0.1516second # [ 10.256556] systemd[1]: Starting Hostname Service...1517second # [ 10.257571] systemd[1]: Started User Login Management.1518second # [ 10.266212] systemd[1]: Starting linger-users.service...1519test # [ 10.251782] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1520test # [ 10.254951] systemd[1]: Finished Create SUID/SGID Wrappers.1521second # [ 10.342236] systemd[1]: linger-users.service: Deactivated successfully.1522second # [ 10.342860] systemd[1]: Finished linger-users.service.1523second # [ 10.390414] systemd[1]: Started Hostname Service.1524test # [ 10.449276] systemd[1]: Finished Firewall.1525test # [ 10.453789] systemd[1]: Reached target Preparation for Network.1526test # [ 10.455952] systemd[1]: Starting Network Management...1527second # [ 10.488762] systemd-networkd[535]: eth0: Link UP1528second # [ 10.489244] systemd-networkd[535]: eth0: Gained carrier1529test # [ 10.466829] systemd[1]: Finished register-nix-paths.service.1530test # [ 10.468872] systemd[1]: Reached target System Initialization.1531test # [ 10.470244] systemd[1]: Started Discard unused filesystem blocks once a week.1532test # [ 10.473012] systemd[1]: Started Daily Cleanup of Temporary Directories.1533test # [ 10.474708] systemd[1]: Reached target Timer Units.1534test # [ 10.476504] systemd[1]: Listening on D-Bus System Message Bus Socket.1535test # [ 10.479432] systemd[1]: Listening on Nix Daemon Socket.1536second # [ 10.511706] systemd[1]: Started Network Manager.1537second # [ 10.513651] systemd[1]: Reached target Network.1538test # [ 10.484774] systemd[1]: Listening on Authorization Manager Agent Helper.1539test # [ 10.486359] systemd[1]: Listening on Hostname Service Socket.1540test # [ 10.487396] systemd[1]: Reached target Socket Units.1541test # [ 10.489364] (udev-worker)[399]: Network interface NamePolicy= disabled on kernel command line.1542test # [ 10.491493] (udev-worker)[405]: Network interface NamePolicy= disabled on kernel command line.1543second # [ 10.521445] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1544test # [ 10.498093] systemd[1]: Starting D-Bus System Message Bus...1545second # [ 10.528644] systemd[1]: Starting Permit User Sessions...1546second # [ 10.695259] systemd[1]: Finished Permit User Sessions.1547second # [ 10.717921] systemd[1]: Started Getty on tty1.1548second # [ 10.721022] systemd[1]: Reached target Login Prompts.1549test # [ 10.700891] cfg80211: Loading compiled-in X.509 certificates for regulatory database1550test # [ 10.699278] dbus-broker-launch[562]: Looking up NSS user entry for 'systemd-timesync'...1551second # [ 10.745141] systemd-resolved[330]: eth0: Bus client set default route setting: yes1552test # [ 10.715846] dbus-broker-launch[562]: NSS returned no entry for 'systemd-timesync'1553second # [ 10.750350] systemd-resolved[330]: eth0: Bus client set DNS server list to: 10.0.2.31554test # [ 10.718676] dbus-broker-launch[562]: Invalid user-name in /nix/store/s3qds9d5y4dgflsgdjkj7pfnrbsm10sr-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1555test # [ 10.741676] mousedev: PS/2 mouse device common for all mice1556test # [ 10.746648] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1557test # [ 10.747198] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1558test # [ 10.780086] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'1559test # [ 10.782585] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/1k1jiid5mf18446q3rl0g1gks4yl81qg-networkmanager-1.56.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'1560test # [ 10.788867] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/sx40vhhwgyvayv82kxrdfsb24z1wvcrg-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'1561test # [ 10.793306] dbus-broker-launch[562]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/0qin0mxlbmkcw8jq0dql0shhcfa41crl-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'1562test # [ 10.802192] systemd[1]: Started D-Bus System Message Bus.1563test # [ 10.806157] systemd[1]: Reached target Basic System.1564test # [ 10.808443] systemd[1]: Starting Network Manager Script Dispatcher Service...1565test # [ 10.814063] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1566second # [ 10.847233] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1567second # [ 10.848777] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1568test # [ 10.817912] systemd-networkd[557]: /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.1569test # [ 10.828435] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1570test # [ 10.829087] systemd-networkd[557]: /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.1571test # [ 10.830700] systemd-networkd[557]: lo: Link UP1572test # [ 10.831137] systemd-networkd[557]: lo: Gained carrier1573test # [ 10.845087] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1574test # [ 10.849512] systemd-networkd[557]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1575test # [ 10.859513] systemd-networkd[557]: eth1: Link UP1576test # [ 10.859997] systemd-networkd[557]: eth1: Gained carrier1577test # [ 10.862293] systemd-networkd[557]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1578test # [ 10.877325] systemd[1]: Starting Generate Wi-Fi secrets for NetworkManager...1579test # [ 10.889551] dbus-broker-launch[562]: Ready1580test # [ 10.898954] systemd[1]: Starting Network Manager...1581second # [ 10.944878] systemd-networkd[535]: eth1: Gained IPv6LL1582test # [ 10.921530] systemd[1]: Started backdoor.service.1583test # [ 10.941684] systemd[1]: Starting Import lastlog data into lastlog2 database...1584second # [ 10.989872] systemd[1]: Reached target Multi-User System.1585second # [ 10.992738] systemd[1]: Startup finished in 745ms (kernel) + 4.105s (initrd) + 6.139s (userspace) = 10.990s.1586test # [ 10.979078] 4bb5snallvknp7ll9gml95rlfxqybb0y-wifi-secrets[571]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1587test # [ 10.987087] gihlbcfxrzdmnrhdz3bb45n3f4b0k7kd-wifi-secrets[570]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1588test # [ 11.002877] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1589test # [ 11.043184] systemd[1]: Starting Post-Boot Actions...1590test # [ 11.062301] systemd[1]: Started Reset console on configuration changes.1591test # [ 11.069271] systemd[1]: Started Network Management.1592test # [ 11.074723] systemd[1]: NetworkManager-setup-secrets-wg-test-all.service: Deactivated successfully.1593test # [ 11.087929] 9zw00hrl9ri87shidqszb96sxar6g9fp-wifi-secrets[572]: Generating wifi secrets file: /run/secrets/NetworkManager/wifi-secrets1594test # [ 11.096252] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1595test # [ 11.107954] systemd[1]: NetworkManager-setup-secrets-wg-test-one.service: Deactivated successfully.1596test # [ 11.121927] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1597test # [ 11.128127] systemd[1]: NetworkManager-setup-secrets-wg-test-open.service: Deactivated successfully.1598test # [ 11.135263] systemd[1]: Finished Generate Wi-Fi secrets for NetworkManager.1599test # connecting to host...1600test # [ 11.222074] nsncd[582]: Sep 30 00:04:11.054 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1601test # [ 11.229444] systemd[1]: Started Name Service Cache Daemon (nsncd).1602test # [ 11.233678] systemd[1]: Finished Post-Boot Actions.1603test: Guest shell says: b'Spawning backdoor root shell...\n'1604test: connected to guest root shell1605test: (connecting took 11.53 seconds)1606test: (finished: waiting for the VM to finish booting, in 11.54 seconds)1607test # [ 11.254905] systemd[1]: Reached target Host and Network Name Lookups.1608test # [ 11.258767] systemd[1]: Reached target User and Group Name Lookups.1609test # [ 11.272238] systemd[1]: Starting User Login Management...1610test # [ 11.284426] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1611test # [ 11.303051] systemd[1]: Finished Import lastlog data into lastlog2 database.1612test # [ 11.306405] systemd[1]: Started Network Manager Script Dispatcher Service.1613second # [ 11.477948] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31614test # [ 11.467556] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1615test # [ 11.471353] systemd-logind[616]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1616test # [ 11.476907] systemd-logind[616]: Watching system buttons on /dev/input/event0 (gpio-keys)1617test # [ 11.477606] systemd-logind[616]: New seat seat0.1618test # [ 11.478031] systemd[1]: Started User Login Management.1619test # [ 11.488174] systemd[1]: Starting linger-users.service...1620test # [ 11.494286] systemd[1]: Starting Hostname Service...1621test # [ 11.554873] systemd[1]: linger-users.service: Deactivated successfully.1622test # [ 11.557050] systemd[1]: Finished linger-users.service.1623test # [ 11.615929] systemd[1]: Started Hostname Service.1624test # [ 11.711514] systemd-networkd[557]: eth0: Link UP1625test # [ 11.711999] systemd-networkd[557]: eth0: Gained carrier1626second # [ 11.741959] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1627test # [ 11.732452] systemd[1]: Started Network Manager.1628test # [ 11.733029] systemd[1]: Reached target Network.1629test # [ 11.742276] systemd[1]: Starting Ensure that NetworkManager declarative profiles are created...1630test # [ 11.746946] systemd[1]: Starting Permit User Sessions...1631second # [ 11.786500] systemd[1]: Starting Virtual Console Setup...1632second # [ 11.809936] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1633second # [ 11.810856] systemd-logind[580]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1634second # [ 11.811613] systemd[1]: Stopped Virtual Console Setup.1635second # [ 11.816404] systemd[1]: Starting Virtual Console Setup...1636test # [ 11.897018] systemd[1]: Finished Permit User Sessions.1637test # [ 11.911422] systemd[1]: Started Getty on tty1.1638test # [ 11.917769] systemd[1]: Reached target Login Prompts.1639test # [ 11.918445] systemd-resolved[356]: eth0: Bus client set default route setting: yes1640test # [ 11.919098] systemd-resolved[356]: eth0: Bus client set DNS server list to: 10.0.2.31641test # [ 11.964641] NetworkManager[573]: <warn> [1790726651.7951] keyfile: load: "/var/run/NetworkManager/system-connections/one.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1642test # [ 11.967009] NetworkManager[573]: <warn> [1790726651.8023] keyfile: load: "/var/run/NetworkManager/system-connections/all.nmconnection": failed to load connection: invalid connection: connection.id: property is empty1643test # [ 12.015432] systemd[1]: NetworkManager-ensure-profiles.service: Deactivated successfully.1644test # [ 12.017643] systemd[1]: Finished Ensure that NetworkManager declarative profiles are created.1645test # [ 12.023836] systemd[1]: Reached target Multi-User System.1646test # [ 12.026290] systemd[1]: Startup finished in 719ms (kernel) + 5.153s (initrd) + 6.153s (userspace) = 12.025s.1647second # [ 12.266512] systemd-vconsole-setup[648]: Configuration of first virtual console was skipped, ignoring remaining ones.1648second # [ 12.269629] systemd[1]: Finished Virtual Console Setup.1649second # [ 12.547723] systemd-networkd[535]: eth0: Gained IPv6LL1650test: (finished: waiting for unit NetworkManager.service, in 12.79 seconds)1651test: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection1652test: (finished: must succeed: cat /run/NetworkManager/system-connections/one.nmconnection, in 0.04 seconds)1653cleanup1654kill QemuMachine (pid 14)1655second # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1656test # [ 12.673872] systemd-networkd[557]: eth1: Gained IPv6LL1657test # [ 12.690616] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input31658kill QemuMachine (pid 15)1659test # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/76jq0mngg7m8zv5yjz1qgg0xspzi8x2w-python3-3.13.15/bin/python3.13)1660(finished: cleanup, in 0.27 seconds)1661Traceback (most recent call last):1662 File "/nix/store/bx2f2mvw7byg1lw3sjx9ya00n556icn7-nixos-test-driver-1.1/bin/.nixos-test-driver-wrapped", line 9, in <module>1663 sys.exit(main())1664 ~~~~^^1665 File "/nix/store/bx2f2mvw7byg1lw3sjx9ya00n556icn7-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/__init__.py", line 183, in main1666 driver.run_tests()1667 ~~~~~~~~~~~~~~~~^^1668 File "/nix/store/bx2f2mvw7byg1lw3sjx9ya00n556icn7-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 434, in run_tests1669 self.test_script()1670 ~~~~~~~~~~~~~~~~^^1671 File "/nix/store/bx2f2mvw7byg1lw3sjx9ya00n556icn7-nixos-test-driver-1.1/lib/python3.13/site-packages/test_driver/driver.py", line 392, in test_script1672 exec(self.tests, symbols, None)1673 ~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^1674 File "<string>", line 4, in <module>1675AssertionError: Expected mock password in connection file:1676[connection]1677autoconnect=true1678id=1679type=wifi16801681[wifi]1682mode=infrastructure1683ssid=16841685[wifi-security]1686key-mgmt=wpa-psk1687psk=1688