vm-test-run-test-machine
checks.x86_64-linux.test-machine
· build #131
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 test-machine,8 vlan1,9 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_ssh10??? Warning (UserWarning): invoking 'QemuMachine.wait_for_unit' is deprecated: It's deprecated to use the `machine` variable when the only machine is called test_machine. This behavior will no longer work in NixOS 27.05.11 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 192812test-machine: waiting for unit multi-user.target13test-machine: waiting for the VM to finish booting14test-machine: starting vm15test-machine # Disk image does not exist, creating the virtualisation disk image...16test-machine: QEMU running (pid 45)17test-machine # Formatting '/build/vm-state-test-machine/tmp.otKGk6ZRcJ', fmt=raw size=107374182418test-machine # mke2fs 1.47.4 (6-Mar-2025)19test-machine # Discarding device blocks: 0/262144 done20test-machine # Creating filesystem with 262144 4k blocks and 65536 inodes21test-machine # Filesystem UUID: 62096972-4fed-4d3f-98ce-1075aeaff42822test-machine # Superblock backups stored on blocks:23test-machine # 32768, 98304, 163840, 22937624test-machine # 25test-machine # Allocating group tables: 0/8 done26test-machine # Writing inode tables: 0/8 done27test-machine # Creating journal (8192 blocks): done28test-machine # Writing superblocks and filesystem accounting information: 0/8 done29test-machine # 30test-machine # Virtualisation disk image created.31test-machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)32test-machine # 33test-machine # 34test-machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+7EFCC7A0+7EF2C7A0 CA0035test-machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...36test-machine # 37test-machine # 38test-machine # 39test-machine # 40test-machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 7EFCC7A0 7EF2C7A0 CB0041test-machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...42test-machine # 43test-machine # 44test-machine # Booting from ROM...45test-machine # Probing EDD (edd=off to disable)... ok46test-machine # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 202647test-machine # [ 0.000000] Command line: console=ttyS0,115200 console=tty0 console=ttyS0 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/x8g7wy03988r4yagdj5d5shchwbx9hjn-nixos-system-test-machine-test/init regInfo=/nix/store/0nidwfxsgm3wkxlqx731kl25ii0ri4yd-closure-info/registration console=ttyS0,115200n8 console=tty048test-machine # [ 0.000000] BIOS-provided physical RAM map:49test-machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable50test-machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved51test-machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved52test-machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000007ffc7fff] usable53test-machine # [ 0.000000] BIOS-e820: [mem 0x000000007ffc8000-0x000000007fffffff] reserved54test-machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved55test-machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved56test-machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved57test-machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved58test-machine # [ 0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000017fffffff] usable59test-machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved60test-machine # [ 0.000000] NX (Execute Disable) protection: active61test-machine # [ 0.000000] APIC: Static calls initialized62test-machine # [ 0.000000] SMBIOS 2.8 present.63test-machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201464test-machine # [ 0.000000] DMI: Memory slots populated: 1/165test-machine # [ 0.000000] Hypervisor detected: KVM66test-machine # [ 0.000000] last_pfn = 0x7ffc8 max_arch_pfn = 0x40000000067test-machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0068test-machine # [ 0.000000] kvm-clock: using sched offset of 458695140 cycles69test-machine # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns70test-machine # [ 0.000004] tsc: Detected 4192.088 MHz processor71test-machine # [ 0.000592] last_pfn = 0x180000 max_arch_pfn = 0x40000000072test-machine # [ 0.000619] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs73test-machine # [ 0.000622] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT74test-machine # [ 0.000659] last_pfn = 0x7ffc8 max_arch_pfn = 0x40000000075test-machine # [ 0.002251] found SMP MP-table at [mem 0x000f5450-0x000f545f]76test-machine # [ 0.002262] Using GB pages for direct mapping77test-machine # [ 0.002346] RAMDISK: [mem 0x7e348000-0x7ffbffff]78test-machine # [ 0.002350] ACPI: Early table checksum verification disabled79test-machine # [ 0.002352] ACPI: RSDP 0x00000000000F5250 000014 (v00 BOCHS )80test-machine # [ 0.002355] ACPI: RSDT 0x000000007FFD27FD 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)81test-machine # [ 0.002357] ACPI: FACP 0x000000007FFD2591 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)82test-machine # [ 0.002361] ACPI: DSDT 0x000000007FFD0040 002551 (v01 BOCHS BXPC 00000001 BXPC 00000001)83test-machine # [ 0.002363] ACPI: FACS 0x000000007FFD0000 00004084test-machine # [ 0.002364] ACPI: APIC 0x000000007FFD2685 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001)85test-machine # [ 0.002365] ACPI: HPET 0x000000007FFD2715 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)86test-machine # [ 0.002366] ACPI: TPM2 0x000000007FFD274D 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)87test-machine # [ 0.002367] ACPI: MCFG 0x000000007FFD2799 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)88test-machine # [ 0.002369] ACPI: WAET 0x000000007FFD27D5 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)89test-machine # [ 0.002370] ACPI: Reserving FACP table memory at [mem 0x7ffd2591-0x7ffd2684]90test-machine # [ 0.002370] ACPI: Reserving DSDT table memory at [mem 0x7ffd0040-0x7ffd2590]91test-machine # [ 0.002371] ACPI: Reserving FACS table memory at [mem 0x7ffd0000-0x7ffd003f]92test-machine # [ 0.002371] ACPI: Reserving APIC table memory at [mem 0x7ffd2685-0x7ffd2714]93test-machine # [ 0.002371] ACPI: Reserving HPET table memory at [mem 0x7ffd2715-0x7ffd274c]94test-machine # [ 0.002372] ACPI: Reserving TPM2 table memory at [mem 0x7ffd274d-0x7ffd2798]95test-machine # [ 0.002372] ACPI: Reserving MCFG table memory at [mem 0x7ffd2799-0x7ffd27d4]96test-machine # [ 0.002373] ACPI: Reserving WAET table memory at [mem 0x7ffd27d5-0x7ffd27fc]97test-machine # [ 0.002716] No NUMA configuration found98test-machine # [ 0.002717] Faking a node at [mem 0x0000000000000000-0x000000017fffffff]99test-machine # [ 0.002720] NODE_DATA(0) allocated [mem 0x17fffa780-0x17ffffcff]100test-machine # [ 0.002790] Zone ranges:101test-machine # [ 0.002791] DMA [mem 0x0000000000001000-0x0000000000ffffff]102test-machine # [ 0.002792] DMA32 [mem 0x0000000001000000-0x00000000ffffffff]103test-machine # [ 0.002793] Normal [mem 0x0000000100000000-0x000000017fffffff]104test-machine # [ 0.002793] Device empty105test-machine # [ 0.002794] Movable zone start for each node106test-machine # [ 0.002795] Early memory node ranges107test-machine # [ 0.002795] node 0: [mem 0x0000000000001000-0x000000000009efff]108test-machine # [ 0.002796] node 0: [mem 0x0000000000100000-0x000000007ffc7fff]109test-machine # [ 0.002796] node 0: [mem 0x0000000100000000-0x000000017fffffff]110test-machine # [ 0.002797] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff]111test-machine # [ 0.002811] On node 0, zone DMA: 1 pages in unavailable ranges112test-machine # [ 0.002995] On node 0, zone DMA: 97 pages in unavailable ranges113test-machine # [ 0.053001] On node 0, zone Normal: 56 pages in unavailable ranges114test-machine # [ 0.053798] ACPI: PM-Timer IO Port: 0x608115test-machine # [ 0.053811] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])116test-machine # [ 0.053832] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23117test-machine # [ 0.053834] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)118test-machine # [ 0.053836] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)119test-machine # [ 0.053837] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)120test-machine # [ 0.053838] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)121test-machine # [ 0.053838] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)122test-machine # [ 0.053840] ACPI: Using ACPI (MADT) for SMP configuration information123test-machine # [ 0.053841] ACPI: HPET id: 0x8086a201 base: 0xfed00000124test-machine # [ 0.053846] TSC deadline timer available125test-machine # [ 0.053849] CPU topo: Max. logical packages: 1126test-machine # [ 0.053850] CPU topo: Max. logical dies: 1127test-machine # [ 0.053850] CPU topo: Max. dies per package: 1128test-machine # [ 0.053853] CPU topo: Max. threads per core: 1129test-machine # [ 0.053853] CPU topo: Num. cores per package: 4130test-machine # [ 0.053854] CPU topo: Num. threads per package: 4131test-machine # [ 0.053854] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs132test-machine # [ 0.053870] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()133test-machine # [ 0.053884] kvm-guest: KVM setup pv remote TLB flush134test-machine # [ 0.053887] kvm-guest: setup PV sched yield135test-machine # [ 0.053894] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]136test-machine # [ 0.053895] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]137test-machine # [ 0.053896] PM: hibernation: Registered nosave memory: [mem 0x7ffc8000-0xffffffff]138test-machine # [ 0.053897] [mem 0xc0000000-0xfed1bfff] available for PCI devices139test-machine # [ 0.053898] Booting paravirtualized kernel on KVM140test-machine # [ 0.053901] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns141test-machine # [ 0.057129] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1142test-machine # [ 0.058705] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288143test-machine # [ 0.058741] kvm-guest: PV spinlocks enabled144test-machine # [ 0.058742] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)145test-machine # [ 0.058744] Kernel command line: console=ttyS0,115200 console=tty0 console=ttyS0 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/x8g7wy03988r4yagdj5d5shchwbx9hjn-nixos-system-test-machine-test/init regInfo=/nix/store/0nidwfxsgm3wkxlqx731kl25ii0ri4yd-closure-info/registration console=ttyS0,115200n8 console=tty0146test-machine # [ 0.058815] Unknown kernel command line parameters "regInfo=/nix/store/0nidwfxsgm3wkxlqx731kl25ii0ri4yd-closure-info/registration", will be passed to user space.147test-machine # [ 0.059006] random: crng init done148test-machine # [ 0.059007] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes149test-machine # [ 0.062064] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)150test-machine # [ 0.063681] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)151test-machine # [ 0.063735] software IO TLB: area num 4.152test-machine # [ 0.116530] Fallback order for Node 0: 0153test-machine # [ 0.116537] Built 1 zonelists, mobility grouping on. Total pages: 1048422154test-machine # [ 0.116539] Policy zone: Normal155test-machine # [ 0.118314] mem auto-init: stack:all(zero), heap alloc:on, heap free:off156test-machine # [ 0.124288] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1157test-machine # [ 0.130638] allocated 8388608 bytes of page_ext158test-machine # [ 0.139066] ftrace: allocating 48733 entries in 192 pages159test-machine # [ 0.139068] ftrace: allocated 192 pages with 2 groups160test-machine # [ 0.139780] Dynamic Preempt: lazy161test-machine # [ 0.139893] rcu: Preemptible hierarchical RCU implementation.162test-machine # [ 0.139893] rcu: RCU event tracing is enabled.163test-machine # [ 0.139894] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.164test-machine # [ 0.139895] Trampoline variant of Tasks RCU enabled.165test-machine # [ 0.139895] Rude variant of Tasks RCU enabled.166test-machine # [ 0.139895] Tracing variant of Tasks RCU enabled.167test-machine # [ 0.139896] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.168test-machine # [ 0.139897] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4169test-machine # [ 0.139914] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.170test-machine # [ 0.139916] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.171test-machine # [ 0.139916] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.172test-machine # [ 0.143061] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16173test-machine # [ 0.143330] rcu: srcu_init: Setting srcu_struct sizes based on contention.174test-machine # [ 0.143335] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns175test-machine # [ 0.143489] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)176test-machine # [ 0.148658] Console: colour VGA+ 80x25177test-machine # [ 0.148661] printk: legacy console [tty0] enabled178test-machine # [ 0.181389] printk: legacy console [ttyS0] enabled179test-machine # [ 0.325299] ACPI: Core revision 20250807180test-machine # [ 0.326343] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns181test-machine # [ 0.328240] APIC: Switch to symmetric I/O mode setup182test-machine # [ 0.329405] x2apic enabled183test-machine # [ 0.330208] APIC: Switched APIC routing to: physical x2apic184test-machine # [ 0.331354] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()185test-machine # [ 0.332833] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()186test-machine # [ 0.338283] kvm-guest: setup PV IPIs187test-machine # [ 0.339856] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1188test-machine # [ 0.341076] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns189test-machine # [ 0.343121] Calibrating delay loop (skipped) preset value.. 8384.17 BogoMIPS (lpj=4192088)190test-machine # [ 0.345205] x86/cpu: User Mode Instruction Prevention (UMIP) activated191test-machine # [ 0.347166] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127192test-machine # [ 0.348121] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0193test-machine # [ 0.349123] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto194test-machine # [ 0.350121] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl195test-machine # [ 0.351121] Spectre V2 : Mitigation: Enhanced / Automatic IBRS196test-machine # [ 0.352121] Speculative Return Stack Overflow: Mitigation: Safe RET197test-machine # [ 0.353120] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization198test-machine # [ 0.355126] Spectre V2 : Enabling IBPB for BPF199test-machine # [ 0.356121] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier200test-machine # [ 0.357121] active return thunk: srso_alias_return_thunk201test-machine # [ 0.358141] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'202test-machine # [ 0.359121] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'203test-machine # [ 0.360121] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'204test-machine # [ 0.362121] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'205test-machine # [ 0.363121] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'206test-machine # [ 0.364120] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'207test-machine # [ 0.365121] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'208test-machine # [ 0.366121] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'209test-machine # [ 0.367121] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'210test-machine # [ 0.368121] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256211test-machine # [ 0.370120] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64212test-machine # [ 0.371121] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512213test-machine # [ 0.372121] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024214test-machine # [ 0.373121] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8215test-machine # [ 0.374121] x86/fpu: xstate_offset[11]: 2440, xstate_sizes[11]: 16216test-machine # [ 0.376121] x86/fpu: xstate_offset[12]: 2456, xstate_sizes[12]: 24217test-machine # [ 0.377120] x86/fpu: Enabled xstate features 0x1ae7, context size is 2480 bytes, using 'compacted' format.218test-machine # [ 0.399566] Freeing SMP alternatives memory: 44K219test-machine # [ 0.400122] pid_max: default: 32768 minimum: 301220test-machine # [ 0.401176] LSM: initializing lsm=capability,landlock,yama,bpf,ima221test-machine # [ 0.402202] landlock: Up and running.222test-machine # [ 0.403121] Yama: becoming mindful.223test-machine # [ 0.404290] LSM support for eBPF active224test-machine # [ 0.405237] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)225test-machine # [ 0.406172] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)226test-machine # [ 0.409403] smpboot: CPU0: AMD Ryzen 9 7950X3D 16-Core Processor (family: 0x19, model: 0x61, stepping: 0x2)227test-machine # [ 0.410517] Performance Events: Fam17h+ core perfctr, AMD PMU driver.228test-machine # [ 0.411128] ... version: 2229test-machine # [ 0.412017] ... bit width: 48230test-machine # [ 0.412827] ... generic counters: 6231test-machine # [ 0.413122] ... generic bitmap: 000000000000003f232test-machine # [ 0.414122] ... fixed-purpose counters: 0233test-machine # [ 0.415007] ... fixed-purpose bitmap: 0000000000000000234test-machine # [ 0.416028] ... value mask: 0000ffffffffffff235test-machine # [ 0.417013] ... max period: 00007fffffffffff236test-machine # [ 0.418019] ... global_ctrl mask: 000000000000003f237test-machine # [ 0.419076] signal: max sigframe size: 3376238test-machine # [ 0.419832] rcu: Hierarchical SRCU implementation.239test-machine # [ 0.420125] rcu: Max phase no-delay instances is 400.240test-machine # [ 0.421253] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level241test-machine # [ 0.425039] smp: Bringing up secondary CPUs ...242test-machine # [ 0.426134] smpboot: x86: Booting SMP configuration:243test-machine # [ 0.427122] .... node #0, CPUs: #1 #2 #3244test-machine # [ 0.428149] smp: Brought up 1 node, 4 CPUs245test-machine # [ 0.429995] smpboot: Total of 4 processors activated (33536.70 BogoMIPS)246test-machine # [ 0.431434] Memory: 3959412K/4193688K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 218928K reserved, 0K cma-reserved)247test-machine # [ 0.432396] devtmpfs: initialized248test-machine # [ 0.433296] x86/mm: Memory block size: 128MB249test-machine # [ 0.435263] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)250test-machine # [ 0.436195] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).251test-machine # [ 0.437201] pinctrl core: initialized pinctrl subsystem252test-machine # [ 0.438383] PM: RTC time: 04:33:47, date: 2026-09-02253test-machine # [ 0.441181] NET: Registered PF_NETLINK/PF_ROUTE protocol family254test-machine # [ 0.442661] DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations255test-machine # [ 0.443148] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations256test-machine # [ 0.444505] DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations257test-machine # [ 0.445129] audit: initializing netlink subsys (disabled)258test-machine # [ 0.446159] audit: type=2000 audit(1788323628.624:1): state=initialized audit_enabled=0 res=1259test-machine # [ 0.446328] thermal_sys: Registered thermal governor 'fair_share'260test-machine # [ 0.447126] thermal_sys: Registered thermal governor 'bang_bang'261test-machine # [ 0.448123] thermal_sys: Registered thermal governor 'step_wise'262test-machine # [ 0.449122] thermal_sys: Registered thermal governor 'user_space'263test-machine # [ 0.450122] thermal_sys: Registered thermal governor 'power_allocator'264test-machine # [ 0.451132] cpuidle: using governor menu265test-machine # [ 0.453674] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5266test-machine # [ 0.454334] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]267test-machine # [ 0.455124] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry268test-machine # [ 0.456131] PCI: Using configuration type 1 for base access269test-machine # [ 0.457257] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.270test-machine # [ 0.459336] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages271test-machine # [ 0.460123] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page272test-machine # [ 0.461122] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages273test-machine # [ 0.463122] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page274test-machine # [ 0.465643] ACPI: Added _OSI(Module Device)275test-machine # [ 0.466805] ACPI: Added _OSI(Processor Device)276test-machine # [ 0.467123] ACPI: Added _OSI(Processor Aggregator Device)277test-machine # [ 0.470125] ACPI: 1 ACPI AML tables successfully acquired and loaded278test-machine # [ 0.473343] ACPI: Interpreter enabled279test-machine # [ 0.474138] ACPI: PM: (supports S0 S3 S4 S5)280test-machine # [ 0.475024] ACPI: Using IOAPIC for interrupt routing281test-machine # [ 0.475975] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug282test-machine # [ 0.477122] PCI: Using E820 reservations for host bridge windows283test-machine # [ 0.478266] ACPI: Enabled 2 GPEs in block 00 to 3F284test-machine # [ 0.482676] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])285test-machine # [ 0.483126] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]286test-machine # [ 0.484200] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]287test-machine # [ 0.485238] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]288test-machine # [ 0.486525] PCI host bridge to bus 0000:00289test-machine # [ 0.487127] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]290test-machine # [ 0.488123] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]291test-machine # [ 0.489123] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]292test-machine # [ 0.490124] pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window]293test-machine # [ 0.491123] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]294test-machine # [ 0.492124] pci_bus 0000:00: root bus resource [mem 0xe0000000000-0xe07ffffffff window]295test-machine # [ 0.493123] pci_bus 0000:00: root bus resource [mem 0xfed40000-0xfed44fff]296test-machine # [ 0.494124] pci_bus 0000:00: root bus resource [bus 00-ff]297test-machine # [ 0.495232] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint298test-machine # [ 0.496786] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint299test-machine # [ 0.499066] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]300test-machine # [ 0.500142] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]301test-machine # [ 0.501166] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]302test-machine # [ 0.502305] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]303test-machine # [ 0.503876] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint304test-machine # [ 0.507047] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]305test-machine # [ 0.507961] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]306test-machine # [ 0.509102] pci 0000:00:02.0: BAR 4 [mem 0xe0000000000-0xe0000003fff 64bit pref]307test-machine # [ 0.510132] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]308test-machine # [ 0.511981] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint309test-machine # [ 0.514901] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]310test-machine # [ 0.515133] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]311test-machine # [ 0.516160] pci 0000:00:03.0: BAR 4 [mem 0xe0000004000-0xe0000007fff 64bit pref]312test-machine # [ 0.517980] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint313test-machine # [ 0.520132] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]314test-machine # [ 0.521132] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]315test-machine # [ 0.522161] pci 0000:00:04.0: BAR 4 [mem 0xe0000008000-0xe000000bfff 64bit pref]316test-machine # [ 0.524132] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint317test-machine # [ 0.526133] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]318test-machine # [ 0.527135] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]319test-machine # [ 0.528160] pci 0000:00:05.0: BAR 4 [mem 0xe000000c000-0xe000000ffff 64bit pref]320test-machine # [ 0.530132] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint321test-machine # [ 0.532133] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]322test-machine # [ 0.533133] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]323test-machine # [ 0.535106] pci 0000:00:06.0: BAR 4 [mem 0xe0000010000-0xe0000013fff 64bit pref]324test-machine # [ 0.536993] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint325test-machine # [ 0.539133] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]326test-machine # [ 0.540135] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]327test-machine # [ 0.541162] pci 0000:00:07.0: BAR 4 [mem 0xe0000014000-0xe0000017fff 64bit pref]328test-machine # [ 0.543028] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint329test-machine # [ 0.545133] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]330test-machine # [ 0.546136] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]331test-machine # [ 0.547167] pci 0000:00:08.0: BAR 4 [mem 0xe0000018000-0xe000001bfff 64bit pref]332test-machine # [ 0.548134] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]333test-machine # [ 0.549995] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint334test-machine # [ 0.551972] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]335test-machine # [ 0.553110] pci 0000:00:09.0: BAR 4 [mem 0xe000001c000-0xe000001ffff 64bit pref]336test-machine # [ 0.555010] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint337test-machine # [ 0.557133] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]338test-machine # [ 0.558132] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]339test-machine # [ 0.559160] pci 0000:00:0a.0: BAR 4 [mem 0xe0000020000-0xe0000023fff 64bit pref]340test-machine # [ 0.560980] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint341test-machine # [ 0.563132] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]342test-machine # [ 0.564132] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]343test-machine # [ 0.565161] pci 0000:00:0b.0: BAR 4 [mem 0xe0000024000-0xe0000027fff 64bit pref]344test-machine # [ 0.567005] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint345test-machine # [ 0.568753] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]346test-machine # [ 0.569380] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint347test-machine # [ 0.570727] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]348test-machine # [ 0.571389] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint349test-machine # [ 0.572742] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]350test-machine # [ 0.573427] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint351test-machine # [ 0.574720] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]352test-machine # [ 0.575453] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint353test-machine # [ 0.576591] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO354test-machine # [ 0.577477] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint355test-machine # [ 0.578963] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]356test-machine # [ 0.579966] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]357test-machine # [ 0.581533] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint358test-machine # [ 0.582820] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]359test-machine # [ 0.587756] ACPI: PCI: Interrupt link LNKA configured for IRQ 10360test-machine # [ 0.588237] ACPI: PCI: Interrupt link LNKB configured for IRQ 10361test-machine # [ 0.589239] ACPI: PCI: Interrupt link LNKC configured for IRQ 11362test-machine # [ 0.590236] ACPI: PCI: Interrupt link LNKD configured for IRQ 11363test-machine # [ 0.591233] ACPI: PCI: Interrupt link LNKE configured for IRQ 10364test-machine # [ 0.592272] ACPI: PCI: Interrupt link LNKF configured for IRQ 10365test-machine # [ 0.593245] ACPI: PCI: Interrupt link LNKG configured for IRQ 11366test-machine # [ 0.594237] ACPI: PCI: Interrupt link LNKH configured for IRQ 11367test-machine # [ 0.595166] ACPI: PCI: Interrupt link GSIA configured for IRQ 16368test-machine # [ 0.596135] ACPI: PCI: Interrupt link GSIB configured for IRQ 17369test-machine # [ 0.597135] ACPI: PCI: Interrupt link GSIC configured for IRQ 18370test-machine # [ 0.598138] ACPI: PCI: Interrupt link GSID configured for IRQ 19371test-machine # [ 0.599134] ACPI: PCI: Interrupt link GSIE configured for IRQ 20372test-machine # [ 0.600138] ACPI: PCI: Interrupt link GSIF configured for IRQ 21373test-machine # [ 0.601135] ACPI: PCI: Interrupt link GSIG configured for IRQ 22374test-machine # [ 0.602138] ACPI: PCI: Interrupt link GSIH configured for IRQ 23375test-machine # [ 0.604138] iommu: Default domain type: Translated376test-machine # [ 0.605122] iommu: DMA domain TLB invalidation policy: lazy mode377test-machine # [ 0.606269] ACPI: bus type USB registered378test-machine # [ 0.607172] usbcore: registered new interface driver usbfs379test-machine # [ 0.608137] usbcore: registered new interface driver hub380test-machine # [ 0.609132] usbcore: registered new device driver usb381test-machine # [ 0.610689] NetLabel: Initializing382test-machine # [ 0.611122] NetLabel: domain hash size = 128383test-machine # [ 0.612024] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO384test-machine # [ 0.613058] NetLabel: unlabeled traffic allowed by default385test-machine # [ 0.614024] PCI: Using ACPI for IRQ routing386test-machine # [ 0.690149] pci 0000:00:01.0: vgaarb: setting as boot VGA device387test-machine # [ 0.691119] pci 0000:00:01.0: vgaarb: bridge control possible388test-machine # [ 0.691119] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none389test-machine # [ 0.691125] vgaarb: loaded390test-machine # [ 0.691922] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0391test-machine # [ 0.692910] hpet0: 3 comparators, 64-bit 100.000000 MHz counter392test-machine # [ 0.696249] clocksource: Switched to clocksource kvm-clock393test-machine # [ 0.697858] VFS: Disk quotas dquot_6.6.0394test-machine # [ 0.698704] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)395test-machine # [ 0.700306] pnp: PnP ACPI init396test-machine # [ 0.701171] ACPI: IRQ 4 override to edge(!), high(!)397test-machine # [ 0.702306] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved398test-machine # [ 0.704090] pnp: PnP ACPI: found 6 devices399test-machine # [ 0.711507] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns400test-machine # [ 0.713264] clocksource: Switched to clocksource acpi_pm401test-machine # [ 0.714437] NET: Registered PF_INET protocol family402test-machine # [ 0.715927] IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)403test-machine # [ 0.729224] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)404test-machine # [ 0.730948] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)405test-machine # [ 0.732554] TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)406test-machine # [ 0.734222] TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)407test-machine # [ 0.735756] TCP: Hash tables configured (established 32768 bind 32768)408test-machine # [ 0.737151] MPTCP token hash table entries: 4096 (order: 5, 98304 bytes, linear)409test-machine # [ 0.738766] UDP hash table entries: 2048 (order: 5, 131072 bytes, linear)410test-machine # [ 0.740252] UDP-Lite hash table entries: 2048 (order: 5, 131072 bytes, linear)411test-machine # [ 0.741834] NET: Registered PF_UNIX/PF_LOCAL protocol family412test-machine # [ 0.743002] NET: Registered PF_XDP protocol family413test-machine # [ 0.744021] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]414test-machine # [ 0.745271] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]415test-machine # [ 0.746518] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]416test-machine # [ 0.747867] pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window]417test-machine # [ 0.749235] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]418test-machine # [ 0.750599] pci_bus 0000:00: resource 9 [mem 0xe0000000000-0xe07ffffffff window]419test-machine # [ 0.752126] pci_bus 0000:00: resource 10 [mem 0xfed40000-0xfed44fff]420test-machine # [ 0.753941] ACPI: \_SB_.GSIA: Enabled at IRQ 16421test-machine # [ 0.755999] ACPI: \_SB_.GSIB: Enabled at IRQ 17422test-machine # [ 0.757987] ACPI: \_SB_.GSIC: Enabled at IRQ 18423test-machine # [ 0.759948] ACPI: \_SB_.GSID: Enabled at IRQ 19424test-machine # [ 0.761728] PCI: CLS 0 bytes, default 64425test-machine # [ 0.762677] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)426test-machine # [ 0.762846] Trying to unpack rootfs image as initramfs...427test-machine # [ 0.762927] software IO TLB: mapped [mem 0x000000007a348000-0x000000007e348000] (64MB)428test-machine # [ 0.766780] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3c6d2fa06f4, max_idle_ns: 440795322535 ns429test-machine # [ 0.782617] Initialise system trusted keyrings430test-machine # [ 0.783829] workingset: timestamp_bits=40 max_order=20 bucket_order=0431test-machine # [ 0.792716] Key type asymmetric registered432test-machine # [ 0.793617] Asymmetric key parser 'x509' registered433test-machine # [ 0.794678] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)434test-machine # [ 0.796376] io scheduler mq-deadline registered435test-machine # [ 0.797352] io scheduler kyber registered436test-machine # [ 0.800499] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled437test-machine # [ 0.802046] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A438test-machine # [ 0.804576] Linux agpgart interface v0.103439test-machine # [ 0.809041] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)440test-machine # [ 0.823577] ACPI: bus type drm_connector registered441test-machine # [ 0.826594] usbcore: registered new interface driver usbserial_generic442test-machine # [ 0.827937] usbserial: USB Serial support registered for generic443test-machine # [ 0.829147] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.444test-machine # [ 0.829147] Please enable it if your BIOS has the CPPC option.445test-machine # [ 0.831955] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled446test-machine # [ 0.833934] drop_monitor: Initializing network drop monitor service447test-machine # [ 0.835470] NET: Registered PF_INET6 protocol family448test-machine # [ 0.837556] Segment Routing with IPv6449test-machine # [ 0.838514] In-situ OAM (IOAM) with IPv6450test-machine # [ 0.841184] IPI shorthand broadcast: enabled451test-machine # [ 0.845367] sched_clock: Marking stable (654023656, 190783855)->(928977597, -84170086)452test-machine # [ 0.847434] registered taskstats version 1453test-machine # [ 0.848621] Loading compiled-in X.509 certificates454test-machine # [ 0.857455] Demotion targets for Node 0: null455test-machine # [ 0.858666] Key type .fscrypt registered456test-machine # [ 0.859530] Key type fscrypt-provisioning registered457test-machine # [ 0.860706] ima: Allocated hash algorithm: sha1458test-machine # [ 0.875971] ima: No architecture policies found459test-machine # [ 0.877157] PM: Magic number: 10:618:564460test-machine # [ 0.878724] RAS: Correctable Errors collector initialized.461test-machine # [ 0.882512] clk: Disabling unused clocks462test-machine # [ 0.883381] PM: genpd: Disabling unused power domains463test-machine # [ 0.951946] Freeing initrd memory: 29152K464test-machine # [ 0.955011] Freeing unused decrypted memory: 2028K465test-machine # [ 0.957472] Freeing unused kernel image (initmem) memory: 3644K466test-machine # [ 0.966512] Write protecting the kernel read-only data: 32768k467test-machine # [ 0.968541] Freeing unused kernel image (text/rodata gap) memory: 1216K468test-machine # [ 0.970297] Freeing unused kernel image (rodata/data gap) memory: 756K469test-machine # [ 1.003217] x86/mm: Checked W+X mappings: passed, no W+X pages found.470test-machine # [ 1.004525] Run /init as init process471test-machine # [ 1.013181] systemd[1]: Inserted module 'autofs4'472test-machine # [ 1.029398] fuse: init (API version 7.45)473test-machine # [ 1.035168] ACPI: \_SB_.GSIG: Enabled at IRQ 22474test-machine # [ 1.037768] ACPI: \_SB_.GSIH: Enabled at IRQ 23475test-machine # [ 1.041356] ACPI: \_SB_.GSIE: Enabled at IRQ 20476test-machine # [ 1.043963] ACPI: \_SB_.GSIF: Enabled at IRQ 21477test-machine # [ 1.074631] systemd[1]: Successfully made /usr/ read-only.478test-machine # [ 1.410569] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)479test-machine # [ 1.416426] systemd[1]: Detected virtualization kvm.480test-machine # [ 1.417510] systemd[1]: Detected architecture x86-64.481test-machine # [ 1.418581] systemd[1]: Running in initrd.482test-machine # [ 1.419727] systemd[1]: Initializing machine ID from random generator.483test-machine # [ 1.421176] systemd[1]: Hostname set to <test-machine>.484test-machine # [ 1.499954] systemd[1]: bpf-restrict-fs: LSM BPF program attached485test-machine # [ 1.523592] systemd[1]: Queued start job for default target Initrd Default Target.486test-machine # [ 1.537128] systemd[1]: Created slice Slice /system/modprobe.487test-machine # [ 1.538540] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.488test-machine # [ 1.540220] systemd[1]: Expecting device /dev/disk/by-label/nixos...489test-machine # [ 1.541556] systemd[1]: Reached target Path Units.490test-machine # [ 1.542616] systemd[1]: Reached target Slice Units.491test-machine # [ 1.543686] systemd[1]: Reached target Swaps.492test-machine # [ 1.544668] systemd[1]: Reached target Timer Units.493test-machine # [ 1.545838] systemd[1]: Listening on D-Bus System Message Bus Socket.494test-machine # [ 1.547281] systemd[1]: Listening on Journal Socket (/dev/log).495test-machine # [ 1.548638] systemd[1]: Listening on Journal Sockets.496test-machine # [ 1.549865] systemd[1]: Listening on udev Control Socket.497test-machine # [ 1.551071] systemd[1]: Listening on udev Kernel Socket.498test-machine # [ 1.552209] systemd[1]: Reached target Socket Units.499test-machine # [ 1.553968] systemd[1]: Starting Create List of Static Device Nodes...500test-machine # [ 1.555899] systemd[1]: Starting Load Kernel Module 9pnet_virtio...501test-machine # [ 1.557842] systemd[1]: Starting Load Kernel Module configfs...502test-machine # [ 1.560394] systemd[1]: Starting Journal Service...503test-machine # [ 1.563727] systemd[1]: Starting Load Kernel Modules...504test-machine # [ 1.564932] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os505test-machine # [ 1.567875] systemd[1]: Starting Coldplug All udev Devices...506test-machine # [ 1.570399] systemd[1]: Finished Create List of Static Device Nodes.507test-machine # [ 1.570675] systemd-journald[91]: Collecting audit messages is disabled.508test-machine # [ 1.573728] systemd[1]: modprobe@configfs.service: Deactivated successfully.509test-machine # [ 1.579584] systemd[1]: Finished Load Kernel Module configfs.510test-machine # [ 1.581472] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config511test-machine # [ 1.585933] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...512test-machine # [ 1.587516] netfs: FS-Cache loaded513test-machine # [ 1.595352] 9pnet: Installing 9P2000 support514test-machine # [ 1.597089] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.515test-machine # [ 1.602337] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.516test-machine # [ 1.604026] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev517test-machine # [ 1.604845] systemd[1]: Starting Create Static Device Nodes in /dev...518test-machine # [ 1.609736] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.519test-machine # [ 1.611701] systemd[1]: Finished Load Kernel Module 9pnet_virtio.520test-machine # [ 1.619194] systemd[1]: Finished Load Kernel Modules.521test-machine # [ 1.621256] systemd[1]: Starting Apply Kernel Variables...522test-machine # [ 1.432672] systemd-modules-load[92]: Using 4[ 1.623941] systemd[1]: Started Journal Service.523test-machine # probe threads524test-machine # [ 1.434787] systemd-modules-load[92]: Inserted module 'virtio_balloon'525test-machine # [ 1.436184] systemd-modules-load[92]: Inserted module 'virtio_gpu'526test-machine # [ 1.437434] systemd-modules-load[92]: Inserted module 'dm_mod'527test-machine # [ 1.438615] systemd[1]: Finished Create Static Device Nodes in /dev.528test-machine # [ 1.440031] systemd[1]: Reached target Preparation for Local File Systems.529test-machine # [ 1.441418] systemd[1]: Reached target Local File Systems.530test-machine # [ 1.442568] systemd[1]: Starting Create System Files and Directories...531test-machine # [ 1.443838] systemd[1]: Starting Rule-based Manager for Device Events and Files...532test-machine # [ 1.451603] systemd[1]: Finished Apply Kernel Variables.533test-machine # [ 1.458223] systemd[1]: Finished Create System Files and Directories.534test-machine # [ 1.465153] systemd-udevd[107]: Using default interface naming scheme 'v261'.535test-machine # [ 1.468226] systemd[1]: Finished Coldplug All udev Devices.536test-machine # [ 1.475315] systemd[1]: Started Rule-based Manager for Device Events and Files.537test-machine # [ 1.476465] systemd[1]: Reached target System Initialization.538test-machine # [ 1.477404] systemd[1]: Reached target Basic System.539test-machine # [ 1.566836] systemd[1]: Expecting device /dev/tpm0...540test-machine # [ 1.783990] virtio_blk virtio5: 4/0/0 default/read/poll queues541test-machine # [ 1.790336] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)542test-machine # [ 1.794759] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12543test-machine # [ 1.798859] ehci-pci 0000:00:1d.7: EHCI Host Controller544test-machine # [ 1.799897] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1545test-machine # [ 1.799999] serio: i8042 KBD port at 0x60,0x64 irq 1546test-machine # [ 1.800561] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000547test-machine # [ 1.801305] serio: i8042 AUX port at 0x60,0x64 irq 12548test-machine # [ 1.807868] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00549test-machine # [ 1.808983] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18550test-machine # [ 1.810315] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1551test-machine # [ 1.811485] usb usb1: Product: EHCI Host Controller552test-machine # [ 1.620906] systemd[1]: Found[ 1.812284] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd553test-machine # device /dev/tpm0.554test-machine # [ 1.813401] usb usb1: SerialNumber: 0000:00:1d.7555test-machine # [ 1.623674] s[ 1.814433] hub 1-0:1.0: USB hub found556test-machine # ystemd[1]: Reached target Truste[ 1.815209] hub 1-0:1.0: 6 ports detected557test-machine # d Platform Module.558test-machine # [ 1.816971] uhci_hcd 0000:00:1d.0: UHCI Host Controller559test-machine # [ 1.817822] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2560test-machine # [ 1.819043] uhci_hcd 0000:00:1d.0: detected 2 ports561test-machine # [ 1.819988] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200562test-machine # [ 1.824559] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18563test-machine # [ 1.826742] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1564test-machine # [ 1.826772] SCSI subsystem initialized565test-machine # [ 1.827069] usb usb2: Product: UHCI Host Controller566test-machine # [ 1.830364] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd567test-machine # [ 1.831376] usb usb2: SerialNumber: 0000:00:1d.0568test-machine # [ 1.642672] (udev-worker)[118]: Network interface NamePolicy= disabled on kernel command line.569test-machine # [ 1.648488] systemd[1]: Starting Virtual Console Setup...570test-machine # [ 1.845436] hub 2-0:1.0: USB hub found571test-machine # [ 1.846138] hub 2-0:1.0: 2 ports detected572test-machine # [ 1.655600] (udev-worker)[138]: Network interface NamePolicy= disabled on ker[ 1.847404] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0573test-machine # nel command line.574test-machine # [ 1.854379] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode575test-machine # [ 1.856419] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)576test-machine # [ 1.857428] ahci 0000:00:1f.2: flags: 64bit ncq only577test-machine # [ 1.668185] systemd-vconsole-setup[143]: Configuration of first virtual console was [ 1.860270] uhci_hcd 0000:00:1d.1: UHCI Host Controller578test-machine # skipped, ignoring remaining ones.579test-machine # [ 1.861400] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3580test-machine # [ 1.862076] scsi host0: ahci581test-machine # [ 1.863698] scsi host1: ahci582test-machine # [ 1.673640] systemd[1]: Finished Virtual Console Setup.583test-machine # [ 1.865900] uhci_hcd 0000:00:1d.1: detected 2 ports584test-machine # [ 1.866664] scsi host2: ahci585test-machine # [ 1.866783] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220586test-machine # [ 1.867528] scsi host3: ahci587test-machine # [ 1.868314] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18588test-machine # [ 1.869852] scsi host4: ahci589test-machine # [ 1.870239] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1590test-machine # [ 1.680313] systemd[1]: Found[ 1.871753] usb usb3: Product: UHCI Host Controller591test-machine # device /dev/disk/by-label/nixos[ 1.872834] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd592test-machine # .593test-machine # [ 1.873910] usb usb3: SerialNumber: 0000:00:1d.1594test-machine # [ 1.683419] systemd[1]: Reach[ 1.874758] scsi host5: ahci595test-machine # ed target Initrd Root Device.596test-machine # [ 1.875630] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1597test-machine # [ 1.685601] systemd[1]: Start[ 1.877006] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1598test-machine # ing File System Check on /dev/disk/by-label/nixo[ 1.878456] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1599test-machine # s...600test-machine # [ 1.879879] hub 3-0:1.0: USB hub found601test-machine # [ 1.880020] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1602test-machine # [ 1.880250] hub 3-0:1.0: 2 ports detected603test-machine # [ 1.880608] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1604test-machine # [ 1.881963] uhci_hcd 0000:00:1d.2: UHCI Host Controller605test-machine # [ 1.882039] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1606test-machine # [ 1.882219] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4607test-machine # [ 1.887708] uhci_hcd 0000:00:1d.2: detected 2 ports608test-machine # [ 1.888622] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240609test-machine # [ 1.889965] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18610test-machine # [ 1.891408] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1611test-machine # [ 1.892623] usb usb4: Product: UHCI Host Controller612test-machine # [ 1.702836] s[ 1.893524] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd613test-machine # ystemd-fsck[172]: nixos: clean, [ 1.894691] usb usb4: SerialNumber: 0000:00:1d.2614test-machine # 12/65536 files, 13019/262144 blocks615test-machine # [ 1.896170] hub 4-0:1.0: USB hub found616test-machine # [ 1.896910] hub 4-0:1.0: 2 ports detected617test-machine # [ 1.708064] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.618test-machine # [ 2.053845] usb 1-1: new high-speed USB device number 2 using ehci-pci619test-machine # [ 2.183637] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00620test-machine # [ 2.184935] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10621test-machine # [ 2.186077] usb 1-1: Product: QEMU USB Tablet622test-machine # [ 2.186819] usb 1-1: Manufacturer: QEMU623test-machine # [ 2.187470] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1624test-machine # [ 2.196094] ata4: SATA link down (SStatus 0 SControl 300)625test-machine # [ 2.197186] ata5: SATA link down (SStatus 0 SControl 300)626test-machine # [ 2.197449] hid: raw HID events driver (C) Jiri Kosina627test-machine # [ 2.198257] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)628test-machine # [ 2.199965] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100629test-machine # [ 2.200865] ata3.00: applying bridge limits630test-machine # [ 2.201711] ata1: SATA link down (SStatus 0 SControl 300)631test-machine # [ 2.202948] ata6: SATA link down (SStatus 0 SControl 300)632test-machine # [ 2.203873] ata3.00: configured for UDMA/100633test-machine # [ 2.204748] ata2: SATA link down (SStatus 0 SControl 300)634test-machine # [ 2.205979] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5635test-machine # [ 2.229404] usbcore: registered new interface driver usbhid636test-machine # [ 2.230439] usbhid: USB HID core driver637test-machine # [ 2.242175] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2638test-machine # [ 2.243985] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0639test-machine # [ 2.262020] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray640test-machine # [ 2.291942] cdrom: Uniform CD-ROM driver Revision: 3.20641test-machine # [ 2.379896] systemd[1]: Mounting /sysroot...642test-machine # [ 2.650359] EXT4-fs (vda): mounted filesystem 62096972-4fed-4d3f-98ce-1075aeaff428 r/w with ordered data mode. Quota mode: none.643test-machine # [ 2.462600] systemd[1]: Mounted /sysroot.644test-machine # [ 2.463529] systemd[1]: Reached target Initrd Root File System.645test-machine # [ 2.464584] systemd[1]: Mounting /sysroot/nix/.ro-store...646test-machine # [ 2.465662] systemd[1]: Mounting /sysroot/nix/.rw-store...647test-machine # [ 2.466699] systemd[1]: Mounting /sysroot/run...648test-machine # [ 2.467735] systemd[1]: Mounting /sysroot/tmp/shared...649test-machine # [ 2.471384] systemd[1]: Mounting /sysroot/tmp/xchg...650test-machine # [ 2.474146] systemd[1]: Starting Mountpoints Configured in the Real Root...651test-machine # [ 2.667531] 9p: Installing v9fs 9p2000 file system support652test-machine # [ 2.479251] systemd[1]: Mounted /sysroot/nix/.rw-store.653test-machine # [ 2.480324] systemd[1]: Mounted /sysroot/run.654test-machine # [ 2.481196] systemd[1]: Mounted /sysroot/nix/.ro-store.655test-machine # [ 2.482204] systemd[1]: Mounted /sysroot/tmp/shared.656test-machine # [ 2.483158] systemd[1]: Mounted /sysroot/tmp/xchg.657test-machine # [ 2.484686] systemd[1]: Starting rw-sysroot-nix-store.service...658test-machine # [ 2.487836] systemd-sysroot-fstab-check[192]: /sysroot should be mounted in the initrd, will request daemon-reload.659test-machine # [ 2.489565] systemd[1]: Reload requested from client PID 192 ('systemd-sysroot') (unit initrd-parse-etc.service)...660test-machine # [ 2.491288] systemd[1]: Reloading...661test-machine # [ 2.531376] systemd[1]: Reloading finished in 42 ms.662test-machine # [ 2.557165] systemd-sysroot-fstab-check[192]: Requesting initrd-fs.target/start/replace...663test-machine # [ 2.558532] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.664test-machine # [ 2.559701] systemd[1]: Finished rw-sysroot-nix-store.service.665test-machine # [ 2.560712] systemd-sysroot-fstab-check[192]: Requesting swap.target/start/replace...666test-machine # [ 2.562060] systemd[1]: Starting rw-sysroot-nix-store.service...667test-machine # [ 2.563059] systemd[1]: initrd-parse-etc.service: Deactivated successfully.668test-machine # [ 2.564176] systemd[1]: Finished Mountpoints Configured in the Real Root.669test-machine # [ 2.565241] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.670test-machine # [ 2.583104] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.671test-machine # [ 2.584256] systemd[1]: Finished rw-sysroot-nix-store.service.672test-machine # [ 3.380201] systemd[1]: Mounting /sysroot/nix/store...673test-machine # [ 3.401051] systemd[1]: Mounted /sysroot/nix/store.674test-machine # [ 3.402254] systemd[1]: Starting Find the path to the etc metadata image and based dir...675test-machine # [ 3.403499] systemd[1]: Starting Find NixOS closure...676test-machine # [ 3.414944] find-etc[224]: Found init: /nix/store/x8g7wy03988r4yagdj5d5shchwbx9hjn-nixos-system-test-machine-test/init.677test-machine # [ 3.418744] systemd[1]: Finished Find the path to the etc metadata image and based dir.678test-machine # [ 3.420960] systemd[1]: Mounting /run/nixos-etc-metadata...679test-machine # [ 3.422416] systemd[1]: Finished Find NixOS closure.680test-machine # [ 3.624670] loop: module loaded681test-machine # [ 3.625972] loop0: detected capacity change from 0 to 96682test-machine # [ 3.633308] erofs (device loop0): mounted with root inode @ nid 36.683test-machine # [ 3.444738] systemd[1]: Mounted /run/nixos-etc-metadata.684test-machine # [ 3.446764] systemd[1]: Starting rw-etc.service...685test-machine # [ 3.462777] systemd[1]: rw-etc.service: Deactivated successfully.686test-machine # [ 3.464071] systemd[1]: Finished rw-etc.service.687test-machine # [ 3.466143] systemd[1]: Mounting /sysroot/etc...688test-machine # [ 3.471642] systemd[1]: Mounted /sysroot/etc.689test-machine # [ 3.472834] systemd[1]: Reached target Initrd File Systems.690test-machine # [ 3.474423] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...691test-machine # [ 3.480936] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.692test-machine # [ 3.482488] systemd[1]: Reached target Initrd Default Target.693test-machine # [ 3.484070] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...694test-machine # [ 3.492744] systemd[1]: Stopped target Initrd Default Target.695test-machine # [ 3.493732] systemd[1]: Stopped target Basic System.696test-machine # [ 3.494672] systemd[1]: Stopped target Initrd Root Device.697test-machine # [ 3.495682] systemd[1]: Stopped target Path Units.698test-machine # [ 3.496559] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.699test-machine # [ 3.497821] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.700test-machine # [ 3.499219] systemd[1]: Stopped target Slice Units.701test-machine # [ 3.500148] systemd[1]: Stopped target Socket Units.702test-machine # [ 3.501033] systemd[1]: Stopped target System Initialization.703test-machine # [ 3.502291] systemd[1]: Stopped target Swaps.704test-machine # [ 3.503270] systemd[1]: Stopped target Timer Units.705test-machine # [ 3.504332] systemd[1]: Stopped target Trusted Platform Module.706test-machine # [ 3.505655] systemd[1]: dbus.socket: Deactivated successfully.707test-machine # [ 3.506753] systemd[1]: Closed D-Bus System Message Bus Socket.708test-machine # [ 3.507934] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.709test-machine # [ 3.509375] systemd[1]: Stopped Find NixOS closure.710test-machine # [ 3.510289] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio711test-machine # [ 3.513111] systemd[1]: Starting rw-etc.service...712test-machine # [ 3.514084] systemd[1]: Starting rw-sysroot-nix-store.service...713test-machine # [ 3.515072] systemd[1]: systemd-sysctl.service: Deactivated successfully.714test-machine # [ 3.516149] systemd[1]: Stopped Apply Kernel Variables.715test-machine # [ 3.517051] systemd[1]: systemd-modules-load.service: Deactivated successfully.716test-machine # [ 3.518183] systemd[1]: Stopped Load Kernel Modules.717test-machine # [ 3.519043] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.718test-machine # [ 3.520289] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.719test-machine # [ 3.521553] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.720test-machine # [ 3.522832] systemd[1]: Stopped Create System Files and Directories.721test-machine # [ 3.523980] systemd[1]: Stopped target Local File Systems.722test-machine # [ 3.525159] systemd[1]: Stopped target Preparation for Local File Systems.723test-machine # [ 3.526300] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.724test-machine # [ 3.527529] systemd[1]: Stopped Coldplug All udev Devices.725test-machine # [ 3.528469] systemd[1]: Stopping Rule-based Manager for Device Events and Files...726test-machine # [ 3.529688] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.727test-machine # [ 3.530915] systemd[1]: Stopped Virtual Console Setup.728test-machine # [ 3.531828] systemd[1]: initrd-cleanup.service: Deactivated successfully.729test-machine # [ 3.532919] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.730test-machine # [ 3.533950] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.731test-machine # [ 3.535094] systemd[1]: Finished rw-sysroot-nix-store.service.732test-machine # [ 3.536066] systemd[1]: rw-etc.service: Deactivated successfully.733test-machine # [ 3.537039] systemd[1]: Finished rw-etc.service.734test-machine # [ 3.537821] systemd[1]: systemd-udevd.service: Deactivated successfully.735test-machine # [ 3.538846] systemd[1]: Stopped Rule-based Manager for Device Events and Files.736test-machine # [ 3.539960] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.737test-machine # [ 3.541127] systemd[1]: Closed udev Control Socket.738test-machine # [ 3.541975] systemd[1]: Starting Cleanup udev Database...739test-machine # [ 3.543034] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.740test-machine # [ 3.544237] systemd[1]: Stopped Create Static Device Nodes in /dev.741test-machine # [ 3.545226] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.742test-machine # [ 3.546469] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.743test-machine # [ 3.547582] systemd[1]: kmod-static-nodes.service: Deactivated successfully.744test-machine # [ 3.548828] systemd[1]: Stopped Create List of Static Device Nodes.745test-machine # [ 3.549979] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.746test-machine # [ 3.551254] systemd[1]: Finished Cleanup udev Database.747test-machine # [ 3.552145] systemd[1]: Reached target Switch Root.748test-machine # [ 3.553054] systemd[1]: Starting NixOS Activation...749test-machine # [ 3.655605] initrd-nixos-activation-start[258]: booting system configuration /nix/store/x8g7wy03988r4yagdj5d5shchwbx9hjn-nixos-system-test-machine-test750test-machine # [ 3.695942] initrd-nixos-activation-start[258]: running activation script...751test-machine # [ 3.971748] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.752test-machine # [ 3.973257] systemd[1]: Finished NixOS Activation.753test-machine # [ 3.974956] systemd[1]: Starting Switch Root...754test-machine # [ 3.987735] systemd[1]: Switching root.755test-machine # [ 4.230232] systemd-journald[91]: Received SIGTERM from PID 1 (systemd).756test-machine # [ 4.309714] NET: Registered PF_VSOCK protocol family757test-machine # [ 4.678052] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)758test-machine # [ 4.682520] systemd[1]: Detected virtualization kvm.759test-machine # [ 4.683385] systemd[1]: Detected architecture x86-64.760test-machine # [ 4.684313] systemd[1]: Detected first boot.761test-machine # [ 4.687383] systemd[1]: Initializing machine ID from random generator.762test-machine # [ 4.809274] systemd[1]: bpf-restrict-fs: LSM BPF program attached763test-machine # [ 4.869604] zram: Added device: zram0764test-machine # [ 4.878638] systemd[1]: Applying preset policy.765test-machine # [ 5.155384] systemd[1]: Populated /etc with preset unit settings.766test-machine # [ 5.446555] systemd[1]: initrd-switch-root.service: Deactivated successfully.767test-machine # [ 5.448175] systemd[1]: Stopped initrd-switch-root.service.768test-machine # [ 5.450931] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.769test-machine # [ 5.453164] systemd[1]: Created slice Slice /system/systemd-zram-setup.770test-machine # [ 5.454704] systemd[1]: Created slice User and Session Slice.771test-machine # [ 5.455853] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.772test-machine # [ 5.457238] systemd[1]: Started Forward Password Requests to Wall Directory Watch.773test-machine # [ 5.458513] systemd[1]: Expecting device /dev/hvc0...774test-machine # [ 5.459390] systemd[1]: Expecting device /dev/ttyS0...775test-machine # [ 5.460301] systemd[1]: Expecting device /dev/zram0...776test-machine # [ 5.461269] systemd[1]: Reached target Local Encrypted Volumes.777test-machine # [ 5.462298] systemd[1]: Reached target Login Prompts.778test-machine # [ 5.463196] systemd[1]: Stopped target initrd-fs.target.779test-machine # [ 5.464107] systemd[1]: Stopped target initrd-root-fs.target.780test-machine # [ 5.465131] systemd[1]: Stopped target initrd-switch-root.target.781test-machine # [ 5.466380] systemd[1]: Reached target Virtual Machines and Containers.782test-machine # [ 5.467495] systemd[1]: Reached target microvms.target.783test-machine # [ 5.468493] systemd[1]: Reached target Path Units.784test-machine # [ 5.469440] systemd[1]: Reached target Remote File Systems.785test-machine # [ 5.470436] systemd[1]: Reached target Slice Units.786test-machine # [ 5.472734] systemd[1]: Listening on Query the User Interactively for a Password.787test-machine # [ 5.475185] systemd[1]: Listening on Process Core Dump Socket.788test-machine # [ 5.477068] systemd[1]: Listening on Credential Encryption/Decryption.789test-machine # [ 5.479188] systemd[1]: Listening on Factory Reset Management.790test-machine # [ 5.480373] systemd[1]: Listening on Hostname Service Socket.791test-machine # [ 5.483267] systemd[1]: Starting Journal Log Access Socket...792test-machine # [ 5.484769] systemd[1]: Listening on Journal Audit Socket.793test-machine # [ 5.487133] systemd[1]: Listening on Console Output Muting Service Socket.794test-machine # [ 5.488409] systemd[1]: Listening on Network Management Metrics Varlink Socket.795test-machine # [ 5.489833] systemd[1]: Listening on Network Management Varlink Socket.796test-machine # [ 5.491103] systemd[1]: Listening on Network Management Netlink Socket.797test-machine # [ 5.492331] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.798test-machine # [ 5.493973] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os799test-machine # [ 5.495458] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki800test-machine # [ 5.500424] systemd[1]: Listening on Disk Repartitioning Service Socket.801test-machine # [ 5.501622] systemd[1]: Listening on Resolve Monitor Varlink Socket.802test-machine # [ 5.502774] systemd[1]: Listening on Resolve Service Varlink Socket.803test-machine # [ 5.503971] systemd[1]: Listening on udev Control Socket.804test-machine # [ 5.504991] systemd[1]: Listening on udev Varlink Socket.805test-machine # [ 5.508170] systemd[1]: Mounting Huge Pages File System...806test-machine # [ 5.510852] systemd[1]: Mounting POSIX Message Queue File System...807test-machine # [ 5.513349] systemd[1]: Mounting Kernel Debug File System...808test-machine # [ 5.526097] systemd[1]: Mounting Kernel Trace File System...809test-machine # [ 5.527835] systemd[1]: initrd-find-etc.service: Deactivated successfully.810test-machine # [ 5.529765] systemd[1]: Stopped initrd-find-etc.service.811test-machine # [ 5.533348] systemd[1]: Starting Create List of Static Device Nodes...812test-machine # [ 5.534914] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio813test-machine # [ 5.541074] systemd[1]: Starting Load Kernel Module configfs...814test-machine # [ 5.542245] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm815test-machine # [ 5.544054] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore816test-machine # [ 5.545873] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse817test-machine # [ 5.554133] systemd[1]: Mounting FUSE Control File System...818test-machine # [ 5.555728] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67819test-machine # [ 5.563047] systemd[1]: Starting Journal Service...820test-machine # [ 5.567158] systemd[1]: Starting Load Kernel Modules...821test-machine # [ 5.569954] systemd[1]: Starting Remount Root and Kernel File Systems...822test-machine # [ 5.572349] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os823test-machine # [ 5.577218] systemd[1]: Starting Coldplug All udev Devices...824test-machine # [ 5.580460] systemd[1]: Listening on Journal Log Access Socket.825test-machine # [ 5.581750] systemd[1]: Mounted Huge Pages File System.826test-machine # [ 5.583400] systemd[1]: Mounted POSIX Message Queue File System.827test-machine # [ 5.585356] systemd[1]: Mounted Kernel Debug File System.828test-machine # [ 5.587183] systemd[1]: Mounted Kernel Trace File System.829test-machine # [ 5.589004] systemd-journald[358]: Collecting audit messages is enabled.830test-machine # [ 5.591220] systemd[1]: Finished Create List of Static Device Nodes.831test-machine # [ 5.595622] systemd[1]: modprobe@configfs.service: Deactivated successfully.832test-machine # [ 5.597968] EXT4-fs (vda): re-mounted 62096972-4fed-4d3f-98ce-1075aeaff428.833test-machine # [ 5.599182] systemd[1]: Finished Load Kernel Module configfs.834test-machine # [ 5.601175] systemd[1]: Mounted FUSE Control File System.835test-machine # [ 5.602905] systemd[1]: Finished Remount Root and Kernel File Systems.836test-machine # [ 5.605325] systemd[1]: Listening on Disk Image Download Service Socket.837test-machine # [ 5.605389] tun: Universal TUN/TAP device driver, 1.6838test-machine # [ 5.607560] systemd[1]: Mounting Kernel Configuration File System...839test-machine # [ 5.417811] systemd[1]: Queued start job for default target Graphical Interface.840test-machine # [ 5.419775] systemd[1]: systemd-journald.service: Deactivated successfully.841test-machine # [ 5.610295] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore842test-machine # [ 5.423233] systemd-modules-load[359]: Using 4 probe threads843test-machine # [ 5.424909] systemd-modules-load[359]: Module 'ctr' is built in844test-machine # [ 5.426225] systemd-modules-load[359]: Inserted module 'tap'845test-machine # [ 5.427782] systemd-modules-load[359]: Inserted module 'vhost_net'846test-machine # [ 5.620203] systemd[1]: Starting Load/Save OS Random Seed...847test-machine # [ 5.622452] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...848test-machine # [ 5.624134] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os849test-machine # [ 5.626269] systemd[1]: Started Journal Service.850test-machine # [ 5.438910] systemd[1]: Finished Load Kernel Modules.851test-machine # [ 5.440811] systemd[1]: Mounted Kernel Configuration File System.852test-machine # [ 5.448750] systemd[1]: Starting Flush Journal to Persistent Storage...853test-machine # [ 5.451491] systemd[1]: Starting Apply Kernel Variables...854test-machine # [ 5.457090] systemd[1]: Finished Load/Save OS Random Seed.855test-machine # [ 5.459065] systemd[1]: Reached target First Boot Complete.856test-machine # [ 5.662441] systemd-journald[358]: Received client request to flush runtime journal.857test-machine # [ 5.522981] systemd[1]: Finished Apply Kernel Variables.858test-machine # [ 5.524465] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.859test-machine # [ 5.526292] systemd[1]: Starting Network Name Resolution...860test-machine # [ 5.527655] systemd[1]: Starting Create Static Device Nodes in /dev...861test-machine # [ 5.529069] systemd[1]: Finished Flush Journal to Persistent Storage.862test-machine # [ 5.530505] systemd[1]: Finished Coldplug All udev Devices.863test-machine # [ 5.532577] systemd[1]: Finished Create Static Device Nodes in /dev.864test-machine # [ 5.533719] systemd[1]: Reached target Preparation for Local File Systems.865test-machine # [ 5.535247] systemd[1]: Starting Rule-based Manager for Device Events and Files...866test-machine # [ 5.545355] systemd-resolved[387]: Positive Trust Anchors:867test-machine # [ 5.546539] systemd-resolved[387]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d868test-machine # [ 5.548385] systemd-resolved[387]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16869test-machine # [ 5.550038] systemd-resolved[387]: 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 test870test-machine # [ 5.579671] systemd-udevd[394]: Using default interface naming scheme 'v261'.871test-machine # [ 5.597890] systemd-resolved[387]: Using system hostname 'test-machine'.872test-machine # [ 5.603653] systemd[1]: Started Network Name Resolution.873test-machine # [ 5.660037] systemd[1]: Started Rule-based Manager for Device Events and Files.874test-machine # [ 5.727755] systemd[1]: Found device /dev/zram0.875test-machine # [ 5.730148] systemd[1]: Starting Create swap on /dev/zram0...876test-machine # [ 5.736163] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse877test-machine # [ 5.749705] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.878test-machine # [ 5.945913] zram0: detected capacity change from 0 to 6417616879test-machine # [ 5.945933] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized880test-machine # [ 5.758141] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.881test-machine # [ 5.762659] systemd-makefs[422]: Formatting /dev/zram0 as swap882test-machine # [ 5.771594] systemd-makefs[422]: /dev/zram0 successfully formatted as swap (label "zram0", uuid 4004a8aa-672b-43ca-99cc-726478095a8b)883test-machine # [ 5.774074] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line.884test-machine # [ 5.776700] systemd[1]: Finished Create swap on /dev/zram0.885test-machine # [ 5.779662] (udev-worker)[419]: Network interface NamePolicy= disabled on kernel command line.886test-machine # [ 5.781903] systemd[1]: Activating swap Compressed Swap on /dev/zram0...887test-machine # [ 5.808490] systemd[1]: Condition check resulted in /dev/tpmrm0 being skipped.888test-machine # [ 5.810068] systemd[1]: Expecting device /dev/tpm0...889test-machine # [ 6.002250] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3890test-machine # [ 6.006183] Adding 3208804k swap on /dev/zram0. Priority:5 extents:1 across:3208804k SSDsc891test-machine # [ 5.817812] systemd[1]: Activated swap Compressed Swap on /dev/zram0.892test-machine # [ 5.818871] systemd[1]: Reached target Swaps.893test-machine # [ 5.820244] systemd[1]: Start[ 6.011076] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console894test-machine # ing Userspace Out-Of-Memory (OOM) Killer...895test-machine # [ 5.833267] mtp-probe[432]: checking bus 1, device 2: "/sys/devices/pci0000:00/0000:00:1d.7/usb1/1-1"896test-machine # [ 5.835113] mtp-probe[432]: bus: 1, device: 2 was not an MTP device897test-machine # [ 5.837467] systemd[1]: Found device /dev/tpm0.898test-machine # [ 5.838951] systemd[1]: Reached target Trusted Platform Modul[ 6.016856] ACPI: button: Power Button [PWRF]899test-machine # e.900test-machine # [ 6.030853] Console: switching to colour dummy device 80x25901test-machine # [ 6.032775] [drm] Found bochs VGA, ID 0xb0c5.902test-machine # [ 6.032777] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.903test-machine # [ 6.035244] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic904test-machine # [ 6.036265] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0905test-machine # [ 6.045572] Console: switching to colour frame buffer device 160x50906test-machine # [ 6.047067] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device907test-machine # [ 5.882300] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.908test-machine # [ 6.074439] rtc_cmos 00:04: RTC can wake from S4909test-machine # [ 6.075584] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4910test-machine # [ 6.093343] rtc_cmos 00:04: registered as rtc0911test-machine # [ 6.094197] rtc_cmos 00:04: setting system clock to 2026-09-02T04:33:53 UTC (1788323633)912test-machine # [ 5.903520] systemd-resolved[387]: Clock change detected. Flushing caches.913test-machine # [ 6.096382] systemd-journald[358]: Time jumped backwards, rotating.914test-machine # [ 6.096600] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs915test-machine # [ 6.100627] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt916test-machine # [ 6.101759] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD917test-machine # [ 6.106271] parport_pc 00:02: reported by Plug and Play ACPI918test-machine # [ 6.116992] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]919test-machine # [ 6.119695] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6920test-machine # [ 6.123237] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5921test-machine # [ 6.127072] mousedev: PS/2 mouse device common for all mice922test-machine # [ 5.979443] systemd[1]: Starting Virtual Console Setup...923test-machine # [ 6.180084] ppdev: user-space parallel port driver924test-machine # [ 6.005345] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.925test-machine # [ 6.006981] systemd[1]: Stopped Virtual Console Setup.926test-machine # [ 6.012599] systemd[1]: Starting Virtual Console Setup...927test-machine # [ 6.238924] iTCO_wdt iTCO_wdt.0.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)928test-machine # [ 6.241928] iTCO_wdt iTCO_wdt.0.auto: initialized. heartbeat=30 sec (nowayout=0)929test-machine # [ 6.255562] kvm_amd: TSC scaling supported930test-machine # [ 6.256341] kvm_amd: Nested Virtualization enabled931test-machine # [ 6.257122] kvm_amd: Nested Paging enabled932test-machine # [ 6.257888] kvm_amd: LBR virtualization supported933test-machine # [ 6.258623] kvm_amd: Virtual GIF supported934test-machine # [ 6.259383] kvm_amd: Virtual NMI enabled935test-machine # [ 6.298929] EDAC MC: Ver: 3.0.0936test-machine # [ 6.232720] systemd-vconsole-setup[450]: Configuration of first virtual console was skipped, ignoring remaining ones.937test-machine # [ 6.235645] systemd[1]: Finished Virtual Console Setup.938test-machine # [ 6.257483] systemd[1]: Mounting /run/wrappers...939test-machine # [ 6.284949] systemd[1]: Mounted /run/wrappers.940test-machine # [ 6.286147] systemd[1]: Reached target Local File Systems.941test-machine # [ 6.287970] systemd[1]: Listening on Boot Loader Control Service Socket.942test-machine # [ 6.290350] systemd[1]: Starting register-nix-paths.service...943test-machine # [ 6.292689] systemd[1]: Starting Create SUID/SGID Wrappers...944test-machine # [ 6.293910] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.945test-machine # [ 6.303303] systemd[1]: Starting Save Transient machine-id to Disk...946test-machine # [ 6.305746] systemd[1]: Starting Create System Files and Directories...947test-machine # [ 6.322078] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.948test-machine # [ 6.324250] systemd[1]: Finished Save Transient machine-id to Disk.949test-machine # [ 6.331280] systemd-tmpfiles[460]: /etc/tmpfiles.d/tmp.conf:11: Duplicate line for path "/tmp", ignoring.950test-machine # [ 6.340295] systemd[1]: Finished Create System Files and Directories.951test-machine # [ 6.342662] systemd[1]: Starting Rebuild Journal Catalog...952test-machine # [ 6.344108] systemd[1]: Starting Record System Boot/Shutdown in UTMP...953test-machine # [ 6.364840] systemd[1]: Finished Record System Boot/Shutdown in UTMP.954test-machine # [ 6.384984] systemd[1]: Finished Rebuild Journal Catalog.955test-machine # [ 6.387505] systemd[1]: Starting Update is Completed...956test-machine # [ 6.405278] systemd[1]: Finished Update is Completed.957test-machine # [ 6.579300] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.958test-machine # [ 6.580556] systemd[1]: Finished Create SUID/SGID Wrappers.959test-machine # [ 6.721443] systemd[1]: Finished register-nix-paths.service.960test-machine # [ 6.722476] systemd[1]: Reached target System Initialization.961test-machine # [ 6.723507] systemd[1]: Started Discard unused filesystem blocks once a week.962test-machine # [ 6.724729] systemd[1]: Started nix-optimise.timer.963test-machine # [ 6.725643] systemd[1]: Started Daily Cleanup of Temporary Directories.964test-machine # [ 6.726751] systemd[1]: Reached target Timer Units.965test-machine # [ 6.727629] systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket.966test-machine # [ 6.728814] systemd[1]: Listening on D-Bus System Message Bus Socket.967test-machine # [ 6.729866] systemd[1]: Listening on Nix Daemon Socket.968test-machine # [ 6.730951] systemd[1]: Listening on Authorization Manager Agent Helper.969test-machine # [ 6.732832] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).970test-machine # [ 6.734263] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.971test-machine # [ 6.735643] systemd[1]: Reached target Socket Units.972test-machine # [ 6.738062] systemd[1]: Starting D-Bus System Message Bus...973test-machine # [ 6.739626] systemd[1]: Starting nftables firewall...974test-machine # [ 6.801302] dbus-broker-launch[553]: Looking up NSS group entry for 'netdev'...975test-machine # [ 6.805418] dbus-broker-launch[553]: NSS returned no entry for 'netdev'976test-machine # [ 6.806763] dbus-broker-launch[553]: Invalid group-name in /nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/system.d/avahi-dbus.conf +24: group="netdev"977test-machine # [ 6.834880] dbus-broker-launch[553]: Looking up NSS user entry for 'systemd-timesync'...978test-machine # [ 6.836673] dbus-broker-launch[553]: NSS returned no entry for 'systemd-timesync'979test-machine # [ 6.838213] dbus-broker-launch[553]: Invalid user-name in /nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"980test-machine # [ 6.841725] dbus-broker-launch[553]: Looking up NSS user entry for 'pulse'...981test-machine # [ 6.843331] dbus-broker-launch[553]: NSS returned no entry for 'pulse'982test-machine # [ 6.844756] dbus-broker-launch[553]: Invalid user-name in /nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/system.d/pulseaudio-system.conf +27: user="pulse"983test-machine # [ 6.847901] dbus-broker-launch[553]: Invalid group-name in /nix/store/8jq7b6qvy8a4wpdq9w3gm021b1bsvwvm-avahi-0.8/share/dbus-1/system.d/avahi-dbus.conf +24: group="netdev"984test-machine # [ 6.867223] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.nm_dispatcher' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_dispatcher.service'985test-machine # [ 6.871602] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.nm_priv_helper' in service file '/nix/store/6qz6q8j2r2cirh33f67mpdsxnqf8d680-networkmanager-1.58.0/share/dbus-1/system-services/org.freedesktop.nm_priv_helper.service'986test-machine # [ 6.875823] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.ModemManager1' in service file '/nix/store/nhsrpbakhmswx0ykmkxj8q0ykm2ifjlh-modemmanager-1.24.2/share/dbus-1/system-services/org.freedesktop.ModemManager1.service'987test-machine # [ 6.880207] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.UPower' in service file '/nix/store/5mg55wxbm96v7fqfmmyg8xl7zp15g32s-upower-1.91.3/share/dbus-1/system-services/org.freedesktop.UPower.service'988test-machine # [ 6.884340] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.UDisks2' in service file '/nix/store/2rypfklqw1s7y1ym2z20wjqzahjrg8lg-udisks-2.11.2/share/dbus-1/system-services/org.freedesktop.UDisks2.service'989test-machine # [ 6.889157] dbus-broker-launch[553]: Ignoring duplicate name 'net.hadess.PowerProfiles' in service file '/nix/store/y3rhxwgzhya1wijhbixjwbbfv2dp48pr-power-profiles-daemon-0.30/share/dbus-1/system-services/net.hadess.PowerProfiles.service'990test-machine # [ 6.893828] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.UPower.PowerProfiles' in service file '/nix/store/y3rhxwgzhya1wijhbixjwbbfv2dp48pr-power-profiles-daemon-0.30/share/dbus-1/system-services/org.freedesktop.UPower.PowerProfiles.service'991test-machine # [ 6.900328] dbus-broker-launch[553]: Ignoring duplicate name 'org.bluez.mesh' in service file '/nix/store/vlakbh3si797k5mfpzdxl033aq2h3xck-bluez-5.87/share/dbus-1/system-services/org.bluez.mesh.service'992test-machine # [ 6.904908] dbus-broker-launch[553]: Ignoring duplicate name 'org.bluez' in service file '/nix/store/vlakbh3si797k5mfpzdxl033aq2h3xck-bluez-5.87/share/dbus-1/system-services/org.bluez.service'993test-machine # [ 6.909094] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.GeoClue2' in service file '/nix/store/n27dci9a54zmzqws3agifbwlyr2zw9z9-geoclue-2.8.2/share/dbus-1/system-services/org.freedesktop.GeoClue2.service'994test-machine # [ 6.914313] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.Accounts' in service file '/nix/store/dh8ak3h384g6r1ngh53k43139lfz2r1c-accountsservice-26.27.3/share/dbus-1/system-services/org.freedesktop.Accounts.service'995test-machine # [ 6.918374] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.RealtimeKit1' in service file '/nix/store/jdq0ssnlbwsyhd6x5r27affhc52mfr9k-rtkit-0.14/share/dbus-1/system-services/org.freedesktop.RealtimeKit1.service'996test-machine # [ 6.930600] dbus-broker-launch[553]: Ignoring duplicate name 'org.freedesktop.PolicyKit1' in service file '/nix/store/3pj4zjhsfxh3fbj02aqm1pxkyf2d1r7f-polkit-127/share/dbus-1/system-services/org.freedesktop.PolicyKit1.service'997test-machine # [ 6.945126] systemd[1]: Started D-Bus System Message Bus.998test-machine # [ 6.949358] systemd[1]: Reached target Basic System.999test-machine # [ 6.951839] systemd[1]: Starting Network Manager Script Dispatcher Service...1000test-machine # [ 6.955760] systemd[1]: Started ACPI Daemon.1001test-machine # [ 6.958494] systemd[1]: Starting Avahi mDNS/DNS-SD Stack...1002test-machine # [ 6.961623] systemd[1]: Started backdoor.service.1003test-machine # [ 6.964213] systemd[1]: Starting cosmic-greeter-daemon.service...1004test-machine # [ 6.968348] systemd[1]: Started Enable Kernel Same-Page Merging.1005test-machine # [ 6.971753] systemd[1]: Starting Import lastlog data into lastlog2 database...1006test-machine # [ 6.974737] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1007test-machine # [ 6.977906] systemd[1]: Starting Post-Boot Actions...1008test-machine # [ 6.980381] nsncd[572]: Sep 02 04:33:54.569 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1009test-machine # connecting to host...1010test-machine # [ 6.985984] systemd[1]: Started Reset console on configuration changes.1011test-machine # [ 6.991790] pmiqgci6r5j6p9zw2z0n3w0f61xl7ca6-tpm2-udev-trigger.sh[583]: TPM udev rules changed, triggering udev1012test-machine # [ 6.994747] systemd[1]: Starting Stage Nix-managed integration profiles into per-user credential trees...1013test-machine # [ 6.999219] avahi-daemon[566]: Found user 'avahi' (UID 999) and group 'avahi' (GID 999).1014test-machine # [ 6.999476] systemd[1]: Starting Generate the SearXNG secret key...1015test-machine # [ 7.000689] avahi-daemon[566]: Successfully dropped root privileges.1016test-machine # [ 7.001615] systemd[1]: Starting SSH Host Keys Generation...1017test-machine # [ 7.002588] avahi-daemon[566]: avahi-daemon 0.8 starting up.1018test-machine # [ 7.003793] dbus-broker-launch[553]: Ready1019test-machine # [ 7.004709] systemd[1]: Starting Trigger udev change for TPM devices...1020test-machine # [ 7.005296] avahi-daemon[566]: WARNING: No NSS support for mDNS detected, consider installing nss-mdns!1021test-machine # [ 7.005890] systemd[1]: enable-ksm.service: Deactivated successfully.1022test-machine # [ 7.006801] systemd[1]: Finished Post-Boot Actions.1023test-machine # [ 7.007594] systemd[1]: Started Name Service Cache Daemon (nsncd).1024test-machine # [ 7.008561] systemd[1]: Reached target Host and Network Name Lookups.1025test-machine # [ 7.009160] systemd[1]: Reached target User and Group Name Lookups.1026test-machine # [ 7.009725] systemd[1]: Starting Accounts Service...1027test-machine # [ 7.010315] systemd[1]: Starting User Login Management...1028test-machine # [ 7.010925] systemd[1]: Finished Import lastlog data into lastlog2 database.1029test-machine # [ 7.019126] avahi-daemon[566]: No service file found in /etc/avahi/services.1030test-machine # [ 7.019922] avahi-daemon[566]: *** WARNING: Detected another IPv4 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. ***1031test-machine # [ 7.021033] avahi-daemon[566]: *** WARNING: Detected another IPv6 mDNS stack running on this host. This makes mDNS unreliable and is thus not recommended. ***1032test-machine # [ 7.021585] avahi-daemon[566]: Joining mDNS multicast group on interface lo.IPv6 with address ::1.1033test-machine # [ 7.026811] avahi-daemon[566]: New relevant interface lo.IPv6 for mDNS.1034test-machine # [ 7.027558] avahi-daemon[566]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1.1035test-machine # [ 7.028221] systemd[1]: spaces-searxng-secret.service: Deactivated successfully.1036test-machine # [ 7.028769] avahi-daemon[566]: New relevant interface lo.IPv4 for mDNS.1037test-machine # [ 7.031831] systemd[1]: Finished Generate the SearXNG secret key.1038test-machine # [ 7.032467] avahi-daemon[566]: Network interface enumeration completed.1039test-machine # [ 7.034125] acpid[565]: starting up with netlink and the input layer1040test-machine: Guest shell says: b'Spawning backdoor root shell...\n'1041test-machine # [ 7.037037] systemd[1]: Finished Trigger udev change for TPM devices.1042test-machine # [ 7.037707] avahi-daemon[566]: Server startup complete. Host name is test-machine.local. Local service cookie is 966912432.1043test-machine # [ 7.038529] acpid[565]: 3 rules loaded1044test-machine # [ 7.039866] acpid[565]: waiting for events: event logging is off1045test-machine: connected to guest root shell1046test-machine: (connecting took 7.78 seconds)1047test-machine: (finished: waiting for the VM to finish booting, in 7.90 seconds)1048test-machine # [ 7.040661] systemd[1]: Started Avahi mDNS/DNS-SD Stack.1049test-machine # [ 7.042563] systemd[1]: Starting Initialise Searx settings...1050test-machine # [ 7.064991] systemd[1]: Started cosmic-greeter-daemon.service.1051test-machine # [ 7.073388] systemd[1]: Started Network Manager Script Dispatcher Service.1052test-machine # [ 7.080990] systemd-logind[609]: New seat seat0.1053test-machine # [ 7.087372] systemd-logind[609]: Watching system buttons on /dev/input/event2 (Power Button)1054test-machine # [ 7.087694] systemd-logind[609]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1055test-machine # [ 7.094516] systemd-logind[609]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1056test-machine # [ 7.096708] systemd[1]: Started User Login Management.1057test-machine # [ 7.097162] systemd[1]: Starting linger-users.service...1058test-machine # [ 7.098095] systemd[1]: Finished nftables firewall.1059test-machine # [ 7.102270] accounts-daemon[606]: Unable to open /etc/tcb: No such file or directory1060test-machine # [ 7.141795] systemd[1]: Finished Initialise Searx settings.1061test-machine # [ 7.142960] systemd[1]: linger-users.service: Deactivated successfully.1062test-machine # [ 7.144239] systemd[1]: Finished linger-users.service.1063test-machine # [ 7.148393] systemd[1]: Reached target Preparation for Network.1064test-machine # [ 7.150349] systemd[1]: Listening on Network Management Resolve Hook Socket.1065test-machine # [ 7.152125] systemd[1]: Starting Network Manager...1066test-machine # [ 7.154162] systemd[1]: Starting Network Management...1067test-machine # [ 7.155841] dbus-broker-launch[553]: Activation request for 'org.freedesktop.home1' failed: The systemd unit 'dbus-org.freedesktop.home1.service' could not be found.1068test-machine # [ 7.159071] accounts-daemon[606]: couldn't list homed users: GDBus.Error:org.freedesktop.DBus.Error.NameHasNoOwner: Could not activate remote peer 'org.freedesktop.home1': activation request failed: unknown unit1069test-machine # [ 7.167254] systemd[1]: Starting Authorization Manager...1070test-machine # [ 7.201994] systemd[1]: Finished Stage Nix-managed integration profiles into per-user credential trees.1071test-machine # [ 7.218524] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1072test-machine # [ 7.226595] polkitd[682]: Started polkitd version 1271073test-machine # [ 7.254405] systemd[1]: Started Authorization Manager.1074test-machine # [ 7.260131] accounts-daemon[606]: started daemon version 26.27.31075test-machine # [ 7.261620] systemd[1]: Started Accounts Service.1076test-machine # [ 7.281812] systemd[1]: Starting Hostname Service...1077test-machine # [ 7.481056] cfg80211: Loading compiled-in X.509 certificates for regulatory database1078test-machine # [ 7.494231] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1079test-machine # [ 7.495527] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1080test-machine # [ 7.325545] systemd-networkd[679]: lo: Link UP1081test-machine # [ 7.326197] systemd-networkd[679]: lo: Gained carrier1082test-machine # [ 7.332702] systemd[1]: Started Network Management.1083test-machine # [ 7.333152] systemd[1]: Starting Enable Persistent Storage in systemd-networkd...1084test-machine # [ 7.336223] systemd-networkd[679]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1085test-machine # [ 7.336757] systemd-networkd[679]: eth1: Configuring with /etc/systemd/network/40-eth1.network.1086test-machine # [ 7.341146] systemd-networkd[679]: eth1: Link UP1087test-machine # [ 7.343497] systemd[1]: Started Hostname Service.1088test-machine # [ 7.343950] systemd-networkd[679]: eth1: Gained carrier1089test-machine # [ 7.344627] systemd-networkd[679]: eth1: Found matching .network file, based on potentially unpredictable interface name: /etc/systemd/network/40-eth1.network1090test-machine # [ 7.547133] NET: Registered PF_PACKET protocol family1091test-machine # [ 7.362890] avahi-daemon[566]: Joining mDNS multicast group on interface eth1.IPv4 with address 192.168.1.1.1092test-machine # [ 7.364430] avahi-daemon[566]: New relevant interface eth1.IPv4 for mDNS.1093test-machine # [ 7.365622] avahi-daemon[566]: Joining mDNS multicast group on interface eth1.IPv6 with address 2001:db8:1::1.1094test-machine # [ 7.367153] avahi-daemon[566]: New relevant interface eth1.IPv6 for mDNS.1095test-machine # [ 7.370835] systemd[1]: Finished Enable Persistent Storage in systemd-networkd.1096test-machine # [ 7.398370] systemd-networkd[679]: eth0: Link UP1097test-machine # [ 7.399283] systemd-networkd[679]: eth0: Gained carrier1098test-machine # [ 7.406215] systemd[1]: Started Network Manager.1099test-machine # [ 7.406757] systemd[1]: Reached target Network.1100test-machine # [ 7.408767] systemd[1]: Starting Model swapping for LLaMA C++ Server (or any local OpenAPI compatible server)...1101test-machine # [ 7.410872] systemd[1]: Started Searx server, the meta search engine..1102test-machine # [ 7.415406] systemd[1]: Starting Permit User Sessions...1103test-machine # [ 7.429400] avahi-daemon[566]: Joining mDNS multicast group on interface eth0.IPv6 with address fe80::a1f3:ff79:b1c6:e16c.1104test-machine # [ 7.430099] avahi-daemon[566]: New relevant interface eth0.IPv6 for mDNS.1105test-machine # [ 7.471077] systemd[1]: Started Model swapping for LLaMA C++ Server (or any local OpenAPI compatible server).1106test-machine # [ 7.473319] systemd[1]: Finished Permit User Sessions.1107test-machine # [ 7.480449] systemd[1]: Started greetd.service.1108test-machine # [ 7.515930] sshd-keygen-start[637]: Generating public/private rsa key pair.1109test-machine # [ 7.516427] sshd-keygen-start[637]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1110test-machine # [ 7.517268] sshd-keygen-start[637]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1111test-machine # [ 7.517873] sshd-keygen-start[637]: The key fingerprint is:1112test-machine # [ 7.518866] sshd-keygen-start[637]: SHA256:uSn7eOV4Ly31F13q1ozoARayKEWN5N+380EegozRQKY root@test-machine1113test-machine # [ 7.520281] sshd-keygen-start[637]: The key's randomart image is:1114test-machine # [ 7.521058] sshd-keygen-start[637]: +---[RSA 4096]----+1115test-machine # [ 7.521702] sshd-keygen-start[637]: | .o++ |1116test-machine # [ 7.522960] sshd-keygen-start[637]: | o.o.o |1117test-machine # [ 7.523964] sshd-keygen-start[637]: | E o o |1118test-machine # [ 7.524972] sshd-keygen-start[637]: | . o O o .|1119test-machine # [ 7.526057] sshd-keygen-start[637]: | . . S * o o.o|1120test-machine # [ 7.526822] sshd-keygen-start[637]: | . +.o.=.o.|1121test-machine # [ 7.527782] sshd-keygen-start[637]: | . o+ o++o+.|1122test-machine # [ 7.528904] sshd-keygen-start[637]: | +o = o+=.+|1123test-machine # [ 7.530378] sshd-keygen-start[637]: | oo.. =o... |1124test-machine # [ 7.531393] sshd-keygen-start[637]: +----[SHA256]-----+1125test-machine # [ 7.548786] sshd-keygen-start[751]: Generating public/private ed25519 key pair.1126test-machine # [ 7.549299] sshd-keygen-start[751]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1127test-machine # [ 7.550113] sshd-keygen-start[751]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1128test-machine # [ 7.550945] sshd-keygen-start[751]: The key fingerprint is:1129test-machine # [ 7.552106] sshd-keygen-start[751]: SHA256:4rk1Vp5YYQY/6Er/mDlljioMZ6uRJXOyQjTABwDnbR8 root@test-machine1130test-machine # [ 7.552939] sshd-keygen-start[751]: The key's randomart image is:1131test-machine # [ 7.553921] sshd-keygen-start[751]: +--[ED25519 256]--+1132test-machine # [ 7.554815] sshd-keygen-start[751]: |B.o . |1133test-machine # [ 7.556219] sshd-keygen-start[751]: |.+ o + |1134test-machine # [ 7.557101] sshd-keygen-start[751]: | oo o E . * |1135test-machine # [ 7.557921] sshd-keygen-start[751]: |. .. . o o o |1136test-machine # [ 7.558852] sshd-keygen-start[751]: | .+ o + S o |1137test-machine # [ 7.559882] sshd-keygen-start[751]: |. .Ooo = =o. |1138test-machine # [ 7.560386] sshd-keygen-start[751]: |. += .+ *=o |1139test-machine # [ 7.561721] sshd-keygen-start[751]: | . .+ +o*. |1140test-machine # [ 7.562743] sshd-keygen-start[751]: | .. .o.+.. |1141test-machine # [ 7.563486] sshd-keygen-start[751]: +----[SHA256]-----+1142test-machine # [ 7.564158] systemd[1]: sshd-keygen.service: Deactivated successfully.1143test-machine # [ 7.564987] systemd[1]: Finished SSH Host Keys Generation.1144test-machine # [ 7.565921] systemd[1]: Starting SSH Daemon...1145test-machine # [ 7.575558] llama-swap[724]: [INFO] GPU monitoring not available: no GPU monitoring tool available1146test-machine # [ 7.585994] avahi-daemon[566]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.0.2.15.1147test-machine # [ 7.588654] avahi-daemon[566]: New relevant interface eth0.IPv4 for mDNS.1148test-machine # [ 7.590342] systemd-resolved[387]: eth0: Bus client set default route setting: yes1149test-machine # [ 7.592588] systemd-resolved[387]: eth0: Bus client set DNS server list to: 10.0.2.31150test-machine # [ 7.607253] sshd[754]: Server listening on 0.0.0.0 port 22.1151test-machine # [ 7.607729] sshd[754]: Server listening on :: port 22.1152test-machine # [ 7.611809] llama-swap[724]: [INFO] llama-swap is reachable by all hosts on the network, use -listen localhost:8012 to restrict to loopback only1153test-machine # [ 7.612356] llama-swap[724]: [INFO] llama-swap listening on http://0.0.0.0:80121154test-machine # [ 7.642301] systemd[1]: Started SSH Daemon.1155test-machine # [ 7.644102] systemd[1]: Reached target Multi-User System.1156test-machine # [ 7.644725] systemd[1]: Reached target Graphical Interface.1157test-machine # [ 7.645892] systemd[1]: Startup finished in 816ms (kernel) + 3.268s (initrd) + 3.559s (userspace) = 7.644s.1158test-machine # [ 7.768752] greetd[762]: pam_unix(greetd:session): session opened for user test(uid=1000) by (uid=0)1159test-machine # [ 7.809714] systemd[1]: Created slice Slice /user/1000.1160test-machine # [ 7.811844] systemd[1]: Starting User Runtime Directory /run/user/1000...1161test-machine # [ 7.839477] systemd-logind[609]: New session '1' of user 'test' with class 'user' and type 'tty'.1162test-machine # [ 7.849738] systemd[1]: Finished User Runtime Directory /run/user/1000.1163test-machine # [ 7.852609] systemd[1]: Starting User Manager for UID 1000...1164test-machine # [ 7.873343] (systemd)[770]: pam_unix(systemd-user:session): session opened for user test(uid=1000) by (uid=0)1165test-machine # [ 7.877077] systemd-logind[609]: New session '2' of user 'test' with class 'manager' and type 'unspecified'.1166test-machine # [ 7.918264] systemd[770]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1167test-machine # [ 8.151145] systemd[770]: Queued start job for default target Main User Target.1168test-machine # [ 8.157845] systemd[770]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1169test-machine # [ 8.159154] systemd[770]: Created slice User Application Slice.1170test-machine # [ 8.159812] systemd[770]: Started Ask GeoClue for a new location fix.1171test-machine # [ 8.160559] systemd[770]: Started Daily Cleanup of User's Temporary Directories.1172test-machine # [ 8.161123] systemd[770]: Reached target Paths.1173test-machine # [ 8.161771] systemd[770]: Reached target Timers.1174test-machine # [ 8.163154] systemd[770]: Starting D-Bus User Message Bus Socket...1175test-machine # [ 8.163782] systemd[770]: Starting GCR ssh-agent wrapper...1176test-machine # [ 8.164330] systemd[770]: Listening on PipeWire PulseAudio.1177test-machine # [ 8.165114] systemd[770]: Listening on PipeWire Multimedia System Sockets.1178test-machine # [ 8.166035] systemd[770]: Listening on Speech Dispatcher Socket.1179test-machine # [ 8.166782] systemd[770]: Starting Create User Files and Directories...1180test-machine # [ 8.181862] systemd[770]: Listening on GCR ssh-agent wrapper.1181test-machine # [ 8.187519] systemd[770]: Finished Create User Files and Directories.1182test-machine: (finished: waiting for unit multi-user.target, in 9.05 seconds)1183subtest: greetd autostarts the cosmic session1184test-machine: waiting for unit greetd.service1185test-machine # [ 8.210131] systemd[770]: Listening on D-Bus User Message Bus Socket.1186test-machine # [ 8.211774] systemd[770]: Reached target Sockets.1187test-machine # [ 8.212650] systemd[770]: Reached target Basic System.1188test-machine # [ 8.212869] systemd[1]: Started User Manager for UID 1000.1189test-machine # [ 8.215237] systemd[1]: Started Session 1 of User test.1190test-machine # [ 8.216449] systemd[770]: Started GCR ssh-agent wrapper.1191test-machine # [ 8.218969] systemd[770]: Starting Run user-specific NixOS activation...1192test-machine # [ 8.221098] systemd[770]: Starting Link the spaces Agent Skills into this user's harness skill roots...1193test-machine # [ 8.223344] systemd[770]: Starting Spaces aggregating integration MCP gateway...1194test-machine # [ 8.226742] systemd[770]: Starting Spaces integrations broker (enable + secret provisioning over /run/user/1000/spaces-integrations.sock)...1195test-machine: (finished: waiting for unit greetd.service, in 0.04 seconds)1196??? Warning (UserWarning): invoking 'QemuMachine.wait_until_succeeds' is deprecated: It's deprecated to use the `machine` variable when the only machine is called test_machine. This behavior will no longer work in NixOS 27.05.1197 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 19281198??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1199 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391200test-machine: waiting for success: systemctl is-active user@1000.service1201??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1202 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391203test-machine # [ 8.251243] systemd[770]: Finished Run user-specific NixOS activation.1204test-machine # [ 8.259751] systemd[770]: Started Spaces integrations broker (enable + secret provisioning over /run/user/1000/spaces-integrations.sock).1205test-machine # [ 8.260752] systemd[770]: Started Spaces aggregating integration MCP gateway.1206test-machine: (finished: waiting for success: systemctl is-active user@1000.service, in 0.03 seconds)1207(finished: subtest: greetd autostarts the cosmic session, in 0.07 seconds)1208subtest: cosmic-session.target starts under the user manager1209test-machine: waiting for success: systemctl --user --machine=test@.host is-active cosmic-session.target1210test-machine # [ 8.278304] greetd[762]: gkr-pam: gnome-keyring-daemon started properly1211test-machine # [ 8.294465] systemd[1]: Started [systemd-run] systemd-stdio-bridge --user --quiet.1212test-machine # [ 8.295770] spaces-integrationd[796]: 2026/09/02 04:33:55 listening on /run/user/1000/spaces-integrations.sock (defs=/etc/spaces-integrations state=/home/test/.local/state/spaces-integrationd managed=/run/spaces-integrations-managed/test)1213test-machine # [ 8.313573] systemd[770]: Finished Link the spaces Agent Skills into this user's harness skill roots.1214test-machine # [ 8.314226] systemd[770]: Reached target Main User Target.1215test-machine # [ 8.315384] systemd[770]: Startup finished in 408ms.1216test-machine # [ 8.328545] (systemd-stdio-bridge)[837]: pam_unix(login:session): session opened for user test(uid=1000) by (uid=0)1217test-machine # [ 8.346242] systemd[1]: Started Session 3 of User test.1218test-machine # [ 8.355835] (systemd-stdio-bridge)[837]: gkr-pam: couldn't unlock the login keyring.1219test-machine # [ 8.369949] systemd[770]: Created slice User Core Session Slice.1220test-machine # [ 8.372774] systemd[770]: Starting D-Bus User Message Bus...1221test-machine # [ 8.423404] dbus-broker-launch[861]: Ignoring duplicate name 'ca.desrt.dconf' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/ca.desrt.dconf.service'1222test-machine # [ 8.424448] dbus-broker-launch[861]: Ignoring duplicate name 'com.system76.CosmicStatusNotifierWatcher' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/com.system76.CosmicStatusNotifierWatcher.service'1223test-machine # [ 8.425502] dbus-broker-launch[861]: Ignoring duplicate name 'org.a11y.Bus' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.a11y.Bus.service'1224test-machine # [ 8.426209] dbus-broker-launch[861]: Ignoring duplicate name 'org.bluez.obex' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.bluez.obex.service'1225test-machine # [ 8.427299] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.PermissionStore' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.impl.portal.PermissionStore.service'1226test-machine # [ 8.428425] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.Secret' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.impl.portal.Secret.service'1227test-machine # [ 8.429256] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.desktop.cosmic' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.impl.portal.desktop.cosmic.service'1228test-machine # [ 8.430082] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.desktop.gtk' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.impl.portal.desktop.gtk.service'1229test-machine # [ 8.430605] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.import1.service'1230test-machine # [ 8.431288] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.machine1.service'1231test-machine # [ 8.432274] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.portable1.service'1232test-machine # [ 8.433088] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.portal.Desktop' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.portal.Desktop.service'1233test-machine # [ 8.433895] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.portal.Documents' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.portal.Documents.service'1234test-machine # [ 8.435026] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.secrets' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.secrets.service'1235test-machine # [ 8.436134] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'1236test-machine # [ 8.437084] dbus-broker-launch[861]: Ignoring duplicate name 'org.gnome.keyring' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gnome.keyring.service'1237test-machine # [ 8.437807] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.AfcVolumeMonitor' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.AfcVolumeMonitor.service'1238test-machine # [ 8.438810] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.Daemon' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.Daemon.service'1239test-machine # [ 8.439800] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.GPhoto2VolumeMonitor' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.GPhoto2VolumeMonitor.service'1240test-machine # [ 8.440909] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.GoaVolumeMonitor' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.GoaVolumeMonitor.service'1241test-machine # [ 8.441689] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.MTPVolumeMonitor' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.MTPVolumeMonitor.service'1242test-machine # [ 8.442507] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.Metadata' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.Metadata.service'1243test-machine # [ 8.501098] dbus-broker-launch[861]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored1244test-machine # [ 8.501739] dbus-broker-launch[861]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored1245test-machine # [ 8.502892] gnome-keyring-daemon[862]: discover_other_daemon: 11246test-machine # [ 8.503870] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.UDisks2VolumeMonitor' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.gtk.vfs.UDisks2VolumeMonitor.service'1247test-machine # [ 8.504900] dbus-broker-launch[861]: Ignoring duplicate name 'org.mpris.MediaPlayer2.playerctld' in service file '/nix/store/gx57iki7l1xyhcaf7hmid9zlp8wwasfi-system-path/share/dbus-1/services/org.mpris.MediaPlayer2.playerctld.service'1248test-machine # [ 8.505789] dbus-broker-launch[861]: Ignoring duplicate name 'org.bluez.obex' in service file '/nix/store/vlakbh3si797k5mfpzdxl033aq2h3xck-bluez-5.87/share/dbus-1/services/org.bluez.obex.service'1249test-machine # [ 8.506709] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.AfcVolumeMonitor' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.AfcVolumeMonitor.service'1250test-machine # [ 8.507375] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.Daemon' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.Daemon.service'1251test-machine # [ 8.508159] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.GPhoto2VolumeMonitor' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.GPhoto2VolumeMonitor.service'1252test-machine # [ 8.508691] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.GoaVolumeMonitor' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.GoaVolumeMonitor.service'1253test-machine # [ 8.509719] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.MTPVolumeMonitor' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.MTPVolumeMonitor.service'1254test-machine # [ 8.510780] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.Metadata' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.Metadata.service'1255test-machine # [ 8.511867] dbus-broker-launch[861]: Ignoring duplicate name 'org.gtk.vfs.UDisks2VolumeMonitor' in service file '/nix/store/5pizqp7n9bqn65nssaxdiqgps2ns99fm-gvfs-1.60.2/share/dbus-1/services/org.gtk.vfs.UDisks2VolumeMonitor.service'1256test-machine # [ 8.512655] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.Secret' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.freedesktop.impl.portal.Secret.service'1257test-machine # [ 8.513697] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.secrets' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.freedesktop.secrets.service'1258test-machine # [ 8.514688] dbus-broker-launch[861]: Ignoring duplicate name 'org.gnome.keyring' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.gnome.keyring.service'1259test-machine # [ 8.515188] dbus-broker-launch[861]: Ignoring duplicate name 'org.a11y.Bus' in service file '/nix/store/iw5kcyxqr3c4w4m2d2yaqxkkis07awr3-at-spi2-core-2.60.6/share/dbus-1/services/org.a11y.Bus.service'1260test-machine # [ 8.515658] dbus-broker-launch[861]: Ignoring duplicate name 'ca.desrt.dconf' in service file '/nix/store/vvp0i1h7pwrwm1im3pnmdpbziwng677i-dconf-0.49.0/share/dbus-1/services/ca.desrt.dconf.service'1261test-machine # [ 8.516687] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.PermissionStore' in service file '/nix/store/hwfl4n2p049q0pa2gzsrjfiqlgf6cbny-xdg-desktop-portal-1.22.1/share/dbus-1/services/org.freedesktop.impl.portal.PermissionStore.service'1262test-machine # [ 8.517769] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.portal.Desktop' in service file '/nix/store/hwfl4n2p049q0pa2gzsrjfiqlgf6cbny-xdg-desktop-portal-1.22.1/share/dbus-1/services/org.freedesktop.portal.Desktop.service'1263test-machine # [ 8.518792] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.portal.Documents' in service file '/nix/store/hwfl4n2p049q0pa2gzsrjfiqlgf6cbny-xdg-desktop-portal-1.22.1/share/dbus-1/services/org.freedesktop.portal.Documents.service'1264test-machine # [ 8.519857] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.desktop.cosmic' in service file '/nix/store/1yfa68m0plf8h1n1yrisf7j0xav13h7a-xdg-desktop-portal-cosmic-1.6.0/share/dbus-1/services/org.freedesktop.impl.portal.desktop.cosmic.service'1265test-machine # [ 8.596204] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.desktop.gtk' in service file '/nix/store/rkw3wzziv59inxy9j8bmkc42459b62cm-xdg-desktop-portal-gtk-1.15.3/share/dbus-1/services/org.freedesktop.impl.portal.desktop.gtk.service'1266test-machine # [ 8.597978] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.impl.portal.Secret' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.freedesktop.impl.portal.Secret.service'1267test-machine # [ 8.598863] dbus-broker-launch[861]: Ignoring duplicate name 'org.freedesktop.secrets' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.freedesktop.secrets.service'1268test-machine # [ 8.599876] dbus-broker-launch[861]: Ignoring duplicate name 'org.gnome.keyring' in service file '/nix/store/fzlx5v79b04caw21xysr632zjrww0zdv-gnome-keyring-50.0/share/dbus-1/services/org.gnome.keyring.service'1269test-machine # [ 8.601193] systemd[770]: Started D-Bus User Message Bus.1270test-machine # [ 8.602413] dbus-broker-launch[861]: Ready1271test-machine # [ 8.603960] cosmic-session[828]: Starting cosmic-session1272test-machine # [ 8.605150] cosmic-session[828]: starting process ' COSMIC_SESSION_SOCK=12 cosmic-comp '1273test-machine # [ 8.623279] systemd[1]: run-p831-i832.service: Deactivated successfully.1274test-machine # [ 8.623794] (sd-pam)[854]: pam_unix(login:session): session closed for user test1275test-machine # [ 8.632631] systemd[1]: session-3.scope: Deactivated successfully.1276test-machine # [ 8.684481] cosmic-comp[900]: error loading system dark theme1277test-machine # [ 8.718318] cosmic-comp[900]: error loading system dark theme1278test-machine # [ 8.820714] cosmic-comp[900]: Unable to become drm master, assuming unprivileged mode1279test-machine # [ 9.008619] systemd-networkd[679]: eth1: Gained IPv6LL1280test-machine # [ 9.232707] cosmic-comp[900]: ignoring requested context priority, EGL_IMG_context_priority not supported1281test-machine # [ 9.391607] systemd-networkd[679]: eth0: Gained IPv6LL1282test-machine # [ 9.505788] cosmic-comp[900]: Erroneous EGL call didn't set EGLError1283test-machine # [ 9.515439] cosmic-comp[900]: ignoring requested context priority, EGL_IMG_context_priority not supported1284test-machine # [ 9.526594] cosmic-comp[900]: ignoring requested context priority, EGL_IMG_context_priority not supported1285test-machine # [ 9.592804] avahi-daemon[566]: Leaving mDNS multicast group on interface eth0.IPv6 with address fe80::a1f3:ff79:b1c6:e16c.1286test-machine # [ 9.593281] avahi-daemon[566]: Joining mDNS multicast group on interface eth0.IPv6 with address fec0::4e5b:bd1f:effc:527d.1287test-machine # [ 9.649158] systemd[1]: Started [systemd-run] systemd-stdio-bridge --user --quiet.1288test-machine # [ 9.665810] cosmic-comp[900]: ignoring requested context priority, EGL_IMG_context_priority not supported1289test-machine # [ 9.676354] (systemd-stdio-bridge)[931]: pam_unix(login:session): session opened for user test(uid=1000) by (uid=0)1290test-machine # [ 9.686238] systemd[1]: Started Session 4 of User test.1291test-machine # [ 9.697062] (systemd-stdio-bridge)[931]: gkr-pam: couldn't unlock the login keyring.1292test-machine # [ 9.714918] cosmic-comp[900]: Erroneous EGL call didn't set EGLError1293test-machine # [ 9.729813] systemd[1]: run-p930-i931.service: Deactivated successfully.1294test-machine # [ 9.734236] (sd-pam)[934]: pam_unix(login:session): session closed for user test1295test-machine # [ 9.739733] systemd[1]: session-4.scope: Deactivated successfully.1296test-machine # [ 9.762343] cosmic-comp[900]: failed to create signaled syncobj1297test-machine # [ 9.763876] cosmic-comp[900]: Preferred format AB30 not available: NoSupportedPlaneFormat1298test-machine # [ 9.764273] cosmic-comp[900]: Preferred format AR30 not available: NoSupportedPlaneFormat1299test-machine # [ 9.764935] cosmic-comp[900]: Preferred format AB24 not available: NoSupportedPlaneFormat1300test-machine # [ 9.929416] searxng-run[725]: 2026-09-02 04:33:57,525 WARNING:searx.data: TRACKER_PATTERNS: HTTPError (https://rules1.clearurls.xyz/data.minify.json) occured while fetching [Errno -2] Name or service not known1301test-machine # [ 9.930994] searxng-run[725]: 2026-09-02 04:33:57,527 WARNING:searx.data: TRACKER_PATTERNS: HTTPError (https://rules2.clearurls.xyz/data.minify.json) occured while fetching [Errno -2] Name or service not known1302test-machine # [ 9.932051] systemd-resolved[387]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 10.0.2.3.1303test-machine # [ 9.932712] searxng-run[725]: 2026-09-02 04:33:57,528 WARNING:searx.data: TRACKER_PATTERNS: HTTPError (https://raw.githubusercontent.com/ClearURLs/Rules/refs/heads/master/data.min.json) occured while fetching [Errno -2] Name or service not known1304test-machine # [ 9.933780] searxng-run[725]: 2026-09-02 04:33:57,528 ERROR:searx.data: TRACKER_PATTERNS: failed fetching ClearURL rule lists1305test-machine # [ 9.974718] searxng-run[725]: 2026-09-02 04:33:57,571 ERROR:searx.engines: (PID 725) ahmia: can't register engine (loading engine failed)1306test-machine # [ 10.086899] cosmic-session[828]: got environmental variables from cosmic-comp: [("WAYLAND_DISPLAY", "wayland-1"), ("DISPLAY", ":0")]1307test-machine # [ 10.087969] cosmic-comp[900]: `xrdb` not found, cannot update Xresources.1308test-machine # [ 10.093603] cosmic-comp[900]: `xrdb` not found, cannot update Xresources.1309test-machine # [ 10.094978] cosmic-comp[900]: Error reading from session socket1310test-machine # [ 10.158957] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-settings-daemon '1311test-machine # [ 10.179218] systemd[770]: Reached target Session services which should run early before the graphical session is brought up.1312test-machine # [ 10.179668] systemd[770]: Reached target Cosmic Session Target.1313test-machine # [ 10.180704] systemd[770]: Reached target Current graphical user session.1314test-machine # [ 10.182951] systemd[770]: Starting COSMIC Initial Setup...1315test-machine # [ 10.184630] systemd[770]: Starting Certificate and Key Storage...1316test-machine # [ 10.188860] systemd[770]: Starting Secret Storage Service...1317test-machine # [ 10.191699] systemd[770]: Starting NetworkManager Applet...1318test-machine # [ 10.194908] systemd[770]: Starting User folders update...1319test-machine # [ 10.199059] systemd[770]: Started Voice recording tray indicator.1320test-machine # [ 10.201456] systemd[770]: Started VoxType push-to-talk voice-to-text daemon.1321test-machine # [ 10.206138] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland DAEMON_NOTIFICATIONS_FD=23 cosmic-notifications '1322test-machine # [ 10.213044] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland PANEL_NOTIFICATIONS_FD=21 cosmic-panel '1323test-machine # [ 10.218063] cosmic-session[828]: ERROR Failed to sync with greeter. Permission denied (os error 13)1324test-machine # [ 10.218814] cosmic-session[828]: at src/main.rs:495 on main1325test-machine # [ 10.219412] cosmic-session[828]: 1326test-machine # [ 10.220719] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-app-library '1327test-machine # [ 10.228241] systemd[770]: app-nm\x2dapplet@autostart.service: Skipped due to 'exec-condition'.1328test-machine # [ 10.233084] systemd[770]: Condition check resulted in NetworkManager Applet being skipped.1329test-machine # [ 10.234927] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-launcher '1330test-machine # [ 10.245236] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-workspaces '1331test-machine # [ 10.251032] systemd[770]: Started Certificate and Key Storage.1332test-machine # [ 10.253309] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-osd '1333test-machine # [ 10.256843] systemd[770]: Started Secret Storage Service.1334test-machine # [ 10.259423] systemd[1]: Starting RealtimeKit Scheduling Policy Service...1335test-machine # [ 10.259850] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-bg '1336test-machine # [ 10.267470] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-greeter '1337test-machine # [ 10.274643] systemd[770]: Started cosmic-app-library.scope.1338test-machine # [ 10.276534] systemd[770]: Started cosmic-launcher.scope.1339test-machine # [ 10.279468] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-files-applet '1340test-machine # [ 10.280607] systemd[770]: Started cosmic-workspaces.scope.1341test-machine # [ 10.282183] systemd[770]: Started COSMIC Initial Setup.1342test-machine # [ 10.288113] gnome-keyring-daemon[815]: The PKCS#11 component was already initialized1343test-machine # [ 10.289060] gnome-keyring-daemon[997]: discover_other_daemon: 11344test-machine # [ 10.294381] cosmic-session[828]: starting process ' WAYLAND_DISPLAY=wayland-1 DISPLAY=:0 XDG_SESSION_TYPE=wayland cosmic-idle '1345test-machine # [ 10.297816] gnome-keyring-daemon[997]: discover_other_daemon: 11346test-machine # [ 10.303652] gnome-keyring-daemon[815]: The Secret Service was already initialized1347test-machine # [ 10.307190] gnome-keyring-daemon[1001]: discover_other_daemon: 11348test-machine # [ 10.310211] gnome-keyring-daemon[1001]: discover_other_daemon: 11349test-machine # [ 10.318068] systemd[770]: Started User folders update.1350test-machine # [ 10.321641] systemd[1]: Starting Daemon for power management...1351test-machine # [ 10.328498] systemd[1]: Starting Locale Service...1352test-machine # [ 10.329720] searxng-run[725]: 2026-09-02 04:33:57,925 ERROR:searx.engines: (PID 725) torch: can't register engine (loading engine failed)1353test-machine # [ 10.337331] cosmic-session[828]: No schemas installed1354test-machine # [ 10.341157] cosmic-session[828]: No schemas installed1355test-machine # [ 10.346448] cosmic-panel[980]: Falling back to default panel configuration1356test-machine # [ 10.349637] cosmic-panel[980]: Panel Entry Error: NoConfigDirectory1357test-machine # [ 10.352726] systemd[770]: Started cosmic-bg.scope.1358test-machine # [ 10.355104] systemd[770]: Started cosmic-files-applet.scope.1359test-machine # [ 10.359178] systemd[770]: Started cosmic-greeter.scope.1360test-machine # [ 10.361057] systemd[1]: Started RealtimeKit Scheduling Policy Service.1361test-machine # [ 10.363577] systemd[770]: Started cosmic-idle.scope.1362test-machine # [ 10.365792] rtkit-daemon[991]: Handling system-suspend using logind.1363test-machine # [ 10.381355] systemd[770]: Started cosmic-osd.scope.1364test-machine # [ 10.386538] cosmic-notifications[974]: error loading system dark theme1365test-machine # [ 10.390243] systemd[770]: Reached target Startup of XDG autostart applications.1366test-machine # [ 10.394103] cosmic-session[828]: 2026-09-02T04:33:57.981267Z ERROR cosmic::theme: error loading system dark theme error=GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1367test-machine # [ 10.402648] systemd[770]: Starting Accessibility services bus...1368test-machine # [ 10.405657] systemd[770]: Started PipeWire Multimedia Service.1369test-machine # [ 10.408198] systemd[770]: Started Multimedia Service Session Manager.1370test-machine # [ 10.410447] systemd[1]: Started Locale Service.1371test-machine # [ 10.504365] rtkit-daemon[991]: Successfully made thread 1012 of process 1012 owned by '1000' high priority at nice level -11.1372test-machine # [ 10.507815] systemd[1]: Started Daemon for power management.1373test-machine # [ 10.513094] cosmic-session[828]: [2026-09-02T04:33:58Z ERROR cosmic::theme] error loading system dark theme error=GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1374test-machine # [ 10.526645] rtkit-daemon[991]: Successfully made thread 1043 of process 1012 owned by '1000' RT at priority 20.1375test-machine # [ 10.532047] systemd[770]: Started Accessibility services bus.1376test-machine # [ 10.547063] systemd-resolved[387]: Using degraded feature set TCP instead of UDP for DNS server 10.0.2.3.1377test-machine # [ 10.548297] systemd-resolved[387]: Using degraded feature set UDP instead of TCP for DNS server 10.0.2.3.1378test-machine # [ 10.549664] searxng-run[725]: 2026-09-02 04:33:58,133 ERROR:searx.searx.search.processor: (PID 725) wikidata: engine INIT failed, exception: [Errno -2] Name or service not known1379test-machine # [ 10.551369] searxng-run[725]: Traceback (most recent call last):1380test-machine # [ 10.551936] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_transports/default.py", line 101, in map_httpcore_exceptions1381test-machine # [ 10.553287] searxng-run[725]: yield1382test-machine # [ 10.553612] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_transports/default.py", line 394, in handle_async_request1383test-machine # [ 10.554713] searxng-run[725]: resp = await self._pool.handle_async_request(req)1384test-machine # [ 10.555707] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1385test-machine # [ 10.556557] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_async/connection_pool.py", line 256, in handle_async_request1386test-machine # [ 10.557376] searxng-run[725]: raise exc from None1387test-machine # [ 10.558268] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_async/connection_pool.py", line 236, in handle_async_request1388test-machine # [ 10.558895] searxng-run[725]: response = await connection.handle_async_request(1389test-machine # [ 10.560130] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1390test-machine # [ 10.561151] searxng-run[725]: pool_request.request1391test-machine # [ 10.561927] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^1392test-machine # [ 10.562777] searxng-run[725]: )1393test-machine # [ 10.563751] searxng-run[725]: ^1394test-machine # [ 10.564645] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_async/connection.py", line 101, in handle_async_request1395test-machine # [ 10.565845] searxng-run[725]: raise exc1396test-machine # [ 10.567276] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_async/connection.py", line 78, in handle_async_request1397test-machine # [ 10.568133] searxng-run[725]: stream = await self._connect(request)1398test-machine # [ 10.568980] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^1399test-machine # [ 10.570254] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_async/connection.py", line 124, in _connect1400test-machine # [ 10.571089] searxng-run[725]: stream = await self._network_backend.connect_tcp(**kwargs)1401test-machine # [ 10.572124] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1402test-machine # [ 10.572710] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_backends/auto.py", line 31, in connect_tcp1403test-machine # [ 10.573580] searxng-run[725]: return await self._backend.connect_tcp(1404test-machine # [ 10.574462] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1405test-machine # [ 10.575921] searxng-run[725]: ...<5 lines>...1406test-machine # [ 10.576683] searxng-run[725]: )1407test-machine # [ 10.578744] searxng-run[725]: ^1408test-machine # [ 10.580057] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_backends/anyio.py", line 113, in connect_tcp1409test-machine # [ 10.580709] searxng-run[725]: with map_exceptions(exc_map):1410test-machine # [ 10.581898] searxng-run[725]: ~~~~~~~~~~~~~~^^^^^^^^^1411test-machine # [ 10.582946] searxng-run[725]: File "/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/lib/python3.14/contextlib.py", line 162, in __exit__1412test-machine # [ 10.584116] searxng-run[725]: self.gen.throw(value)1413test-machine # [ 10.585203] searxng-run[725]: ~~~~~~~~~~~~~~^^^^^^^1414test-machine # [ 10.586162] searxng-run[725]: File "/nix/store/xa75mvdg891rnc1ajzbfvys35x7y8gbh-python3.14-httpcore-1.0.9/lib/python3.14/site-packages/httpcore/_exceptions.py", line 14, in map_exceptions1415test-machine # [ 10.587338] searxng-run[725]: raise to_exc(exc) from exc1416test-machine # [ 10.588492] searxng-run[725]: httpcore.ConnectError: [Errno -2] Name or service not known1417test-machine # [ 10.589219] searxng-run[725]: The above exception was the direct cause of the following exception:1418test-machine # [ 10.590204] searxng-run[725]: Traceback (most recent call last):1419test-machine # [ 10.591095] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/search/processors/abstract.py", line 158, in init_engine1420test-machine # [ 10.592074] searxng-run[725]: init_ok = self.engine.init(eng_setting)1421test-machine # [ 10.593182] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/engines/wikidata.py", line 839, in init1422test-machine # [ 10.593841] searxng-run[725]: init_wikidata_properties()1423test-machine # [ 10.595113] searxng-run[725]: ~~~~~~~~~~~~~~~~~~~~~~~~^^1424test-machine # [ 10.596116] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/engines/wikidata.py", line 866, in init_wikidata_properties1425test-machine # [ 10.597306] searxng-run[725]: jsonresponse = send_wikidata_query(query, **kwargs)1426test-machine # [ 10.597738] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/engines/wikidata.py", line 473, in send_wikidata_query1427test-machine # [ 10.599672] searxng-run[725]: http_response = get(SPARQL_ENDPOINT_URL + "?" + urlencode({"query": query}), headers=get_headers(), **kwargs)1428test-machine # [ 10.600922] cosmic-panel[980]: Error loading light theme: GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1429test-machine # [ 10.602650] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/network/__init__.py", line 175, in get1430test-machine # [ 10.604401] searxng-run[725]: return request('get', url, **kwargs)1431test-machine # [ 10.606695] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/network/__init__.py", line 106, in request1432test-machine # [ 10.607549] searxng-run[725]: return future.result(timeout)1433test-machine # [ 10.612934] searxng-run[725]: ~~~~~~~~~~~~~^^^^^^^^^1434test-machine # [ 10.615113] searxng-run[725]: File "/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/lib/python3.14/concurrent/futures/_base.py", line 454, in result1435test-machine # [ 10.617216] searxng-run[725]: return self.__get_result()1436test-machine # [ 10.617885] searxng-run[725]: ~~~~~~~~~~~~~~~~~^^1437test-machine # [ 10.619847] searxng-run[725]: File "/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/lib/python3.14/concurrent/futures/_base.py", line 396, in __get_result1438test-machine # [ 10.620653] searxng-run[725]: raise self._exception1439test-machine # [ 10.622806] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/network/network.py", line 304, in request1440test-machine # [ 10.623464] searxng-run[725]: return await self.call_client(False, method, url, **kwargs)1441test-machine # [ 10.624050] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1442test-machine # [ 10.624614] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/network/network.py", line 300, in call_client1443test-machine # [ 10.625647] searxng-run[725]: raise e1444test-machine # [ 10.626149] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/network/network.py", line 285, in call_client1445test-machine # [ 10.627707] searxng-run[725]: response = await client.request(method, url, **kwargs)1446test-machine # [ 10.628829] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1447test-machine # [ 10.630602] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_client.py", line 1540, in request1448test-machine # [ 10.632528] searxng-run[725]: return await self.send(request, auth=auth, follow_redirects=follow_redirects)1449test-machine # [ 10.633719] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1450test-machine # [ 10.635732] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_client.py", line 1629, in send1451test-machine # [ 10.636897] searxng-run[725]: response = await self._send_handling_auth(1452test-machine # [ 10.638844] cosmic-launcher[985]: error loading system dark theme1453test-machine # [ 10.639858] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1454test-machine # [ 10.640445] searxng-run[725]: ...<4 lines>...1455test-machine # [ 10.641271] searxng-run[725]: )1456test-machine # [ 10.641792] searxng-run[725]: ^1457test-machine # [ 10.644140] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_client.py", line 1657, in _send_handling_auth1458test-machine # [ 10.644753] searxng-run[725]: response = await self._send_handling_redirects(1459test-machine # [ 10.645961] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1460test-machine # [ 10.646642] searxng-run[725]: ...<3 lines>...1461test-machine # [ 10.647201] searxng-run[725]: )1462test-machine # [ 10.647751] searxng-run[725]: ^1463test-machine # [ 10.649212] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_client.py", line 1694, in _send_handling_redirects1464test-machine # [ 10.649808] searxng-run[725]: response = await self._send_single_request(request)1465test-machine # [ 10.651254] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1466test-machine # [ 10.651863] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_client.py", line 1730, in _send_single_request1467test-machine # [ 10.653880] searxng-run[725]: response = await transport.handle_async_request(request)1468test-machine # [ 10.655029] searxng-run[725]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1469test-machine # [ 10.656873] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_transports/default.py", line 393, in handle_async_request1470test-machine # [ 10.659465] searxng-run[725]: with map_httpcore_exceptions():1471test-machine # [ 10.660221] searxng-run[725]: ~~~~~~~~~~~~~~~~~~~~~~~^^1472test-machine # [ 10.660768] searxng-run[725]: File "/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/lib/python3.14/contextlib.py", line 162, in __exit__1473test-machine # [ 10.662777] searxng-run[725]: self.gen.throw(value)1474test-machine # [ 10.663558] searxng-run[725]: ~~~~~~~~~~~~~~^^^^^^^1475test-machine # [ 10.664145] searxng-run[725]: File "/nix/store/7d281qd1ymhjx4lb6ar5kqickqay29iz-python3.14-httpx-0.28.1/lib/python3.14/site-packages/httpx/_transports/default.py", line 118, in map_httpcore_exceptions1476test-machine # [ 10.665991] searxng-run[725]: raise mapped_exc(message) from exc1477test-machine # [ 10.666769] searxng-run[725]: httpx.ConnectError: [Errno -2] Name or service not known1478test-machine # [ 10.667708] searxng-run[725]: 2026-09-02 04:33:58,141 WARNING:searx.botdetection.config: missing config file: /run/searx/limiter.toml1479test-machine # [ 10.670686] searxng-run[725]: * Serving Flask app 'searx.webapp'1480test-machine # [ 10.671241] searxng-run[725]: * Debug mode: off1481test-machine # [ 10.671823] searxng-run[725]: 2026-09-02 04:33:58,146 ERROR:searx.searx.search.processor: (PID 725) wikidata: engine init was not successful1482test-machine # [ 10.672852] searxng-run[725]: 2026-09-02 04:33:58,147 ERROR:searx.search.processors: (PID 725) wikidata: can't register engines processor (init engine failed)1483test-machine # [ 10.674681] cosmic-panel[980]: Error loading dark theme: GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1484test-machine # [ 10.676764] searxng-run[725]: 2026-09-02 04:33:58,156 ERROR:searx.searx.search.processor: (PID 725) radio browser: engine INIT failed, exception: [Errno -2] Name or service not known1485test-machine # [ 10.768636] searxng-run[725]: Traceback (most recent call last):1486test-machine # [ 10.769172] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/search/processors/abstract.py", line 158, in init_engine1487test-machine # [ 10.769737] searxng-run[725]: init_ok = self.engine.init(eng_setting)1488test-machine # [ 10.771233] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/engines/radio_browser.py", line 71, in init1489test-machine # [ 10.771748] searxng-run[725]: server_list()1490test-machine # [ 10.772492] searxng-run[725]: ~~~~~~~~~~~^^1491test-machine # [ 10.773170] searxng-run[725]: File "/nix/store/n8gxgz8nsxah3ppqvxwz2gv5026q9h1r-searxng-0-unstable-2026-08-22/lib/python3.14/site-packages/searx/engines/radio_browser.py", line 86, in server_list1492test-machine # [ 10.773798] searxng-run[725]: ips = socket.getaddrinfo("all.api.radio-browser.info", 80, 0, 0, socket.IPPROTO_TCP)1493test-machine # [ 10.774619] searxng-run[725]: File "/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/lib/python3.14/socket.py", line 989, in getaddrinfo1494test-machine # [ 10.775121] searxng-run[725]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):1495test-machine # [ 10.775662] searxng-run[725]: ~~~~~~~~~~~~~~~~~~~^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^1496test-machine # [ 10.776239] searxng-run[725]: socket.gaierror: [Errno -2] Name or service not known1497test-machine # [ 10.776796] searxng-run[725]: 2026-09-02 04:33:58,158 ERROR:searx.searx.search.processor: (PID 725) radio browser: engine init was not successful1498test-machine # [ 10.777634] searxng-run[725]: 2026-09-02 04:33:58,158 ERROR:searx.search.processors: (PID 725) radio browser: can't register engines processor (init engine failed)1499test-machine # [ 10.778470] cosmic-greeter[994]: failed to open icon "/var/lib/AccountsService/icons/test": Os { code: 2, kind: NotFound, message: "No such file or directory" }1500test-machine # [ 10.779228] voxtype-daemon[970]: 2026-09-02T04:33:58.312491Z INFO Using Energy VAD backend1501test-machine # [ 10.779928] voxtype-daemon[970]: 2026-09-02T04:33:58.313162Z INFO Voice Activity Detection enabled (backend: Energy, threshold: 0.40, min_speech: 100ms)1502test-machine # [ 10.780655] voxtype-daemon[970]: 2026-09-02T04:33:58.315110Z INFO Starting voxtype daemon1503test-machine # [ 10.781223] rtkit-daemon[991]: Successfully made thread 1013 of process 1013 owned by '1000' high priority at nice level -11.1504test-machine # [ 10.781775] cosmic-session[828]: ERROR cosmic::theme > error loading system dark theme error=GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1505test-machine # [ 10.782527] rtkit-daemon[991]: Successfully made thread 1124 of process 1013 owned by '1000' RT at priority 20.1506test-machine # [ 10.783101] cosmic-session[828]: [2026-09-02T04:33:58Z ERROR cosmic::theme] error loading system dark theme error=GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1507test-machine # [ 10.783646] cosmic-launcher[985]: Failed to activate another instance1508test-machine # [ 10.784285] cosmic-greeter[994]: failed to load cosmic-theme config: [GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })]1509test-machine # [ 10.785142] systemd[1]: Started [systemd-run] systemd-stdio-bridge --user --quiet.1510test-machine # [ 10.834182] cosmic-session[828]: ERROR error loading system dark theme, error: GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1511test-machine # [ 10.845907] cosmic-session[828]: at /build/cosmic-files-1.6.0-vendor/source-git-2/libcosmic-1.0.0/src/theme/mod.rs:95 on main1512test-machine # [ 10.851207] cosmic-session[828]: 1513test-machine # [ 10.854767] cosmic-session[828]: ERROR error loading system dark theme, error: GetKey("frosted_maximized_apps", Os { code: 2, kind: NotFound, message: "No such file or directory" })1514test-machine # [ 10.862323] cosmic-session[828]: at /build/cosmic-files-1.6.0-vendor/source-git-2/libcosmic-1.0.0/src/theme/mod.rs:95 on main1515test-machine # [ 10.870275] (systemd-stdio-bridge)[1142]: pam_unix(login:session): session opened for user test(uid=1000) by (uid=0)1516test-machine # [ 10.875795] cosmic-session[828]: 1517test-machine # [ 10.878387] cosmic-greeter[994]: failed to load cosmic-theme builder config: [RonSpanned(SpannedError { code: ExpectedIdentifier, span: Span { start: Position { line: 1, col: 1 }, end: Position { line: 1, col: 1 } } })]1518test-machine # [ 10.888529] cosmic-session[828]: ERROR error loading system dark theme, error: GetKey("list_button", Os { code: 2, kind: NotFound, message: "No such file or directory" })1519test-machine # [ 10.897490] cosmic-session[828]: at /build/cosmic-files-1.6.0-vendor/source-git-2/libcosmic-1.0.0/src/theme/mod.rs:95 on main1520test-machine # [ 10.904338] cosmic-session[828]: 1521test-machine # [ 10.906221] cosmic-session[828]: ERROR error loading system dark theme, error: GetKey("frosted_maximized_apps", Os { code: 2, kind: NotFound, message: "No such file or directory" })1522test-machine # [ 10.912890] cosmic-session[828]: at /build/cosmic-files-1.6.0-vendor/source-git-2/libcosmic-1.0.0/src/theme/mod.rs:95 on main1523test-machine # [ 10.919624] cosmic-session[828]: 1524test-machine # [ 10.922709] cosmic-greeter[994]: errors loading cosmic-comp config: [GetKey("workspaces", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("pinned_workspaces", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("input_default", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("input_touchpad_override", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("input_devices", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("xkb_config", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("keyboard_config", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("autotile", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("autotile_behavior", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("active_hint", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("focus_follows_cursor", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("cursor_follows_focus", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("focus_follows_cursor_delay", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("descale_xwayland", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("xwayland_eavesdropping", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("edge_snap_threshold", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("accessibility_zoom", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("appearance_settings", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("cursor_hide_timeout", Os { code: 2, kind: NotFound, message: "No such file or directory" }), GetKey("activation_policy", Os { code: 2, kind: NotFound, message: "No such file or directory" })]1525test-machine # [ 10.981766] cosmic-greeter[994]: error loading system dark theme1526test-machine # [ 10.984864] systemd[1]: Started Session 5 of User test.1527test-machine # [ 11.003224] (systemd-stdio-bridge)[1142]: gkr-pam: couldn't unlock the login keyring.1528test-machine # [ 11.009140] cosmic-session[828]: MESA-EGL: warning: failed to get driver name for fd -11529test-machine # [ 11.019871] cosmic-panel[980]: [EGL] 0x3003 (BAD_ALLOC) eglInitialize: DRI2: failed to get driver name1530test-machine # [ 11.031391] cosmic-session[828]: MESA-EGL: warning: MESA-LOADER: failed to retrieve device information1531test-machine # [ 11.032263] cosmic-session[828]: MESA-EGL: warning: failed to get driver name for fd -11532test-machine: (finished: waiting for success: systemctl --user --machine=test@.host is-active cosmic-session.target, in 2.78 seconds)1533(finished: subtest: cosmic-session.target starts under the user manager, in 2.78 seconds)1534subtest: cosmic exposes its Wayland socket1535test-machine: waiting for success: systemctl --user --machine=test@.host show-environment | grep -q '^WAYLAND_DISPLAY='1536test-machine # [ 11.046446] systemd[1]: run-p1141-i1142.service: Deactivated successfully.1537test-machine # [ 11.048619] (sd-pam)[1151]: pam_unix(login:session): session closed for user test1538test-machine # [ 11.050702] wireplumber[1013]: spa.bluez5: BlueZ system service is not available1539test-machine # [ 11.064307] voxtype-daemon[970]: 2026-09-02T04:33:58.660737Z INFO Audio level socket listening at "/run/user/1000/voxtype/audio.sock"1540test-machine # [ 11.065710] voxtype-daemon[970]: 2026-09-02T04:33:58.660861Z INFO OSD audio level socket: "/run/user/1000/voxtype/audio.sock"1541test-machine # [ 11.067251] systemd[1]: session-5.scope: Deactivated successfully.1542test-machine # [ 11.072939] voxtype-daemon[970]: 2026-09-02T04:33:58.669268Z INFO Output mode: Type1543test-machine # [ 11.074148] voxtype-daemon[970]: 2026-09-02T04:33:58.669427Z INFO State file: "/run/user/1000/voxtype/state"1544test-machine # [ 11.074322] voxtype-daemon[970]: 2026-09-02T04:33:58.669439Z INFO Built-in hotkey disabled, use 'voxtype record' commands or compositor keybindings1545test-machine # [ 11.087408] voxtype-daemon[970]: 2026-09-02T04:33:58.683830Z INFO Loading transcription model: /nix/store/cp89s185x1ykj4fi5a5mn9nlbvz1vwnn-ggml-small.bin1546test-machine # [ 11.090074] voxtype-daemon[970]: 2026-09-02T04:33:58.686516Z INFO Preloading primary model '/nix/store/cp89s185x1ykj4fi5a5mn9nlbvz1vwnn-ggml-small.bin'1547test-machine # [ 11.092547] voxtype-daemon[970]: 2026-09-02T04:33:58.688482Z INFO Loading model '/nix/store/cp89s185x1ykj4fi5a5mn9nlbvz1vwnn-ggml-small.bin' into cache1548test-machine # [ 11.094181] voxtype-daemon[970]: 2026-09-02T04:33:58.690745Z INFO Loading whisper model from "/nix/store/cp89s185x1ykj4fi5a5mn9nlbvz1vwnn-ggml-small.bin"1549test-machine # [ 11.096269] voxtype-daemon[970]: whisper_init_from_file_with_params_no_state: loading model from '/nix/store/cp89s185x1ykj4fi5a5mn9nlbvz1vwnn-ggml-small.bin'1550test-machine # [ 11.099248] voxtype-daemon[970]: whisper_init_with_params_no_state: use gpu = 11551test-machine # [ 11.100924] systemd[1]: Started [systemd-run] systemd-stdio-bridge --user --quiet.1552test-machine # [ 11.105277] voxtype-daemon[970]: whisper_init_with_params_no_state: flash attn = 01553test-machine # [ 11.107759] voxtype-daemon[970]: whisper_init_with_params_no_state: gpu_device = 01554test-machine # [ 11.111248] voxtype-daemon[970]: whisper_init_with_params_no_state: dtw = 01555test-machine # [ 11.137132] (systemd-stdio-bridge)[1168]: pam_unix(login:session): session opened for user test(uid=1000) by (uid=0)1556test-machine # [ 11.149516] systemd[1]: Started Session 6 of User test.1557test-machine # [ 11.166508] (systemd-stdio-bridge)[1168]: gkr-pam: couldn't unlock the login keyring.1558test-machine: (finished: waiting for success: systemctl --user --machine=test@.host show-environment | grep -q '^WAYLAND_DISPLAY=', in 0.14 seconds)1559??? Warning (UserWarning): invoking 'QemuMachine.succeed' is deprecated: It's deprecated to use the `machine` variable when the only machine is called test_machine. This behavior will no longer work in NixOS 27.05.1560 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 19281561test-machine: must succeed: sock=$(systemctl --user --machine=test@.host show-environment | sed -n 's/^WAYLAND_DISPLAY=//p'); test -S /run/user/1000/$sock1562test-machine # [ 11.191189] systemd[1]: run-p1167-i1168.service: Deactivated successfully.1563test-machine # [ 11.191599] (sd-pam)[1182]: pam_unix(login:session): session closed for user test1564test-machine # [ 11.199712] systemd[1]: session-6.scope: Deactivated successfully.1565test-machine # [ 11.214725] systemd[1]: Started [systemd-run] systemd-stdio-bridge --user --quiet.1566test-machine # [ 11.229782] wireplumber[1013]: [0:00:11.229398178] [1013] INFO Camera camera_manager.cpp:340 libcamera v0.7.21567test-machine # [ 11.232065] wireplumber[1013]: [0:00:11.230332096] [1199] INFO IPAManager ipa_manager.cpp:148 libcamera is not installed. Adding '/nix/store/src/ipa' to the IPA search path1568test-machine # [ 11.249193] (systemd-stdio-bridge)[1196]: pam_unix(login:session): session opened for user test(uid=1000) by (uid=0)1569test-machine # [ 11.263727] systemd[1]: Started Session 7 of User test.1570test-machine # [ 11.274545] (systemd-stdio-bridge)[1196]: gkr-pam: couldn't unlock the login keyring.1571test-machine # [ 11.294277] systemd[1]: run-p1193-i1194.service: Deactivated successfully.1572test-machine # [ 11.295654] (sd-pam)[1202]: pam_unix(login:session): session closed for user test1573test-machine: (finished: must succeed: sock=$(systemctl --user --machine=test@.host show-environment | sed -n 's/^WAYLAND_DISPLAY=//p'); test -S /run/user/1000/$sock, in 0.11 seconds)1574(finished: subtest: cosmic exposes its Wayland socket, in 0.25 seconds)1575subtest: llama-swap is up1576??? Warning (UserWarning): invoking 'QemuMachine.wait_for_open_port' is deprecated: It's deprecated to use the `machine` variable when the only machine is called test_machine. This behavior will no longer work in NixOS 27.05.1577 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/machine/__init__.py", line 19281578??? Warning (UserWarning): wait_for_open_port(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1579 File "/nix/store/n2idrk0jvf991mc9cwbdlyb60018wbhz-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391580test-machine: waiting for TCP port 8012 on localhost1581test-machine # [ 11.308635] systemd[1]: session-7.scope: Deactivated successfully.1582test-machine # [ 11.317810] systemd-localed[1005]: The X11 keyboard layout 'us' is converted to virtual console keymap 'us'1583test-machine # [ 11.333399] systemd-localed[1005]: The X11 keyboard layout 'us' is converted to virtual console keymap 'us'1584test-machine # [ 11.337595] systemd-localed[1005]: Changed X11 keyboard layout to 'us' model 'pc104' variant '' options 'terminate:ctrl_alt_bksp'1585test-machine # [ 11.338576] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1586test-machine # [ 11.338730] systemd[1]: Stopped Virtual Console Setup.1587test-machine # [ 11.344342] systemd[1]: Stopping Virtual Console Setup...1588test-machine # [ 11.345550] systemd-localed[1005]: The X11 keyboard layout 'us' is converted to virtual console keymap 'us'1589test-machine # [ 11.347385] systemd[1]: Starting Virtual Console Setup...1590test-machine # Connection to localhost (::1) 8012 port [tcp/*] succeeded!1591test-machine: (finished: waiting for TCP port 8012 on localhost, in 0.07 seconds)1592(finished: subtest: llama-swap is up, in 0.07 seconds)1593(finished: run the VM test script, in 12.23 seconds)1594test script finished in 12.25s1595cleanup1596kill QemuMachine (pid 45)1597test-machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1598(finished: cleanup, in 0.05 seconds)