nixbot

builds

failed vm-test-run-systemd-shutdown checks.x86_64-linux.systemd-shutdown · build #60 · raw

1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.4emY94M0wz', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 09723eba-3352-43b8-953b-caa084c7178d17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Starting virtiofs daemons...27machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)28machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether29machine # [2026-10-18T02:51:18Z INFO virtiofsd] Waiting for vhost-user socket connection...30machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-10-18T02:51:18Z INFO virtiofsd] Waiting for vhost-user socket connection...33machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)34machine # [2026-10-18T02:51:18Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether35machine # [2026-10-18T02:51:18Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-10-18T02:51:18Z INFO virtiofsd] Client connected, servicing requests37machine # [2026-10-18T02:51:18Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-18T02:51:18Z INFO virtiofsd] Client connected, servicing requests39machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)40machine # 41machine # 42machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0043machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...44machine # 45machine # 46machine # 47machine # 48machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0049machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...50machine # 51machine # 52machine # Booting from ROM...53machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC @179172517254machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/rgs7204zwh1ifs1wn4kmjza7f0ysfdpk-nixos-system-machine-test/init regInfo=/nix/.ro-store/yxb5dc0i4sswx85cglv5vczfs7ff620f-closure-info/registration console=ttyS0,115200n8 console=tty055machine # [ 0.000000] BIOS-provided physical RAM map:56machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable57machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved58machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved59machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable60machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved61machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved62machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved63machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved64machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved65machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved66machine # [ 0.000000] NX (Execute Disable) protection: active67machine # [ 0.000000] APIC: Static calls initialized68machine # [ 0.000000] SMBIOS 2.8 present.69machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201470machine # [ 0.000000] DMI: Memory slots populated: 1/171machine # [ 0.000000] Hypervisor detected: KVM72machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000073machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0074machine # [ 0.000000] kvm-clock: using sched offset of 462851793 cycles75machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns76machine # [ 0.000005] tsc: Detected 2400.008 MHz processor77machine # [ 0.000763] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000078machine # [ 0.000789] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs79machine # [ 0.000792] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT80machine # [ 0.002675] found SMP MP-table at [mem 0x000f5450-0x000f545f]81machine # [ 0.002687] Using GB pages for direct mapping82machine # [ 0.002813] RAMDISK: [mem 0x3f4ba000-0x3ffcffff]83machine # [ 0.002822] ACPI: Early table checksum verification disabled84machine # [ 0.002825] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )85machine # [ 0.002829] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)86machine # [ 0.002833] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)87machine # [ 0.002840] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002842] ACPI: FACS 0x000000003FFE0000 00004089machine # [ 0.002843] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)90machine # [ 0.002845] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)91machine # [ 0.002847] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002848] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002849] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]94machine # [ 0.002850] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]95machine # [ 0.002851] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]96machine # [ 0.002852] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]97machine # [ 0.002852] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]98machine # [ 0.002852] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]99machine # [ 0.002853] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]100machine # [ 0.003076] No NUMA configuration found101machine # [ 0.003076] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]102machine # [ 0.003079] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]103machine # [ 0.005225] Zone ranges:104machine # [ 0.005226] DMA [mem 0x0000000000001000-0x0000000000ffffff]105machine # [ 0.005227] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]106machine # [ 0.005228] Normal empty107machine # [ 0.005229] Device empty108machine # [ 0.005229] Movable zone start for each node109machine # [ 0.005230] Early memory node ranges110machine # [ 0.005231] node 0: [mem 0x0000000000001000-0x000000000009efff]111machine # [ 0.005232] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]112machine # [ 0.005232] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]113machine # [ 0.005251] On node 0, zone DMA: 1 pages in unavailable ranges114machine # [ 0.005494] On node 0, zone DMA: 97 pages in unavailable ranges115machine # [ 0.022047] On node 0, zone DMA32: 40 pages in unavailable ranges116machine # [ 0.022491] ACPI: PM-Timer IO Port: 0x608117machine # [ 0.022501] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])118machine # [ 0.022527] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23119machine # [ 0.022529] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)120machine # [ 0.022531] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)121machine # [ 0.022532] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)122machine # [ 0.022533] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)123machine # [ 0.022533] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)124machine # [ 0.022536] ACPI: Using ACPI (MADT) for SMP configuration information125machine # [ 0.022537] ACPI: HPET id: 0x8086a201 base: 0xfed00000126machine # [ 0.022539] TSC deadline timer available127machine # [ 0.022543] CPU topo: Max. logical packages: 1128machine # [ 0.022544] CPU topo: Max. logical dies: 1129machine # [ 0.022544] CPU topo: Max. dies per package: 1130machine # [ 0.022548] CPU topo: Max. threads per core: 1131machine # [ 0.022548] CPU topo: Num. cores per package: 1132machine # [ 0.022549] CPU topo: Num. threads per package: 1133machine # [ 0.022549] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs134machine # [ 0.022565] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()135machine # [ 0.022591] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]136machine # [ 0.022593] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]137machine # [ 0.022594] [mem 0x40000000-0xafffffff] available for PCI devices138machine # [ 0.022595] Booting paravirtualized kernel on KVM139machine # [ 0.022597] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns140machine # [ 0.027219] setup_percpu: NR_CPUS:512 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1141machine # [ 0.029246] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152142machine # [ 0.029286] kvm-guest: PV spinlocks disabled, single CPU143machine # [ 0.029288] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/rgs7204zwh1ifs1wn4kmjza7f0ysfdpk-nixos-system-machine-test/init regInfo=/nix/.ro-store/yxb5dc0i4sswx85cglv5vczfs7ff620f-closure-info/registration console=ttyS0,115200n8 console=tty0144machine # [ 0.029373] Unknown kernel command line parameters "regInfo=/nix/.ro-store/yxb5dc0i4sswx85cglv5vczfs7ff620f-closure-info/registration", will be passed to user space.145machine # [ 0.029385] random: crng init done146machine # [ 0.029386] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes147machine # [ 0.029406] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)148machine # [ 0.030026] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)149machine # [ 0.030055] Fallback order for Node 0: 0150machine # [ 0.030057] Built 1 zonelists, mobility grouping on. Total pages: 262006151machine # [ 0.030058] Policy zone: DMA32152machine # [ 0.032111] mem auto-init: stack:all(zero), heap alloc:on, heap free:off153machine # [ 0.034406] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1154machine # [ 0.036487] allocated 2097152 bytes of page_ext155machine # [ 0.046250] ftrace: allocating 48842 entries in 192 pages156machine # [ 0.046252] ftrace: allocated 192 pages with 2 groups157machine # [ 0.047044] Dynamic Preempt: lazy158machine # [ 0.047183] rcu: Preemptible hierarchical RCU implementation.159machine # [ 0.047184] rcu: RCU event tracing is enabled.160machine # [ 0.047185] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.161machine # [ 0.047188] Trampoline variant of Tasks RCU enabled.162machine # [ 0.047189] Rude variant of Tasks RCU enabled.163machine # [ 0.047189] Tracing variant of Tasks RCU enabled.164machine # [ 0.047191] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.165machine # [ 0.047192] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1166machine # [ 0.047210] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167machine # [ 0.047212] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.168machine # [ 0.047213] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.169machine # [ 0.051443] NR_IRQS: 33024, nr_irqs: 256, preallocated irqs: 16170machine # [ 0.051737] rcu: srcu_init: Setting srcu_struct sizes based on contention.171machine # [ 0.051743] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns172machine # [ 0.051844] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)173machine # [ 0.055344] Console: colour VGA+ 80x25174machine # [ 0.055348] printk: legacy console [tty0] enabled175machine # [ 0.084691] printk: legacy console [ttyS0] enabled176machine # [ 0.191117] ACPI: Core revision 20250807177machine # [ 0.192010] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns178machine # [ 0.193650] APIC: Switch to symmetric I/O mode setup179machine # [ 0.194712] x2apic enabled180machine # [ 0.195463] APIC: Switched APIC routing to: physical x2apic181machine # [ 0.197522] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1182machine # [ 0.198536] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns183machine # [ 0.200265] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)184machine # [ 0.201360] x86/cpu: User Mode Instruction Prevention (UMIP) activated185machine # [ 0.202415] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127186machine # [ 0.203264] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0187machine # [ 0.204267] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto188machine # [ 0.205263] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl189machine # [ 0.206263] Transient Scheduler Attacks: Vulnerable: No microcode190machine # [ 0.208047] Spectre V2 : Mitigation: Enhanced / Automatic IBRS191machine # [ 0.208975] Speculative Return Stack Overflow: Mitigation: Safe RET192machine # [ 0.210094] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization193machine # [ 0.211270] Spectre V2 : Enabling IBPB for BPF194machine # [ 0.212831] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier195machine # [ 0.213264] active return thunk: srso_alias_return_thunk196machine # [ 0.214283] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'197machine # [ 0.215262] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'198machine # [ 0.216263] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'199machine # [ 0.217262] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'200machine # [ 0.218262] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'201machine # [ 0.219264] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'202machine # [ 0.221071] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'203machine # [ 0.222263] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256204machine # [ 0.223262] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64205machine # [ 0.224262] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512206machine # [ 0.225262] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024207machine # [ 0.226262] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8208machine # [ 0.227262] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.209machine # [ 0.261707] Freeing SMP alternatives memory: 48K210machine # [ 0.262265] pid_max: default: 32768 minimum: 301211machine # [ 0.263349] LSM: initializing lsm=capability,landlock,yama,bpf,ima212machine # [ 0.264354] landlock: Up and running.213machine # [ 0.264997] Yama: becoming mindful.214machine # [ 0.265936] LSM support for eBPF active215machine # [ 0.266354] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)216machine # [ 0.267283] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217machine # [ 0.270422] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)218machine # [ 0.271936] Performance Events: Fam17h+ core perfctr, AMD PMU driver.219machine # [ 0.272273] ... version: 2220machine # [ 0.273032] ... bit width: 48221machine # [ 0.273265] ... generic counters: 6222machine # [ 0.274014] ... generic bitmap: 000000000000003f223machine # [ 0.274265] ... fixed-purpose counters: 0224machine # [ 0.275009] ... fixed-purpose bitmap: 0000000000000000225machine # [ 0.275265] ... value mask: 0000ffffffffffff226machine # [ 0.276206] ... max period: 00007fffffffffff227machine # [ 0.277024] ... global_ctrl mask: 000000000000003f228machine # [ 0.277383] signal: max sigframe size: 3376229machine # [ 0.278198] rcu: Hierarchical SRCU implementation.230machine # [ 0.278927] rcu: Max phase no-delay instances is 400.231machine # [ 0.283819] smp: Bringing up secondary CPUs ...232machine # [ 0.284280] smp: Brought up 1 node, 1 CPU233machine # [ 0.284999] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)234machine # [ 0.285458] Memory: 958760K/1048024K available (18132K kernel code, 2734K rwdata, 13652K rodata, 3660K init, 3620K bss, 81872K reserved, 0K cma-reserved)235machine # [ 0.286474] devtmpfs: initialized236machine # [ 0.287324] x86/mm: Memory block size: 128MB237machine # [ 0.289022] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)238machine # [ 0.290252] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).239machine # [ 0.291345] pinctrl core: initialized pinctrl subsystem240machine # [ 0.292494] PM: RTC time: 02:51:18, date: 2026-10-18241machine # [ 0.295827] NET: Registered PF_NETLINK/PF_ROUTE protocol family242machine # [ 0.296610] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations243machine # [ 0.297280] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations244machine # [ 0.298401] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations245machine # [ 0.299273] audit: initializing netlink subsys (disabled)246machine # [ 0.300414] thermal_sys: Registered thermal governor 'fair_share'247machine # [ 0.300416] thermal_sys: Registered thermal governor 'bang_bang'248machine # [ 0.301266] thermal_sys: Registered thermal governor 'step_wise'249machine # [ 0.302197] thermal_sys: Registered thermal governor 'user_space'250machine # [ 0.302992] audit: type=2000 audit(1792291879.325:1): state=initialized audit_enabled=0 res=1251machine # [ 0.304268] thermal_sys: Registered thermal governor 'power_allocator'252machine # [ 0.304283] cpuidle: using governor menu253machine # [ 0.306464] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5254machine # [ 0.307512] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]255machine # [ 0.308268] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry256machine # [ 0.309278] PCI: Using configuration type 1 for base access257machine # [ 0.310368] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.258machine # [ 0.315505] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages259machine # [ 0.316266] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page260machine # [ 0.321266] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages261machine # [ 0.322265] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page262machine # [ 0.332675] ACPI: Added _OSI(Module Device)263machine # [ 0.333267] ACPI: Added _OSI(Processor Device)264machine # [ 0.334046] ACPI: Added _OSI(Processor Aggregator Device)265machine # [ 0.342746] ACPI: 1 ACPI AML tables successfully acquired and loaded266machine # [ 0.346683] ACPI: Interpreter enabled267machine # [ 0.347280] ACPI: PM: (supports S0 S3 S4 S5)268machine # [ 0.347999] ACPI: Using IOAPIC for interrupt routing269machine # [ 0.348311] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug270machine # [ 0.349265] PCI: Using E820 reservations for host bridge windows271machine # [ 0.352403] ACPI: Enabled 2 GPEs in block 00 to 3F272machine # [ 0.359946] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])273machine # [ 0.360271] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]274machine # [ 0.361342] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]275machine # [ 0.362397] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]276machine # [ 0.363604] PCI host bridge to bus 0000:00277machine # [ 0.364269] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]278machine # [ 0.365266] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]279machine # [ 0.366265] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]280machine # [ 0.367265] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]281machine # [ 0.368267] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]282machine # [ 0.369265] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]283machine # [ 0.370266] pci_bus 0000:00: root bus resource [bus 00-ff]284machine # [ 0.371330] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint285machine # [ 0.372697] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint286machine # [ 0.375281] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]287machine # [ 0.376277] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]288machine # [ 0.377286] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]289machine # [ 0.378434] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]290machine # [ 0.380231] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint291machine # [ 0.382290] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]292machine # [ 0.383199] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]293machine # [ 0.384070] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]294machine # [ 0.385180] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]295machine # [ 0.386797] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint296machine # [ 0.389282] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]297machine # [ 0.390153] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]298machine # [ 0.390992] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]299machine # [ 0.391806] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint300machine # [ 0.394291] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]301machine # [ 0.395107] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]302machine # [ 0.395966] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]303machine # [ 0.396809] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint304machine # [ 0.398282] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]305machine # [ 0.399135] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]306machine # [ 0.400009] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]307machine # [ 0.400272] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]308machine # [ 0.401769] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint309machine # [ 0.403559] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]310machine # [ 0.404287] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]311machine # [ 0.405809] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint312machine # [ 0.407048] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]313machine # [ 0.407287] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]314machine # [ 0.408842] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint315machine # [ 0.410181] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]316machine # [ 0.411225] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]317machine # [ 0.412615] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint318machine # [ 0.414052] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]319machine # [ 0.414974] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]320machine # [ 0.415805] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint321machine # [ 0.417296] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]322machine # [ 0.418272] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]323machine # [ 0.419227] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]324machine # [ 0.420640] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint325machine # [ 0.422280] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]326machine # [ 0.423101] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]327machine # [ 0.423965] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]328machine # [ 0.424834] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint329machine # [ 0.426026] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]330machine # [ 0.426466] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint331machine # [ 0.427788] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]332machine # [ 0.428465] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint333machine # [ 0.429820] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]334machine # [ 0.430488] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint335machine # [ 0.432775] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]336machine # [ 0.433534] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint337machine # [ 0.434563] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO338machine # [ 0.435527] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint339machine # [ 0.437071] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]340machine # [ 0.437898] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]341machine # [ 0.438577] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint342machine # [ 0.439788] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]343machine # [ 0.443332] ACPI: PCI: Interrupt link LNKA configured for IRQ 10344machine # [ 0.444371] ACPI: PCI: Interrupt link LNKB configured for IRQ 10345machine # [ 0.445365] ACPI: PCI: Interrupt link LNKC configured for IRQ 11346machine # [ 0.446366] ACPI: PCI: Interrupt link LNKD configured for IRQ 11347machine # [ 0.447365] ACPI: PCI: Interrupt link LNKE configured for IRQ 10348machine # [ 0.448362] ACPI: PCI: Interrupt link LNKF configured for IRQ 10349machine # [ 0.449374] ACPI: PCI: Interrupt link LNKG configured for IRQ 11350machine # [ 0.450374] ACPI: PCI: Interrupt link LNKH configured for IRQ 11351machine # [ 0.451310] ACPI: PCI: Interrupt link GSIA configured for IRQ 16352machine # [ 0.452284] ACPI: PCI: Interrupt link GSIB configured for IRQ 17353machine # [ 0.453283] ACPI: PCI: Interrupt link GSIC configured for IRQ 18354machine # [ 0.454280] ACPI: PCI: Interrupt link GSID configured for IRQ 19355machine # [ 0.455277] ACPI: PCI: Interrupt link GSIE configured for IRQ 20356machine # [ 0.456279] ACPI: PCI: Interrupt link GSIF configured for IRQ 21357machine # [ 0.457277] ACPI: PCI: Interrupt link GSIG configured for IRQ 22358machine # [ 0.458295] ACPI: PCI: Interrupt link GSIH configured for IRQ 23359machine # [ 0.460252] iommu: Default domain type: Translated360machine # [ 0.460909] iommu: DMA domain TLB invalidation policy: lazy mode361machine # [ 0.461521] ACPI: bus type USB registered362machine # [ 0.462281] usbcore: registered new interface driver usbfs363machine # [ 0.463205] usbcore: registered new interface driver hub364machine # [ 0.463951] usbcore: registered new device driver usb365machine # [ 0.465225] NetLabel: Initializing366machine # [ 0.465736] NetLabel: domain hash size = 128367machine # [ 0.466265] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO368machine # [ 0.467254] NetLabel: unlabeled traffic allowed by default369machine # [ 0.468021] PCI: Using ACPI for IRQ routing370machine # [ 0.511591] pci 0000:00:01.0: vgaarb: setting as boot VGA device371machine # [ 0.512261] pci 0000:00:01.0: vgaarb: bridge control possible372machine # [ 0.512261] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none373machine # [ 0.512270] vgaarb: loaded374machine # [ 0.512995] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0375machine # [ 0.513267] hpet0: 3 comparators, 64-bit 100.000000 MHz counter376machine # [ 0.516354] clocksource: Switched to clocksource kvm-clock377machine # [ 0.519863] VFS: Disk quotas dquot_6.6.0378machine # [ 0.520616] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)379machine # [ 0.521908] pnp: PnP ACPI init380machine # [ 0.522686] ACPI: IRQ 4 override to edge(!), high(!)381machine # [ 0.523705] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved382machine # [ 0.525278] pnp: PnP ACPI: found 5 devices383machine # [ 0.533450] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns384machine # [ 0.535152] clocksource: Switched to clocksource acpi_pm385machine # [ 0.536105] NET: Registered PF_INET protocol family386machine # [ 0.537098] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)387machine # [ 0.555074] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)388machine # [ 0.556550] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)389machine # [ 0.557807] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)390machine # [ 0.559057] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)391machine # [ 0.560222] TCP: Hash tables configured (established 8192 bind 8192)392machine # [ 0.561259] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)393machine # [ 0.562510] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)394machine # [ 0.563607] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)395machine # [ 0.564742] NET: Registered PF_UNIX/PF_LOCAL protocol family396machine # [ 0.565657] NET: Registered PF_XDP protocol family397machine # [ 0.566448] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]398machine # [ 0.567403] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]399machine # [ 0.568376] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]400machine # [ 0.569442] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]401machine # [ 0.570499] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]402machine # [ 0.571596] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]403machine # [ 0.573300] ACPI: \_SB_.GSIA: Enabled at IRQ 16404machine # [ 0.575884] ACPI: \_SB_.GSIB: Enabled at IRQ 17405machine # [ 0.577814] ACPI: \_SB_.GSIC: Enabled at IRQ 18406machine # [ 0.579733] ACPI: \_SB_.GSID: Enabled at IRQ 19407machine # [ 0.581354] PCI: CLS 0 bytes, default 64408machine # [ 0.582220] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns409machine # [ 0.583894] Trying to unpack rootfs image as initramfs...410machine # [ 0.629957] Initialise system trusted keyrings411machine # [ 0.630910] workingset: timestamp_bits=40 max_order=18 bucket_order=0412machine # [ 0.652225] Key type asymmetric registered413machine # [ 0.655553] Asymmetric key parser 'x509' registered414machine # [ 0.656394] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)415machine # [ 0.659660] io scheduler mq-deadline registered416machine # [ 0.660414] io scheduler kyber registered417machine # [ 0.664066] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled418machine # [ 0.665446] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A419machine # [ 0.669291] Linux agpgart interface v0.103420machine # [ 0.670068] ACPI: bus type drm_connector registered421machine # [ 0.673036] usbcore: registered new interface driver usbserial_generic422machine # [ 0.674102] usbserial: USB Serial support registered for generic423machine # [ 0.676554] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.424machine # [ 0.676554] Please enable it if your BIOS has the CPPC option.425machine # [ 0.678717] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled426machine # [ 0.683656] drop_monitor: Initializing network drop monitor service427machine # [ 0.684827] NET: Registered PF_INET6 protocol family428machine # [ 0.688036] Segment Routing with IPv6429machine # [ 0.688729] In-situ OAM (IOAM) with IPv6430machine # [ 0.691826] IPI shorthand broadcast: enabled431machine # [ 0.700064] sched_clock: Marking stable (556014169, 143518903)->(772858132, -73325060)432machine # [ 0.702612] registered taskstats version 1433machine # [ 0.703501] Loading compiled-in X.509 certificates434machine # [ 0.722777] Demotion targets for Node 0: null435machine # [ 0.725586] Key type .fscrypt registered436machine # [ 0.726233] Key type fscrypt-provisioning registered437machine # [ 0.727140] ima: No TPM chip found, activating TPM-bypass!438machine # [ 0.731543] ima: Allocated hash algorithm: sha1439machine # [ 0.732291] ima: No architecture policies found440machine # [ 0.733224] PM: Magic number: 14:924:864441machine # [ 0.736827] RAS: Correctable Errors collector initialized.442machine # [ 0.745639] clk: Disabling unused clocks443machine # [ 0.746289] PM: genpd: Disabling unused power domains444machine # [ 0.748011] Freeing initrd memory: 11352K445machine # [ 0.751096] Freeing unused decrypted memory: 2028K446machine # [ 0.753780] Freeing unused kernel image (initmem) memory: 3660K447machine # [ 0.754822] Write protecting the kernel read-only data: 32768k448machine # [ 0.756091] Freeing unused kernel image (text/rodata gap) memory: 296K449machine # [ 0.757550] Freeing unused kernel image (rodata/data gap) memory: 684K450machine # [ 0.808132] x86/mm: Checked W+X mappings: passed, no W+X pages found.451machine # [ 0.809205] Run /init as init process452machine # [ 0.850862] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.453machine # [ 0.853057] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev454machine # [ 0.971402] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12455machine # [ 0.978389] serio: i8042 KBD port at 0x60,0x64 irq 1456machine # [ 0.979207] serio: i8042 AUX port at 0x60,0x64 irq 12457machine # [ 0.982562] ACPI: \_SB_.GSIG: Enabled at IRQ 22458machine # [ 0.987905] ACPI: \_SB_.GSIH: Enabled at IRQ 23459machine # [ 0.992302] ACPI: \_SB_.GSIE: Enabled at IRQ 20460machine # [ 0.994794] ACPI: \_SB_.GSIF: Enabled at IRQ 21461machine # [ 1.064197] ehci-pci 0000:00:1d.7: EHCI Host Controller462machine # [ 1.065128] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1463machine # [ 1.067109] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000464machine # [ 1.073604] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00465machine # [ 1.077624] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18466machine # [ 1.078998] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1467machine # [ 1.081729] usb usb1: Product: EHCI Host Controller468machine # [ 1.082587] usb usb1: Manufacturer: Linux 6.18.56 ehci_hcd469machine # [ 1.083466] usb usb1: SerialNumber: 0000:00:1d.7470machine # [ 1.088735] hub 1-0:1.0: USB hub found471machine # [ 1.089415] hub 1-0:1.0: 6 ports detected472machine # [ 1.092806] virtio_blk virtio2: 1/0/0 default/read/poll queues473machine # [ 1.095057] uhci_hcd 0000:00:1d.0: UHCI Host Controller474machine # [ 1.096001] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2475machine # [ 1.104670] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)476machine # [ 1.109574] uhci_hcd 0000:00:1d.0: detected 2 ports477machine # [ 1.128349] SCSI subsystem initialized478machine # [ 1.135606] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0479machine # [ 1.151414] fuse: init (API version 7.45)480machine # [ 1.173627] virtiofs virtio5: discovered new tag: nix-store481machine # [ 1.176978] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180482machine # [ 1.180232] virtiofs virtio5: virtio_fs_setup_dax: No cache capability483machine # [ 1.181366] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18484machine # [ 1.186132] virtiofs virtio6: discovered new tag: shared485machine # [ 1.187252] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1486machine # [ 1.188502] usb usb2: Product: UHCI Host Controller487machine # [ 1.192537] usb usb2: Manufacturer: Linux 6.18.56 uhci_hcd488machine # [ 1.193455] usb usb2: SerialNumber: 0000:00:1d.0489machine # [ 1.194967] virtiofs virtio6: virtio_fs_setup_dax: No cache capability490machine # [ 1.198235] virtiofs virtio7: discovered new tag: xchg491machine # [ 1.200937] hub 2-0:1.0: USB hub found492machine # [ 1.203559] hub 2-0:1.0: 2 ports detected493machine # [ 1.208557] virtiofs virtio7: virtio_fs_setup_dax: No cache capability494machine # [ 1.211366] uhci_hcd 0000:00:1d.1: UHCI Host Controller495machine # [ 1.212358] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3496machine # [ 1.220036] uhci_hcd 0000:00:1d.1: detected 2 ports497machine # [ 1.221084] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0498machine # [ 1.223708] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18499machine # [ 1.225146] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1500machine # [ 1.230555] usb usb3: Product: UHCI Host Controller501machine # [ 1.231449] usb usb3: Manufacturer: Linux 6.18.56 uhci_hcd502machine # [ 1.232397] usb usb3: SerialNumber: 0000:00:1d.1503machine # [ 1.234667] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode504machine # [ 1.236663] hub 3-0:1.0: USB hub found505machine # [ 1.237415] hub 3-0:1.0: 2 ports detected506machine # [ 1.238261] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)507machine # [ 1.239311] ahci 0000:00:1f.2: flags: 64bit ncq only508machine # [ 1.241827] uhci_hcd 0000:00:1d.2: UHCI Host Controller509machine # [ 1.245126] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4510machine # [ 1.246372] uhci_hcd 0000:00:1d.2: detected 2 ports511machine # [ 1.247280] scsi host0: ahci512machine # [ 1.248611] scsi host1: ahci513machine # [ 1.249670] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0514machine # [ 1.250770] scsi host2: ahci515machine # [ 1.251918] scsi host3: ahci516machine # [ 1.252750] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18517machine # [ 1.254154] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1518machine # [ 1.255745] scsi host4: ahci519machine # [ 1.256809] scsi host5: ahci520machine # [ 1.257502] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 47 lpm-pol 1521machine # [ 1.259139] usb usb4: Product: UHCI Host Controller522machine # [ 1.259987] usb usb4: Manufacturer: Linux 6.18.56 uhci_hcd523machine # [ 1.260917] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 47 lpm-pol 1524machine # [ 1.262405] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 47 lpm-pol 1525machine # [ 1.264181] usb usb4: SerialNumber: 0000:00:1d.2526machine # [ 1.265360] hub 4-0:1.0: USB hub found527machine # [ 1.266127] hub 4-0:1.0: 2 ports detected528machine # [ 1.270842] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 47 lpm-pol 1529machine # [ 1.272257] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 47 lpm-pol 1530machine # [ 1.274918] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 47 lpm-pol 1531machine # [ 1.340746] usb 1-1: new high-speed USB device number 2 using ehci-pci532machine # [ 1.474044] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00533machine # [ 1.477808] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10534machine # [ 1.480942] usb 1-1: Product: QEMU USB Tablet535machine # [ 1.482908] usb 1-1: Manufacturer: QEMU536machine # [ 1.484945] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1537machine # [ 1.513695] hid: raw HID events driver (C) Jiri Kosina538machine # [ 1.588241] ata2: SATA link down (SStatus 0 SControl 300)539machine # [ 1.591060] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)540machine # [ 1.593844] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100541machine # [ 1.596291] ata3.00: applying bridge limits542machine # [ 1.598493] ata5: SATA link down (SStatus 0 SControl 300)543machine # [ 1.601163] ata4: SATA link down (SStatus 0 SControl 300)544machine # [ 1.603844] ata1: SATA link down (SStatus 0 SControl 300)545machine # [ 1.606423] ata6: SATA link down (SStatus 0 SControl 300)546machine # [ 1.609093] ata3.00: configured for UDMA/100547machine # [ 1.611875] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5548machine # [ 1.649142] usbcore: registered new interface driver usbhid549machine # [ 1.650482] usbhid: USB HID core driver550machine # [ 1.652882] 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/input2551machine # [ 1.655000] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray552machine # [ 1.656254] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0553machine # [ 1.664656] cdrom: Uniform CD-ROM driver Revision: 3.20554machine # [ 1.852617] EXT4-fs (vda): mounted filesystem 09723eba-3352-43b8-953b-caa084c7178d r/w with ordered data mode. Quota mode: none.555machine # [ 2.050551] EXT4-fs (vda): re-mounted 09723eba-3352-43b8-953b-caa084c7178d.556machine # [ 2.052361] booting system configuration /nix/store/rgs7204zwh1ifs1wn4kmjza7f0ysfdpk-nixos-system-machine-test557machine # [ 2.407780] systemd[1]: Inserted module 'autofs4'558machine # [ 2.414611] NET: Registered PF_VSOCK protocol family559machine # [ 2.439578] systemd[1]: systemd 263-409be20 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -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 +EXPERIMENTAL-ENVVAR)560machine # [ 2.444554] systemd[1]: Detected virtualization kvm.561machine # [ 2.445366] systemd[1]: Detected architecture x86-64.562machine # [ 2.446239] systemd[1]: Detected first boot.563machine # [ 2.448239] systemd[1]: Initializing machine ID from random generator.564machine # [ 2.453330] systemd[1]: Hostname set to <machine>.565machine # [ 2.536007] systemd[1]: bpf-restrict-fs: LSM BPF program attached566machine # [ 2.633186] systemd[1]: Applying preset policy.567machine # [ 2.797326] systemd[1]: Populated /etc with preset unit settings.568machine # [ 2.929033] systemd[1]: Queued start job for default target Multi-User System.569machine # [ 2.934326] systemd[1]: Created slice Slice /system/getty.570machine # [ 2.935768] systemd[1]: Created slice Slice /system/modprobe.571machine # [ 2.937100] systemd[1]: Created slice User and Session Slice.572machine # [ 2.938033] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.573machine # [ 2.939204] systemd[1]: Started Forward Password Requests to Wall Directory Watch.574machine # [ 2.940261] systemd[1]: Expecting device /dev/hvc0...575machine # [ 2.940972] systemd[1]: Expecting device /dev/ttyS0...576machine # [ 2.941738] systemd[1]: Reached target Local Encrypted Volumes.577machine # [ 2.942593] systemd[1]: Reached target Virtual Machines and Containers.578machine # [ 2.943487] systemd[1]: Reached target Path Units.579machine # [ 2.944165] systemd[1]: Reached target Remote File Systems.580machine # [ 2.944917] systemd[1]: Reached target Slice Units.581machine # [ 2.945646] systemd[1]: Reached target Swaps.582machine # [ 2.947233] systemd[1]: Listening on Query the User Interactively for a Password.583machine # [ 2.949381] systemd[1]: Listening on Process Core Dump Socket.584machine # [ 2.951004] systemd[1]: Listening on Credential Encryption/Decryption.585machine # [ 2.952721] systemd[1]: Listening on Factory Reset Management.586machine # [ 2.953649] systemd[1]: Listening on Hostname Service Socket.587machine # [ 2.956284] systemd[1]: Starting Journal Log Access Socket...588machine # [ 2.960641] systemd[1]: Listening on Journal Audit Socket.589machine # [ 2.961602] systemd[1]: Listening on Journal Socket (/dev/log).590machine # [ 2.962593] systemd[1]: Listening on Journal Sockets.591machine # [ 2.964091] systemd[1]: Listening on Console Output Muting Service Socket.592machine # [ 2.965209] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.593machine # [ 2.966376] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os594machine # [ 2.967704] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki595machine # [ 2.971554] systemd[1]: Listening on Disk Repartitioning Service Socket.596machine # [ 2.972606] systemd[1]: Listening on udev Kernel Socket.597machine # [ 2.973439] systemd[1]: Listening on udev Varlink Socket.598machine # [ 2.975908] systemd[1]: Mounting Huge Pages File System...599machine # [ 2.978209] systemd[1]: Mounting POSIX Message Queue File System...600machine # [ 2.985021] systemd[1]: Mounting Kernel Debug File System...601machine # [ 2.992310] systemd[1]: Mounting Kernel Trace File System...602machine # [ 2.999752] systemd[1]: Starting Create List of Static Device Nodes...603machine # [ 3.015156] systemd[1]: Starting Load Kernel Module configfs...604machine # [ 3.022413] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm605machine # [ 3.054611] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore606machine # [ 3.059789] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse607machine # [ 3.067418] systemd[1]: Mounting FUSE Control File System...608machine # [ 3.068472] systemd[1]: File System Check on Root Device skipped, unmet condition check ConditionPathIsReadWrite=!/609machine # [ 3.070249] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67610machine # [ 3.080952] systemd[1]: Starting Journal Service...611machine # [ 3.088416] systemd[1]: Starting Load Kernel Modules...612machine # [ 3.099842] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...613machine # [ 3.115792] systemd[1]: Starting Remount Root and Kernel File Systems...614machine # [ 3.120982] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os615machine # [ 3.129214] systemd[1]: Starting Coldplug All udev Devices...616machine # [ 3.140216] systemd-journald[409]: Collecting audit messages is enabled.617machine # [ 3.151401] systemd[1]: Listening on Journal Log Access Socket.618machine # [ 3.155767] systemd[1]: Mounted Huge Pages File System.619machine # [ 3.160881] systemd[1]: Mounted POSIX Message Queue File System.620machine # [ 3.166848] systemd[1]: Mounted Kernel Debug File System.621machine # [ 3.172814] systemd[1]: Mounted Kernel Trace File System.622machine # [ 3.180233] systemd[1]: Finished Create List of Static Device Nodes.623machine # [ 3.191783] systemd[1]: modprobe@configfs.service: Deactivated successfully.624machine # [ 3.193087] loop: module loaded625machine # [ 3.200584] systemd[1]: Finished Load Kernel Module configfs.626machine # [ 3.213569] systemd[1]: Mounting Kernel Configuration File System...627machine # [ 3.224569] EXT4-fs (vda): re-mounted 09723eba-3352-43b8-953b-caa084c7178d.628machine # [ 3.225699] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...629machine # [ 3.234461] systemd[1]: Mounted FUSE Control File System.630machine # [ 3.242594] systemd[1]: Finished Load Kernel Modules.631machine # [ 3.265916] systemd[1]: Starting Firewall...632machine # [ 3.281718] systemd[1]: Starting Apply Kernel Variables...633machine # [ 3.296691] systemd[1]: Finished Remount Root and Kernel File Systems.634machine # [ 3.307418] systemd[1]: Listening on Disk Image Download Service Socket.635machine # [ 3.319660] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore636machine # [ 3.347667] systemd[1]: Starting Load/Save OS Random Seed...637machine # [ 3.348493] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os638machine # [ 3.209793] systemd-modules-load[410]: Inserted module 'loop'639machine # [ 3.212427] systemd-oomd[412]: No swap; memory pressure usage will be degraded640machine # [ 3.358174] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.641machine # [ 3.363700] systemd[1]: Started Journal Service.642machine # [ 3.267113] systemd[1]: Starting Flush Journal to Persistent Storage...643machine # [ 3.290254] systemd[1]: Finished Load/Save OS Random Seed.644machine # [ 3.291933] systemd[1]: Reached target First Boot Complete.645machine # [ 3.318183] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.646machine # [ 3.322116] systemd[1]: Mounted Kernel Configuration File System.647machine # [ 3.326143] systemd[1]: Starting Create Static Device Nodes in /dev...648machine # [ 3.329375] systemd[1]: Finished Apply Kernel Variables.649machine # [ 3.480625] systemd-journald[409]: Received client request to flush runtime journal.650machine # [ 3.429107] systemd[1]: Finished Flush Journal to Persistent Storage.651machine # [ 3.484343] systemd[1]: Finished Coldplug All udev Devices.652machine # [ 3.487867] systemd[1]: Finished Create Static Device Nodes in /dev.653machine # [ 3.490148] systemd[1]: Reached target Preparation for Local File Systems.654machine # [ 3.492456] systemd[1]: Starting Rule-based Manager for Device Events and Files...655machine # [ 3.536797] systemd-udevd[449]: Using default interface naming scheme 'v261'.656machine # [ 3.578816] systemd[1]: Started Rule-based Manager for Device Events and Files.657machine # [ 3.702706] systemd[1]: Found device /dev/hvc0.658machine # [ 3.726486] systemd[1]: Found device /dev/ttyS0.659machine # [ 3.755307] (udev-worker)[476]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.660machine # [ 3.758169] (udev-worker)[476]: Network interface NamePolicy= disabled on kernel command line.661machine # [ 3.867552] systemd[1]: Condition check resulted in Virtio network device being skipped.662machine # [ 3.868793] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore663machine # [ 3.870591] systemd[1]: File System Check on Root Device skipped, unmet condition check ConditionPathIsReadWrite=!/664machine # [ 3.872650] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67665machine # [ 3.875750] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore666machine # [ 3.878144] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os667machine # [ 3.879408] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os668machine # [ 4.098182] mousedev: PS/2 mouse device common for all mice669machine # [ 4.129685] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3670machine # [ 4.135631] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console671machine # [ 4.006741] systemd[1]: Mounting /run/wrappers...672machine # [ 4.046879] systemd[1]: Mounted /run/wrappers.673machine # [ 4.048258] systemd[1]: Reached target Local File Systems.674machine # [ 4.051250] systemd[1]: Listening on Boot Loader Control Service Socket.675machine # [ 4.055354] systemd[1]: Starting Create SUID/SGID Wrappers...676machine # [ 4.057419] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.677machine # [ 4.063097] systemd[1]: Starting Save Transient machine-id to Disk...678machine # [ 4.070405] systemd[1]: Starting Create System Files and Directories...679machine # [ 4.181175] systemd[1]: Finished Create System Files and Directories.680machine # [ 4.189140] systemd[1]: Starting Rebuild Journal Catalog...681machine # [ 4.195396] systemd[1]: Starting Record System Boot/Shutdown in UTMP...682machine # [ 4.157371] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4683machine # [ 4.161225] ACPI: button: Power Button [PWRF]684machine # [ 4.299453] rtc_cmos PNP0B00:00: RTC can wake from S4685machine # [ 4.346324] rtc_cmos PNP0B00:00: registered as rtc0686machine # [ 4.346397] rtc_cmos PNP0B00:00: setting system clock to 2026-10-18T02:51:22 UTC (1792291882)687machine # [ 4.346484] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs688machine # [ 4.346972] systemd-journald[409]: Time jumped backwards, rotating.689machine # [ 4.374253] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized690machine # [ 4.415169] Console: switching to colour dummy device 80x25691machine # [ 4.434047] parport_pc 00:02: reported by Plug and Play ACPI692machine # [ 4.362583] systemd[1]: Finished Record System Boot/Shutdown in UTMP.693machine # [ 4.366301] systemd[1]: Finished Rebuild Journal Catalog.694machine # [ 4.371652] systemd[1]: Starting Update is Completed...695machine # [ 4.378448] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.696machine # [ 4.382706] systemd[1]: Finished Save Transient machine-id to Disk.697machine # [ 4.385408] systemd[1]: Finished Update is Completed.698machine # [ 4.434137] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]699machine # [ 4.558618] [drm] Found bochs VGA, ID 0xb0c5.700machine # [ 4.559018] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.701machine # [ 4.431515] systemd[1]: Finished Firewall.702machine # [ 4.586631] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic703machine # [ 4.587283] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0704machine # [ 4.593594] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt705machine # [ 4.594245] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD706machine # [ 4.656004] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6707machine # [ 4.657566] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5708machine # [ 4.529414] systemd[1]: Starting Virtual Console Setup...709machine # [ 4.736313] Console: switching to colour frame buffer device 160x50710machine # [ 4.741718] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device711machine # [ 4.602922] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.712machine # [ 4.604071] systemd[1]: Stopped Virtual Console Setup.713machine # [ 4.611604] systemd[1]: Starting Virtual Console Setup...714machine # [ 4.612497] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.715machine # [ 4.614048] systemd[1]: Finished Create SUID/SGID Wrappers.716machine # [ 4.814871] ppdev: user-space parallel port driver717machine # [ 4.825410] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)718machine # [ 4.835472] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)719machine # [ 4.699550] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.720machine # [ 4.704297] systemd[1]: Stopped Virtual Console Setup.721machine # [ 4.706595] systemd[1]: Starting Virtual Console Setup...722machine # [ 4.942227] kvm_amd: TSC scaling supported723machine # [ 4.942821] kvm_amd: Nested Virtualization enabled724machine # [ 4.943254] kvm_amd: Nested Paging enabled725machine # [ 4.944087] kvm_amd: LBR virtualization supported726machine # [ 4.944734] kvm_amd: Virtual VMLOAD VMSAVE supported727machine # [ 4.945186] kvm_amd: Virtual GIF supported728machine # [ 4.945880] kvm_amd: Virtual NMI enabled729machine # [ 4.973243] EDAC MC: Ver: 3.0.0730machine # [ 4.906779] systemd-vconsole-setup[638]: Configuration of first virtual console was skipped, ignoring remaining ones.731machine # [ 4.910319] systemd[1]: Finished Virtual Console Setup.732machine # [ 4.911367] systemd[1]: Reached target System Initialization.733machine # [ 4.912682] systemd[1]: Started Discard unused filesystem blocks once a week.734machine # [ 4.914149] systemd[1]: Started Daily Cleanup of Temporary Directories.735machine # [ 4.915186] systemd[1]: Reached target Timer Units.736machine # [ 4.916556] systemd[1]: Listening on D-Bus System Message Bus Socket.737machine # [ 4.917522] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.738machine # [ 4.918868] systemd[1]: Reached target Socket Units.739machine # [ 4.919619] systemd[1]: Reached target Basic System.740machine # [ 4.921930] systemd[1]: Started backdoor.service.741machine # [ 4.925582] systemd[1]: Starting Import lastlog data into lastlog2 database...742machine # [ 4.932154] systemd[1]: Starting Name Service Cache Daemon (nsncd)...743machine # [ 4.938558] systemd[1]: Starting Post-Boot Actions...744machine # [ 4.955958] systemd[1]: Started Reset console on configuration changes.745machine # [ 4.963517] systemd[1]: Starting resolvconf update...746machine # [ 4.996558] systemd[1]: Starting D-Bus System Message Bus...747machine # connecting to host...748machine # [ 5.017258] nsncd[644]: Oct 18 02:51:23.313 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"749machine # [ 5.020495] systemd[1]: Finished Post-Boot Actions.750machine # [ 5.023552] systemd[1]: Started Name Service Cache Daemon (nsncd).751machine # [ 5.029307] systemd[1]: Reached target Host and Network Name Lookups.752machine # [ 5.031199] systemd[1]: Reached target User and Group Name Lookups.753machine # [ 5.052585] systemd[1]: Starting User Login Management...754machine: Guest shell says: b'Spawning backdoor root shell...\n'755machine: connected to guest root shell756machine: (connecting took 5.75 seconds)757machine: (finished: waiting for the VM to finish booting, in 6.18 seconds)758machine # [ 5.114365] systemd[1]: Finished Import lastlog data into lastlog2 database.759machine # [ 5.166282] dbus-broker-launch[651]: Looking up NSS user entry for 'systemd-timesync'...760machine # [ 5.178274] systemd-logind[667]: New seat seat0.761machine # [ 5.185576] systemd-logind[667]: Watching system buttons on /dev/input/event2 (Power Button)762machine # [ 5.186765] systemd-logind[667]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)763machine # [ 5.188854] systemd-logind[667]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)764machine # [ 5.206071] systemd[1]: Started User Login Management.765machine # [ 5.210732] dbus-broker-launch[651]: NSS returned no entry for 'systemd-timesync'766machine # [ 5.211904] dbus-broker-launch[651]: Invalid user-name in /nix/store/281fr0qkic9y08y9x5m2vpj7j5s81sna-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"767machine # [ 5.216712] systemd[1]: Stopped target Host and Network Name Lookups.768machine # [ 5.218061] systemd[1]: Stopping Host and Network Name Lookups...769machine # [ 5.218959] systemd[1]: Stopped target User and Group Name Lookups.770machine # [ 5.221106] systemd[1]: Stopping User and Group Name Lookups...771machine # [ 5.224204] systemd[1]: Starting linger-users.service...772machine # [ 5.226675] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...773machine # [ 5.231340] systemd[1]: nscd.service: Deactivated successfully.774machine # [ 5.237125] systemd[1]: Stopped Name Service Cache Daemon (nsncd).775machine # [ 5.245138] systemd[1]: Started D-Bus System Message Bus.776machine # [ 5.263605] systemd[1]: Starting Name Service Cache Daemon (nsncd)...777machine # [ 5.274895] dbus-broker-launch[651]: Ready778machine # [ 5.300861] systemd[1]: linger-users.service: Deactivated successfully.779machine # [ 5.304221] systemd[1]: Finished linger-users.service.780machine # [ 5.314229] systemd[1]: Started Name Service Cache Daemon (nsncd).781machine # [ 5.315977] systemd[1]: Reached target Host and Network Name Lookups.782machine # [ 5.317182] systemd[1]: Reached target User and Group Name Lookups.783machine # [ 5.318647] nsncd[730]: Oct 18 02:51:23.611 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"784machine # [ 5.325126] systemd[1]: Finished resolvconf update.785machine # [ 5.326570] systemd[1]: Reached target Preparation for Network.786machine # [ 5.330165] systemd[1]: Starting DHCP Client...787machine # [ 5.332786] systemd[1]: Starting Address configuration of eth1...788machine # [ 5.337463] systemd[1]: Starting Extra networking commands....789machine # [ 5.415342] network-addresses-eth1-start[753]: adding address 192.168.1.1/24... done790machine # [ 5.428482] network-addresses-eth1-start[753]: adding address 2001:db8:1::1/64... done791machine # [ 5.453102] systemd[1]: Finished Address configuration of eth1.792machine # [ 5.486853] dhcpcd[762]: dhcpcd-10.3.2 starting793machine # [ 5.492680] dhcpcd[814]: dev: loaded udev794machine # [ 5.504441] systemd[1]: Finished Extra networking commands..795machine # [ 5.505288] systemd[1]: Reached target Network.796machine # [ 5.651703] 8021q: 802.1Q VLAN Support v1.8797machine # [ 5.652109] 8021q: adding VLAN 0 to HW filter on device eth1798machine # [ 5.510202] systemd[1]: Starting Permit User Sessions...799machine # [ 5.538144] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.800machine # [ 5.587087] systemd[1]: Finished Permit User Sessions.801machine # [ 5.603312] systemd[1]: Started Getty on tty1.802machine # [ 5.604076] systemd[1]: Reached target Login Prompts.803machine # [ 5.750063] cfg80211: Loading compiled-in X.509 certificates for regulatory database804machine # [ 5.763065] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'805machine # [ 5.763811] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'806machine # [ 5.765632] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2807machine # [ 5.766490] cfg80211: failed to load regulatory.db808machine # [ 5.791351] 8021q: adding VLAN 0 to HW filter on device eth0809machine # [ 5.649055] dhcpcd[814]: eth0: waiting for carrier810machine # [ 5.650054] dhcpcd[814]: eth0: carrier acquired811machine # [ 5.654756] dhcpcd[814]: DUID 00:01:00:01:32:66:f0:ab:52:54:00:12:34:56812machine # [ 5.655843] dhcpcd[814]: eth0: IAID 00:12:34:56813machine # [ 5.656538] dhcpcd[814]: eth0: adding address fe80::5054:ff:fe12:3456814machine # [ 6.967223] dhcpcd[814]: eth0: soliciting a DHCP lease815machine # [ 7.128689] NET: Registered PF_PACKET protocol family816machine # [ 6.990954] dhcpcd[814]: eth0: offered 10.0.2.15 from 10.0.2.2817machine # [ 6.994379] dhcpcd[814]: eth0: probing address 10.0.2.15/24818machine # [ 7.652614] dhcpcd[814]: eth0: soliciting an IPv6 router819machine # [ 7.655233] dhcpcd[814]: eth0: Router Advertisement from fe80::2820machine # [ 7.657811] dhcpcd[814]: eth0: adding address fec0::5054:ff:fe12:3456/64821machine # [ 7.660168] dhcpcd[814]: eth0: adding route to fec0::/64822machine # [ 7.662182] dhcpcd[814]: eth0: adding default route via fe80::2823machine # [ 11.830516] dhcpcd[814]: eth0: leased 10.0.2.15 for 86400 seconds824machine # [ 11.833419] dhcpcd[814]: eth0: adding route to 10.0.2.0/24825machine # [ 11.836248] dhcpcd[814]: eth0: adding default route via 10.0.2.2826machine # [ 11.918825] systemd[1]: Started DHCP Client.827machine # [ 11.920818] systemd[1]: Reached target Multi-User System.828machine # [ 11.921884] systemd[1]: Startup finished in 2.244s (kernel) + 9.677s (userspace) = 11.921s.829machine: (finished: waiting for unit multi-user.target, in 13.77 seconds)830machine # [ 12.700393] systemd-logind[667]: poweroff requested from client PID 959 ('systemctl') (unit backdoor.service)...831machine # [ 12.703603] systemd-logind[667]: System is powering down.832machine # [ 12.711463] systemd-logind[667]: The system will power off now!833machine: waiting for Unmounting '/oldroot' to appear on console834machine # [ 12.721268] systemd[1]: Removed slice Slice /system/modprobe.835machine # [ 12.722475] systemd[1]: Stopped target Multi-User System.836machine # [ 12.724067] systemd[1]: Stopped target Login Prompts.837machine # [ 12.724722] systemd[1]: Stopped target Virtual Machines and Containers.838machine # [ 12.726343] systemd[1]: Stopped target Host and Network Name Lookups.839machine # [ 12.727251] systemd[1]: Stopped target Timer Units.840machine # [ 12.727875] systemd[1]: fstrim.timer: Deactivated successfully.841machine # [ 12.729137] systemd[1]: Stopped Discard unused filesystem blocks once a week.842machine # [ 12.730688] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.843machine # [ 12.731637] systemd[1]: Stopped Daily Cleanup of Temporary Directories.844machine # [ 12.732497] systemd[1]: systemd-rfkill.socket: Deactivated successfully.845machine # [ 12.733353] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.846machine # [ 12.735043] systemd[1]: Mounting /run/initramfs...847machine # [ 12.736467] systemd[1]: Stopping backdoor.service...848machine # [ 12.737805] dhcpcd[814]: received SIGTERM, stopping849machine # [ 12.739204] dhcpcd[814]: eth0: removing interface850machine # [ 12.739824] systemd[1]: Stopping DHCP Client...851machine # [ 12.741629] dhcpcd[814]: eth0: deleting address fec0::5054:ff:fe12:3456/64852machine # [ 12.743141] systemd[1]: Stopping Getty on tty1...853machine # [ 12.744517] dhcpcd[814]: eth0: deleting route to fec0::/64854machine # [ 12.746070] systemd[1]: lastlog2-import.service: Deactivated successfully.855machine # [ 12.747137] dhcpcd[814]: eth0: deleting default route via fe80::2856machine # [ 12.748923] systemd[1]: Stopped Import lastlog data into lastlog2 database.857machine # [ 12.750723] dhcpcd[814]: script_status: /nix/store/5bw65sv1gjzvvsrvj9l01ls66r2ibg5y-dhcpcd-10.3.2/libexec/dhcpcd-run-hooks: Terminated858machine # [ 12.752478] dhcpcd[814]: eth0: deleting address fe80::5054:ff:fe12:3456859machine # [ 12.753405] dhcpcd[814]: eth0: deleting route to 10.0.2.0/24860machine # [ 12.755397] dhcpcd[814]: eth0: deleting default route via 10.0.2.2861machine # [ 12.758098] systemd[1]: Stopping Address configuration of eth1...862machine # [ 12.763435] systemd[1]: Stopping Post-Boot Actions...863machine # [ 12.764532] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.864machine # [ 12.767220] systemd[1]: Stopped Reset console on configuration changes.865machine # [ 12.768161] systemd[1]: Stopping User Login Management...866machine # [ 12.768851] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.867machine # [ 12.769839] systemd[1]: Stopped Save Transient machine-id to Disk.868machine # [ 12.770638] systemd[1]: Stopped target First Boot Complete.869machine # [ 12.776648] dhcpcd[814]: dhcpcd exited870machine # [ 12.778785] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...871machine # [ 12.787233] systemd[1]: Stopping Load/Save OS Random Seed...872machine # [ 12.795470] systemd[1]: systemd-oomd.service: Deactivated successfully.873machine # [ 12.801466] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.874machine # [ 12.802955] systemd[1]: backdoor.service: Deactivated successfully.875machine # [ 12.810202] systemd[1]: Stopped backdoor.service.876machine # [ 12.812689] systemd[1]: systemd-logind.service: Deactivated successfully.877machine # [ 12.816314] systemd[1]: Stopped User Login Management.878machine # [ 12.828333] systemd[1]: dhcpcd.service: Deactivated successfully.879machine # [ 12.829481] systemd[1]: Stopped DHCP Client.880machine # [ 12.831211] network-addresses-eth1-pre-stop[964]: deleting address 192.168.1.1/24... done881machine # [ 12.834442] systemd[1]: dhcpcd.service: Consumed 159ms CPU time over 7.497s wall clock time, 5.7M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.882machine # [ 12.844214] systemd[1]: getty@tty1.service: Deactivated successfully.883machine # [ 12.845548] systemd[1]: Stopped Getty on tty1.884machine # [ 12.847367] network-addresses-eth1-pre-stop[964]: deleting address 2001:db8:1::1/64... done885machine # [ 12.853118] systemd[1]: Mounted /run/initramfs.886machine # [ 12.855068] systemd[1]: post-boot.service: Deactivated successfully.887machine # [ 12.856937] systemd[1]: Stopped Post-Boot Actions.888machine # [ 12.858964] systemd[1]: network-addresses-eth1.service: Deactivated successfully.889machine # [ 12.860308] systemd[1]: Stopped Address configuration of eth1.890machine # [ 12.862243] systemd[1]: systemd-random-seed.service: Deactivated successfully.891machine # [ 12.863796] systemd[1]: Stopped Load/Save OS Random Seed.892machine # [ 12.869768] systemd[1]: Removed slice Slice /system/getty.893machine # [ 12.872552] systemd[1]: Starting Generate shutdown ramfs...894machine # [ 12.875276] systemd[1]: Stopping Permit User Sessions...895machine # [ 12.898934] systemd[1]: systemd-user-sessions.service: Deactivated successfully.896machine # [ 12.900690] systemd[1]: Stopped Permit User Sessions.897machine # [ 12.902710] systemd[1]: Stopped target Network.898machine # [ 12.903964] systemd[1]: Stopped target User and Group Name Lookups.899machine # [ 12.905340] systemd[1]: Stopped target Remote File Systems.900machine # [ 12.907413] systemd[1]: network-local-commands.service: Deactivated successfully.901machine # [ 12.908544] systemd[1]: Stopped Extra networking commands..902machine # [ 12.909791] systemd[1]: Stopped target Preparation for Network.903machine # [ 12.913532] systemd[1]: Stopping Firewall...904machine # [ 12.916280] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...905machine # [ 12.917367] systemd[1]: resolvconf.service: Deactivated successfully.906machine # [ 12.919527] systemd[1]: Stopped resolvconf update.907machine # [ 12.922804] systemd[1]: nscd.service: Deactivated successfully.908machine # [ 12.923772] systemd[1]: Stopped Name Service Cache Daemon (nsncd).909machine # [ 12.934806] systemd[1]: Stopped target Basic System.910machine # [ 12.935655] systemd[1]: Stopped target Path Units.911machine # [ 12.936521] systemd[1]: Stopped target Slice Units.912machine # [ 12.937508] systemd[1]: Removed slice User and Session Slice.913machine # [ 12.939782] systemd[1]: Stopped target Socket Units.914machine # [ 12.940723] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.915machine # [ 12.943805] systemd[1]: Closed Hostname Service Socket.916machine # [ 12.944698] systemd[1]: systemd-importd.socket: Deactivated successfully.917machine # [ 12.945867] systemd[1]: Closed Disk Image Download Service Socket.918machine # [ 12.950168] systemd[1]: systemd-machined.socket: Deactivated successfully.919machine # [ 12.951270] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.920machine # [ 12.952469] systemd[1]: systemd-mute-console.socket: Deactivated successfully.921machine # [ 12.953553] systemd[1]: Closed Console Output Muting Service Socket.922machine # [ 12.955417] systemd[1]: systemd-oomd.socket: Deactivated successfully.923machine # [ 12.957185] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.924machine # [ 12.958422] systemd[1]: systemd-repart.socket: Deactivated successfully.925machine # [ 12.960121] systemd[1]: Closed Disk Repartitioning Service Socket.926machine # [ 12.963160] dbus-broker[723]: Dispatched 733 messages @ 2(±3)μs / message.927machine # [ 12.964322] systemd[1]: Stopping D-Bus System Message Bus...928machine # [ 12.967808] systemd[1]: dbus-broker.service: Deactivated successfully.929machine # [ 12.970095] systemd[1]: Stopped D-Bus System Message Bus.930machine # [ 12.970973] systemd[1]: dbus.socket: Deactivated successfully.931machine # [ 12.976144] systemd[1]: Closed D-Bus System Message Bus Socket.932machine # [ 12.977402] systemd[1]: Stopped target System Initialization.933machine # [ 12.979512] systemd[1]: Stopped target Local Encrypted Volumes.934machine # [ 12.980502] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.935machine # [ 12.982983] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.936machine # [ 12.985213] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.937machine # [ 12.986347] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.938machine # [ 12.987485] systemd[1]: systemd-sysctl.service: Deactivated successfully.939machine # [ 12.989975] systemd[1]: Stopped Apply Kernel Variables.940machine # [ 12.990817] systemd[1]: systemd-coredump.socket: Deactivated successfully.941machine # [ 12.991837] systemd[1]: Closed Process Core Dump Socket.942machine # [ 12.992675] systemd[1]: systemd-update-done.service: Deactivated successfully.943machine # [ 12.993754] systemd[1]: Stopped Update is Completed.944machine # [ 12.996574] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.945machine # [ 12.997988] systemd[1]: Stopped Rebuild Journal Catalog.946machine # [ 13.000638] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...947machine # [ 13.011497] make-initrd-ng[987]: /etc/initrd-release -> /nix/store/7dkvhcvi4mri514gbvzzfwpl1ra73ps9-etc-os-release948machine # [ 13.013676] make-initrd-ng[987]: /etc/os-release -> /nix/store/7dkvhcvi4mri514gbvzzfwpl1ra73ps9-etc-os-release949machine # [ 13.015532] make-initrd-ng[987]: /etc/systemd/system-shutdown/shutdown-message -> /nix/store/n2rm4b9zm5jakcpkb023vy7k75z860by-shutdown-message950machine # [ 13.018569] make-initrd-ng[987]: /shutdown -> /nix/store/afhrxq2s6w30h4w81dy2cibzzkj6089v-systemd-263-409be20/lib/systemd/systemd-shutdown951machine # [ 13.037722] systemd[1]: systemd-update-utmp.service: Deactivated successfully.952machine # [ 13.041214] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.953machine # [ 13.042302] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.954machine # [ 13.043471] systemd[1]: Stopped Create System Files and Directories.955machine # [ 13.044559] systemd[1]: Stopped target Local File Systems.956machine # [ 13.048158] systemd[1]: Unmounting /nix/.ro-store...957machine # [ 13.056118] systemd[1]: Unmounting /nix/.rw-store...958machine # [ 13.063364] systemd[1]: Unmounting /run/keys...959machine # [ 13.072145] systemd[1]: Unmounting /run/wrappers...960machine # [ 13.079334] systemd[1]: Unmounting /tmp/shared...961machine # [ 13.096090] systemd[1]: Unmounting /tmp/xchg...962machine # [ 13.110942] systemd[1]: firewall.service: Deactivated successfully.963machine # [ 13.120711] systemd[1]: Stopped Firewall.964machine # [ 13.121476] systemd[1]: systemd-modules-load.service: Deactivated successfully.965machine # [ 13.122637] systemd[1]: Stopped Load Kernel Modules.966machine # [ 13.148802] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.967machine # [ 13.155757] systemd[1]: Finished Generate shutdown ramfs.968machine # [ 13.172794] systemd[1]: nix-.ro\x2dstore.mount: Deactivated successfully.969machine # [ 13.177963] systemd[1]: Unmounted /nix/.ro-store.970machine # [ 13.179856] systemd[1]: nix-.rw\x2dstore.mount: Deactivated successfully.971machine # [ 13.182658] systemd[1]: Unmounted /nix/.rw-store.972machine # [ 13.184421] systemd[1]: run-keys.mount: Deactivated successfully.973machine # [ 13.185849] systemd[1]: Unmounted /run/keys.974machine # [ 13.186884] systemd[1]: run-wrappers.mount: Deactivated successfully.975machine # [ 13.188452] systemd[1]: Unmounted /run/wrappers.976machine # [ 13.189846] systemd[1]: tmp-shared.mount: Deactivated successfully.977machine # [ 13.190895] systemd[1]: Unmounted /tmp/shared.978machine # [ 13.191965] systemd[1]: tmp-xchg.mount: Deactivated successfully.979machine # [ 13.194150] systemd[1]: Unmounted /tmp/xchg.980machine # [ 13.198103] systemd[1]: Stopped target Preparation for Local File Systems.981machine # [ 13.199227] systemd[1]: Stopped target Swaps.982machine # [ 13.199974] systemd[1]: Reached target Unmount All Filesystems.983machine # [ 13.200948] systemd[1]: systemd-remount-fs.service: Deactivated successfully.984machine # [ 13.202152] systemd[1]: Stopped Remount Root and Kernel File Systems.985machine # [ 13.203433] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.986machine # [ 13.205464] systemd[1]: Stopped Create Static Device Nodes in /dev.987machine # [ 13.206469] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.988machine # [ 13.207705] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.989machine # [ 13.208876] systemd[1]: Reached target System Shutdown.990machine # [ 13.209933] systemd[1]: Reached target Late Shutdown Services.991machine # [ 13.211150] systemd[1]: systemd-poweroff.service: Deactivated successfully.992machine # [ 13.212723] systemd[1]: Finished System Power Off.993machine # [ 13.213656] systemd[1]: Reached target System Power Off.994machine # [ 13.214581] systemd[1]: Shutting down.995machine # [ 13.489907] systemd-shutdown[1]: Syncing filesystems and block devices.996machine # [ 13.553536] systemd-shutdown[1]: Sending SIGTERM to remaining processes...997machine # [ 13.561429] systemd-journald[409]: Received SIGTERM from PID 1 (systemd-shutdow).998machine # [ 13.575993] systemd-shutdown[1]: Sending SIGKILL to remaining processes...999machine # [ 13.583855] systemd-shutdown[1]: Unmounting file systems.1000machine # [ 13.588732] (sd-umount)[1025]: Unmounting '/run/credentials/systemd-journald.service'.1001machine # [ 13.592035] (sd-remount)[1026]: Remounting '/nix/store' read-only with options 'lowerdir=/mnt-root/nix/.ro-store,upperdir=/mnt-root/nix/.rw-store/upper,workdir=/mnt-root/nix/.rw-store/work,uuid=on'.1002machine # [ 13.604998] (sd-umount)[1027]: Unmounting '/nix/store'.1003machine # [ 13.606248] (sd-umount)[1027]: Failed to unmount /nix/store: Device or resource busy1004machine # [ 13.608225] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/8ae6f6a2585f9eff.1005machine # [ 13.610665] (sd-remount)[1028]: Remounting '/nix/store' read-only with options 'lowerdir=/mnt-root/nix/.ro-store,upperdir=/mnt-root/nix/.rw-store/upper,workdir=/mnt-root/nix/.rw-store/work,uuid=on'.1006machine # [ 13.614870] (sd-umount)[1029]: Unmounting '/nix/store'.1007machine # [ 13.616896] (sd-remount)[1030]: Remounting '/' read-only with options ''.1008machine # [ 13.624437] EXT4-fs (vda): re-mounted 09723eba-3352-43b8-953b-caa084c7178d ro.1009machine # [ 13.627446] (sd-umount)[1031]: Unmounting '/run/shutdown/mounts/8ae6f6a2585f9eff'.1010machine # [ 13.629043] (sd-umount)[1031]: Failed to unmount /run/shutdown/mounts/8ae6f6a2585f9eff: Device or resource busy1011machine # [ 13.631450] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1012machine # [ 13.632889] systemd-shutdown[1]: Deactivating swaps.1013machine # [ 13.633999] systemd-shutdown[1]: All swaps deactivated.1014machine # [ 13.634602] systemd-shutdown[1]: Detaching loop devices.1015machine # [ 13.638055] systemd-shutdown[1]: All loop devices detached.1016machine # [ 13.638674] systemd-shutdown[1]: Stopping MD devices.1017machine # [ 13.639250] systemd-shutdown[1]: All MD devices stopped.1018machine # [ 13.639869] systemd-shutdown[1]: Detaching DM devices.1019machine # [ 13.640498] systemd-shutdown[1]: All DM devices detached.1020machine # [ 13.641080] systemd-shutdown[1]: Unmounting file systems.1021machine # [ 13.642094] (sd-umount)[1032]: Unmounting '/run/shutdown/mounts/8ae6f6a2585f9eff'.1022machine # [ 13.642944] (sd-umount)[1032]: Failed to unmount /run/shutdown/mounts/8ae6f6a2585f9eff: Device or resource busy1023machine # [ 13.644092] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1024machine # [ 13.644834] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing.1025machine # [ 13.647413] systemd-shutdown[1]: Successfully changed into root pivot.1026machine # [ 13.648072] systemd-shutdown[1]: Entering exitrd...1027machine # [ 13.652698] shutdown[1]: Syncing filesystems and block devices.1028machine # [ 13.653751] shutdown[1]: Sending SIGTERM to remaining processes...1029machine # [ 13.655992] shutdown[1]: Sending SIGKILL to remaining processes...1030machine # [ 13.658154] shutdown[1]: Unmounting file systems.1031machine # [ 13.659606] (sd-umoun[1034]: Unmounting '/run/credentials'.1032machine # [ 13.660614] (sd-umoun[1035]: Unmounting '/oldroot/sys/kernel/config'.1033machine # [ 13.661658] (sd-umoun[1036]: Unmounting '/oldroot/sys/fs/fuse/connections'.1034machine # [ 13.662804] (sd-umoun[1037]: Unmounting '/oldroot/dev/hugepages'.1035machine # [ 13.663868] (sd-umoun[1038]: Unmounting '/oldroot/dev/mqueue'.1036machine # [ 13.664907] (sd-umoun[1039]: Unmounting '/oldroot/sys/kernel/tracing'.1037machine # [ 13.666026] (sd-umoun[1040]: Unmounting '/oldroot/sys/kernel/debug'.1038machine # [ 13.667109] (sd-umoun[1041]: Unmounting '/oldroot/sys/fs/bpf'.1039machine # [ 13.668159] (sd-umoun[1042]: Unmounting '/oldroot/sys/fs/pstore'.1040machine # [ 13.669278] (sd-umoun[1043]: Unmounting '/oldroot/sys/fs/cgroup'.1041machine # [ 13.670301] (sd-umoun[1044]: Unmounting '/oldroot/sys/kernel/security'.1042machine # [ 13.671377] (sd-umoun[1045]: Unmounting '/oldroot/run/shutdown/mounts/8ae6f6a2585f9eff'.1043machine # [ 13.688705] (sd-umoun[1046]: Unmounting '/oldroot'.1044machine # [ 13.689820] (sd-umoun[1046]: Failed to unmount /oldroot: Device or resource busy1045machine # [ 13.691383] (sd-umoun[1047]: Unmounting '/oldroot/sys'.1046machine # [ 13.692684] (sd-umoun[1048]: Unmounting '/oldroot/run'.1047machine # [ 13.694015] (sd-umoun[1049]: Unmounting '/oldroot/proc'.1048machine # [ 13.695290] (sd-umoun[1050]: Unmounting '/oldroot/dev/shm'.1049machine # [ 13.696612] (sd-umoun[1051]: Unmounting '/oldroot/dev/pts'.1050machine # [ 13.697897] (sd-umoun[1052]: Unmounting '/oldroot/dev'.1051machine # [ 13.699406] (sd-umoun[1053]: Unmounting '/oldroot'.1052machine # [ 13.701600] EXT4-fs (vda): unmounting filesystem 09723eba-3352-43b8-953b-caa084c7178d.1053machine # [ 13.703079] shutdown[1]: All filesystems unmounted.1054machine # [ 13.704037] shutdown[1]: Deactivating swaps.1055machine # [ 13.704857] shutdown[1]: All swaps deactivated.1056machine # [ 13.705645] shutdown[1]: Detaching loop devices.1057machine # [ 13.707442] shutdown[1]: All loop devices detached.1058machine # [ 13.708238] shutdown[1]: Stopping MD devices.1059machine # [ 13.709027] shutdown[1]: All MD devices stopped.1060machine # [ 13.709794] shutdown[1]: Detaching DM devices.1061machine # [ 13.710598] shutdown[1]: All DM devices detached.1062machine # [ 13.711326] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1063machine # [ 13.714430] shutdown[1]: Syncing filesystems and block devices.1064machine # [ 13.715686] shutdown[1]: Powering off.1065machine # [ 13.726894] ACPI: PM: Preparing to enter system sleep state S51066machine # [ 13.728059] kvm: exiting hardware virtualization1067machine # [ 13.728795] reboot: Power down1068machine # [2026-10-18T02:51:32Z INFO virtiofsd] Client disconnected, shutting down1069machine # [2026-10-18T02:51:32Z INFO virtiofsd] Client disconnected, shutting down1070machine # [2026-10-18T02:51:32Z INFO virtiofsd] Client disconnected, shutting down1071machine: (finished: waiting for Unmounting '/oldroot' to appear on console, in 1.03 seconds)1072machine: waiting for Shutting down NixOS to appear on console1073!!! Traceback (most recent call last):1074!!! File "<string>", line 10, in <module>1075!!! machine.wait_for_console_text("Shutting down NixOS", timeout=dt.timedelta(seconds=5))1076!!! 1077!!! RequestedAssertionFailed: action timed out after 5.00 seconds (timeout=5.0)1078cleanup1079kill QemuMachine (pid 45)1080(finished: cleanup, in 0.00 seconds)1081additionally exposed symbols:1082 machine,1083 vlan1,1084 start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh