vm-test-run-systemd-timesyncd-nscd-dnssec
checks.x86_64-linux.systemd-timesyncd-nscd-dnssec
· build #20
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit tinydns.service8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine # Formatting '/build/vm-state-machine/tmp.5kYYGeDhXZ', fmt=raw size=107374182412machine # mke2fs 1.47.4 (6-Mar-2025)13machine # Discarding device blocks: 0/262144 done14machine # Creating filesystem with 262144 4k blocks and 65536 inodes15machine # Filesystem UUID: 05327817-1c53-412b-a455-fdea169d101216machine # Superblock backups stored on blocks:17machine # 32768, 98304, 163840, 22937618machine # 19machine # Allocating group tables: 0/8 done20machine # Writing inode tables: 0/8 done21machine # Creating journal (8192 blocks): done22machine # Writing superblocks and filesystem accounting information: 0/8 done23machine # 24machine # Virtualisation disk image created.25machine: QEMU running (pid 45)26machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)27machine # 28machine # 29machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0030machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...31machine # 32machine # 33machine # 34machine # 35machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0036machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...37machine # 38machine # 39machine # Booting from ROM...40machine # Probing EDD (edd=off to disable)... ok41machine # [ 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 202642machine # [ 0.000000] Command line: 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/j2q25p0d4qh7xi910y2ighcv6zpphhc2-nixos-system-machine-test/init regInfo=/nix/store/vb5pq0xd1b3sp8dw02m01zd2pc4fdz9k-closure-info/registration console=ttyS0,115200n8 console=tty043machine # [ 0.000000] BIOS-provided physical RAM map:44machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable45machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved46machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved47machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable48machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved49machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved50machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved51machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved52machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved53machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved54machine # [ 0.000000] NX (Execute Disable) protection: active55machine # [ 0.000000] APIC: Static calls initialized56machine # [ 0.000000] SMBIOS 2.8 present.57machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201458machine # [ 0.000000] DMI: Memory slots populated: 1/159machine # [ 0.000000] Hypervisor detected: KVM60machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000061machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0062machine # [ 0.000001] kvm-clock: using sched offset of 730122191 cycles63machine # [ 0.000003] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns64machine # [ 0.000007] tsc: Detected 2400.010 MHz processor65machine # [ 0.001256] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000066machine # [ 0.001296] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs67machine # [ 0.001300] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT68machine # [ 0.004077] found SMP MP-table at [mem 0x000f5450-0x000f545f]69machine # [ 0.004095] Using GB pages for direct mapping70machine # [ 0.004195] RAMDISK: [mem 0x3e429000-0x3ffcffff]71machine # [ 0.004207] ACPI: Early table checksum verification disabled72machine # [ 0.004211] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )73machine # [ 0.004216] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)74machine # [ 0.004222] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)75machine # [ 0.004233] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)76machine # [ 0.004237] ACPI: FACS 0x000000003FFE0000 00004077machine # [ 0.004240] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)78machine # [ 0.004243] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)79machine # [ 0.004246] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)80machine # [ 0.004248] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)81machine # [ 0.004251] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]82machine # [ 0.004252] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]83machine # [ 0.004253] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]84machine # [ 0.004254] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]85machine # [ 0.004255] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]86machine # [ 0.004256] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]87machine # [ 0.004256] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]88machine # [ 0.004586] No NUMA configuration found89machine # [ 0.004588] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]90machine # [ 0.004592] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]91machine # [ 0.008235] Zone ranges:92machine # [ 0.008237] DMA [mem 0x0000000000001000-0x0000000000ffffff]93machine # [ 0.008240] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]94machine # [ 0.008241] Normal empty95machine # [ 0.008242] Device empty96machine # [ 0.008243] Movable zone start for each node97machine # [ 0.008244] Early memory node ranges98machine # [ 0.008245] node 0: [mem 0x0000000000001000-0x000000000009efff]99machine # [ 0.008246] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]100machine # [ 0.008248] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]101machine # [ 0.008276] On node 0, zone DMA: 1 pages in unavailable ranges102machine # [ 0.008655] On node 0, zone DMA: 97 pages in unavailable ranges103machine # [ 0.034313] On node 0, zone DMA32: 40 pages in unavailable ranges104machine # [ 0.035009] ACPI: PM-Timer IO Port: 0x608105machine # [ 0.035026] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])106machine # [ 0.035063] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23107machine # [ 0.035067] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)108machine # [ 0.035069] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)109machine # [ 0.035071] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)110machine # [ 0.035073] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)111machine # [ 0.035074] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)112machine # [ 0.035079] ACPI: Using ACPI (MADT) for SMP configuration information113machine # [ 0.035080] ACPI: HPET id: 0x8086a201 base: 0xfed00000114machine # [ 0.035084] TSC deadline timer available115machine # [ 0.035091] CPU topo: Max. logical packages: 1116machine # [ 0.035092] CPU topo: Max. logical dies: 1117machine # [ 0.035093] CPU topo: Max. dies per package: 1118machine # [ 0.035098] CPU topo: Max. threads per core: 1119machine # [ 0.035099] CPU topo: Num. cores per package: 1120machine # [ 0.035100] CPU topo: Num. threads per package: 1121machine # [ 0.035100] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs122machine # [ 0.035124] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()123machine # [ 0.035165] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]124machine # [ 0.035167] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]125machine # [ 0.035169] [mem 0x40000000-0xafffffff] available for PCI devices126machine # [ 0.035171] Booting paravirtualized kernel on KVM127machine # [ 0.035175] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns128machine # [ 0.041205] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1129machine # [ 0.044369] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152130machine # [ 0.044433] kvm-guest: PV spinlocks disabled, single CPU131machine # [ 0.044435] Kernel command line: 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/j2q25p0d4qh7xi910y2ighcv6zpphhc2-nixos-system-machine-test/init regInfo=/nix/store/vb5pq0xd1b3sp8dw02m01zd2pc4fdz9k-closure-info/registration console=ttyS0,115200n8 console=tty0132machine # [ 0.044584] Unknown kernel command line parameters "regInfo=/nix/store/vb5pq0xd1b3sp8dw02m01zd2pc4fdz9k-closure-info/registration", will be passed to user space.133machine # [ 0.044600] random: crng init done134machine # [ 0.044601] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes135machine # [ 0.044649] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)136machine # [ 0.044685] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)137machine # [ 0.044728] Fallback order for Node 0: 0138machine # [ 0.044732] Built 1 zonelists, mobility grouping on. Total pages: 262006139machine # [ 0.044733] Policy zone: DMA32140machine # [ 0.048315] mem auto-init: stack:all(zero), heap alloc:on, heap free:off141machine # [ 0.051963] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1142machine # [ 0.055491] allocated 2097152 bytes of page_ext143machine # [ 0.068288] ftrace: allocating 48733 entries in 192 pages144machine # [ 0.068291] ftrace: allocated 192 pages with 2 groups145machine # [ 0.069500] Dynamic Preempt: lazy146machine # [ 0.069768] rcu: Preemptible hierarchical RCU implementation.147machine # [ 0.069769] rcu: RCU event tracing is enabled.148machine # [ 0.069770] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.149machine # [ 0.069772] Trampoline variant of Tasks RCU enabled.150machine # [ 0.069772] Rude variant of Tasks RCU enabled.151machine # [ 0.069773] Tracing variant of Tasks RCU enabled.152machine # [ 0.069774] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.153machine # [ 0.069775] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1154machine # [ 0.069807] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.155machine # [ 0.069809] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.156machine # [ 0.069811] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.157machine # [ 0.077248] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16158machine # [ 0.077604] rcu: srcu_init: Setting srcu_struct sizes based on contention.159machine # [ 0.077612] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns160machine # [ 0.077769] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)161machine # [ 0.083288] Console: colour VGA+ 80x25162machine # [ 0.083293] printk: legacy console [tty0] enabled163machine # [ 0.130173] printk: legacy console [ttyS0] enabled164machine # [ 0.332985] ACPI: Core revision 20250807165machine # [ 0.334744] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns166machine # [ 0.337978] APIC: Switch to symmetric I/O mode setup167machine # [ 0.339950] x2apic enabled168machine # [ 0.345151] APIC: Switched APIC routing to: physical x2apic169machine # [ 0.348451] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1170machine # [ 0.350401] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns171machine # [ 0.354047] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)172machine # [ 0.355169] x86/cpu: User Mode Instruction Prevention (UMIP) activated173machine # [ 0.356235] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127174machine # [ 0.357044] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0175machine # [ 0.358048] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto176machine # [ 0.359045] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl177machine # [ 0.361044] Transient Scheduler Attacks: Vulnerable: No microcode178machine # [ 0.362044] Spectre V2 : Mitigation: Enhanced / Automatic IBRS179machine # [ 0.364044] Speculative Return Stack Overflow: Mitigation: Safe RET180machine # [ 0.366042] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization181machine # [ 0.368058] Spectre V2 : Enabling IBPB for BPF182machine # [ 0.370045] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier183machine # [ 0.371045] active return thunk: srso_alias_return_thunk184machine # [ 0.372076] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'185machine # [ 0.374044] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'186machine # [ 0.375043] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'187machine # [ 0.376044] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'188machine # [ 0.377043] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'189machine # [ 0.378043] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'190machine # [ 0.379044] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'191machine # [ 0.380045] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256192machine # [ 0.381043] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64193machine # [ 0.382043] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512194machine # [ 0.384046] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024195machine # [ 0.386043] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8196machine # [ 0.387044] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.197machine # [ 0.441086] Freeing SMP alternatives memory: 44K198machine # [ 0.442049] pid_max: default: 32768 minimum: 301199machine # [ 0.444205] LSM: initializing lsm=capability,landlock,yama,bpf,ima200machine # [ 0.447187] landlock: Up and running.201machine # [ 0.448044] Yama: becoming mindful.202machine # [ 0.450374] LSM support for eBPF active203machine # [ 0.452191] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)204machine # [ 0.453079] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)205machine # [ 0.456645] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)206machine # [ 0.457842] Performance Events: Fam17h+ core perfctr, AMD PMU driver.207machine # [ 0.459051] ... version: 2208machine # [ 0.460125] ... bit width: 48209machine # [ 0.461049] ... generic counters: 6210machine # [ 0.462048] ... generic bitmap: 000000000000003f211machine # [ 0.463047] ... fixed-purpose counters: 0212machine # [ 0.464047] ... fixed-purpose bitmap: 0000000000000000213machine # [ 0.465046] ... value mask: 0000ffffffffffff214machine # [ 0.466048] ... max period: 00007fffffffffff215machine # [ 0.467048] ... global_ctrl mask: 000000000000003f216machine # [ 0.468234] signal: max sigframe size: 3376217machine # [ 0.469194] rcu: Hierarchical SRCU implementation.218machine # [ 0.470053] rcu: Max phase no-delay instances is 400.219machine # [ 0.478295] smp: Bringing up secondary CPUs ...220machine # [ 0.479071] smp: Brought up 1 node, 1 CPU221machine # [ 0.480052] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)222machine # [ 0.481366] Memory: 941780K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 98840K reserved, 0K cma-reserved)223machine # [ 0.483381] devtmpfs: initialized224machine # [ 0.484439] x86/mm: Memory block size: 128MB225machine # [ 0.486671] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)226machine # [ 0.488105] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).227machine # [ 0.489178] pinctrl core: initialized pinctrl subsystem228machine # [ 0.490497] PM: RTC time: 22:17:05, date: 2026-09-03229machine # [ 0.495308] NET: Registered PF_NETLINK/PF_ROUTE protocol family230machine # [ 0.496626] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations231machine # [ 0.497075] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations232machine # [ 0.498269] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations233machine # [ 0.499074] audit: initializing netlink subsys (disabled)234machine # [ 0.500474] thermal_sys: Registered thermal governor 'fair_share'235machine # [ 0.500477] thermal_sys: Registered thermal governor 'bang_bang'236machine # [ 0.501052] audit: type=2000 audit(1788473825.216:1): state=initialized audit_enabled=0 res=1237machine # [ 0.503052] thermal_sys: Registered thermal governor 'step_wise'238machine # [ 0.503055] thermal_sys: Registered thermal governor 'user_space'239machine # [ 0.504050] thermal_sys: Registered thermal governor 'power_allocator'240machine # [ 0.505083] cpuidle: using governor menu241machine # [ 0.508885] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5242machine # [ 0.510442] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]243machine # [ 0.511054] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry244machine # [ 0.512070] PCI: Using configuration type 1 for base access245machine # [ 0.513380] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.246machine # [ 0.520216] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages247machine # [ 0.521049] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page248machine # [ 0.522049] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages249machine # [ 0.525048] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page250machine # [ 0.536589] ACPI: Added _OSI(Module Device)251machine # [ 0.537050] ACPI: Added _OSI(Processor Device)252machine # [ 0.538049] ACPI: Added _OSI(Processor Aggregator Device)253machine # [ 0.551364] ACPI: 1 ACPI AML tables successfully acquired and loaded254machine # [ 0.557727] ACPI: Interpreter enabled255machine # [ 0.558072] ACPI: PM: (supports S0 S3 S4 S5)256machine # [ 0.563048] ACPI: Using IOAPIC for interrupt routing257machine # [ 0.564132] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug258machine # [ 0.569047] PCI: Using E820 reservations for host bridge windows259machine # [ 0.570306] ACPI: Enabled 2 GPEs in block 00 to 3F260machine # [ 0.585780] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])261machine # [ 0.589058] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]262machine # [ 0.590183] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]263machine # [ 0.591272] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]264machine # [ 0.594717] PCI host bridge to bus 0000:00265machine # [ 0.595054] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]266machine # [ 0.596051] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]267machine # [ 0.597048] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]268machine # [ 0.600049] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]269machine # [ 0.601049] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]270machine # [ 0.602049] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]271machine # [ 0.604953] pci_bus 0000:00: root bus resource [bus 00-ff]272machine # [ 0.606186] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint273machine # [ 0.607802] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint274machine # [ 0.611147] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]275machine # [ 0.612070] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]276machine # [ 0.613093] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]277machine # [ 0.614311] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]278machine # [ 0.616179] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint279machine # [ 0.620077] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]280machine # [ 0.621060] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]281machine # [ 0.622085] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]282machine # [ 0.623059] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]283machine # [ 0.624940] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint284machine # [ 0.628077] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]285machine # [ 0.629059] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]286machine # [ 0.630161] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]287machine # [ 0.632012] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint288machine # [ 0.636863] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]289machine # [ 0.638057] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]290machine # [ 0.639085] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]291machine # [ 0.640964] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint292machine # [ 0.644074] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]293machine # [ 0.645060] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]294machine # [ 0.646082] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]295machine # [ 0.647978] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint296machine # [ 0.652072] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]297machine # [ 0.653060] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]298machine # [ 0.654084] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]299machine # [ 0.656129] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint300machine # [ 0.659061] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]301machine # [ 0.660060] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]302machine # [ 0.661086] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]303machine # [ 0.663013] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint304machine # [ 0.666060] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]305machine # [ 0.667060] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]306machine # [ 0.668188] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]307machine # [ 0.669057] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]308machine # [ 0.671268] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint309machine # [ 0.673067] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]310machine # [ 0.674085] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]311machine # [ 0.675913] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint312machine # [ 0.679072] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]313machine # [ 0.680060] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]314machine # [ 0.681083] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]315machine # [ 0.682933] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint316machine # [ 0.686072] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]317machine # [ 0.687060] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]318machine # [ 0.688097] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]319machine # [ 0.690061] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint320machine # [ 0.692012] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]321machine # [ 0.693419] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint322machine # [ 0.695083] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]323machine # [ 0.696386] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint324machine # [ 0.699754] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]325machine # [ 0.701371] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint326machine # [ 0.704022] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]327machine # [ 0.705603] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint328machine # [ 0.707507] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO329machine # [ 0.709491] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint330machine # [ 0.712092] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]331machine # [ 0.713057] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]332machine # [ 0.714591] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint333machine # [ 0.717700] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]334machine # [ 0.724058] ACPI: PCI: Interrupt link LNKA configured for IRQ 10335machine # [ 0.725225] ACPI: PCI: Interrupt link LNKB configured for IRQ 10336machine # [ 0.726223] ACPI: PCI: Interrupt link LNKC configured for IRQ 11337machine # [ 0.727219] ACPI: PCI: Interrupt link LNKD configured for IRQ 11338machine # [ 0.728226] ACPI: PCI: Interrupt link LNKE configured for IRQ 10339machine # [ 0.729218] ACPI: PCI: Interrupt link LNKF configured for IRQ 10340machine # [ 0.730265] ACPI: PCI: Interrupt link LNKG configured for IRQ 11341machine # [ 0.731207] ACPI: PCI: Interrupt link LNKH configured for IRQ 11342machine # [ 0.732120] ACPI: PCI: Interrupt link GSIA configured for IRQ 16343machine # [ 0.733075] ACPI: PCI: Interrupt link GSIB configured for IRQ 17344machine # [ 0.734093] ACPI: PCI: Interrupt link GSIC configured for IRQ 18345machine # [ 0.735079] ACPI: PCI: Interrupt link GSID configured for IRQ 19346machine # [ 0.736072] ACPI: PCI: Interrupt link GSIE configured for IRQ 20347machine # [ 0.737073] ACPI: PCI: Interrupt link GSIF configured for IRQ 21348machine # [ 0.738073] ACPI: PCI: Interrupt link GSIG configured for IRQ 22349machine # [ 0.739082] ACPI: PCI: Interrupt link GSIH configured for IRQ 23350machine # [ 0.741888] iommu: Default domain type: Translated351machine # [ 0.743061] iommu: DMA domain TLB invalidation policy: lazy mode352machine # [ 0.744454] ACPI: bus type USB registered353machine # [ 0.745165] usbcore: registered new interface driver usbfs354machine # [ 0.746087] usbcore: registered new interface driver hub355machine # [ 0.747064] usbcore: registered new device driver usb356machine # [ 0.749879] NetLabel: Initializing357machine # [ 0.751048] NetLabel: domain hash size = 128358machine # [ 0.752047] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO359machine # [ 0.753205] NetLabel: unlabeled traffic allowed by default360machine # [ 0.754066] PCI: Using ACPI for IRQ routing361machine # [ 0.824191] pci 0000:00:01.0: vgaarb: setting as boot VGA device362machine # [ 0.825041] pci 0000:00:01.0: vgaarb: bridge control possible363machine # [ 0.825041] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none364machine # [ 0.825055] vgaarb: loaded365machine # [ 0.826323] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0366machine # [ 0.827049] hpet0: 3 comparators, 64-bit 100.000000 MHz counter367machine # [ 0.831224] clocksource: Switched to clocksource kvm-clock368machine # [ 0.837622] VFS: Disk quotas dquot_6.6.0369machine # [ 0.838747] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)370machine # [ 0.841710] pnp: PnP ACPI init371machine # [ 0.843044] ACPI: IRQ 4 override to edge(!), high(!)372machine # [ 0.845273] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved373machine # [ 0.848125] pnp: PnP ACPI: found 6 devices374machine # [ 0.857698] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns375machine # [ 0.861007] clocksource: Switched to clocksource acpi_pm376machine # [ 0.863099] NET: Registered PF_INET protocol family377machine # [ 0.865274] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)378machine # [ 0.894019] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)379machine # [ 0.897375] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)380machine # [ 0.900281] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)381machine # [ 0.902685] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)382machine # [ 0.905362] TCP: Hash tables configured (established 8192 bind 8192)383machine # [ 0.907335] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)384machine # [ 0.910152] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)385machine # [ 0.912056] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)386machine # [ 0.915070] NET: Registered PF_UNIX/PF_LOCAL protocol family387machine # [ 0.916990] NET: Registered PF_XDP protocol family388machine # [ 0.918905] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]389machine # [ 0.920742] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]390machine # [ 0.923031] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]391machine # [ 0.925224] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]392machine # [ 0.927557] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]393machine # [ 0.929565] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]394machine # [ 0.932927] ACPI: \_SB_.GSIA: Enabled at IRQ 16395machine # [ 0.936762] ACPI: \_SB_.GSIB: Enabled at IRQ 17396machine # [ 0.940096] ACPI: \_SB_.GSIC: Enabled at IRQ 18397machine # [ 0.943829] ACPI: \_SB_.GSID: Enabled at IRQ 19398machine # [ 0.947662] PCI: CLS 0 bytes, default 64399machine # [ 0.949624] Trying to unpack rootfs image as initramfs...400machine # [ 0.955162] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns401machine # [ 1.037087] Initialise system trusted keyrings402machine # [ 1.042655] workingset: timestamp_bits=40 max_order=18 bucket_order=0403machine # [ 1.085795] Key type asymmetric registered404machine # [ 1.098478] Asymmetric key parser 'x509' registered405machine # [ 1.100002] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)406machine # [ 1.107742] io scheduler mq-deadline registered407machine # [ 1.109594] io scheduler kyber registered408machine # [ 1.115343] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled409machine # [ 1.118105] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A410machine # [ 1.127110] Linux agpgart interface v0.103411machine # [ 1.130572] ACPI: bus type drm_connector registered412machine # [ 1.136204] usbcore: registered new interface driver usbserial_generic413machine # [ 1.138649] usbserial: USB Serial support registered for generic414machine # [ 1.140845] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.415machine # [ 1.140845] Please enable it if your BIOS has the CPPC option.416machine # [ 1.153475] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled417machine # [ 1.160635] drop_monitor: Initializing network drop monitor service418machine # [ 1.163186] NET: Registered PF_INET6 protocol family419machine # [ 1.168321] Segment Routing with IPv6420machine # [ 1.171502] In-situ OAM (IOAM) with IPv6421machine # [ 1.175917] IPI shorthand broadcast: enabled422machine # [ 1.188992] sched_clock: Marking stable (918022707, 270428959)->(1494268674, -305817008)423machine # [ 1.196743] registered taskstats version 1424machine # [ 1.200819] Loading compiled-in X.509 certificates425machine # [ 1.234478] Demotion targets for Node 0: null426machine # [ 1.236143] Key type .fscrypt registered427machine # [ 1.239472] Key type fscrypt-provisioning registered428machine # [ 1.243610] ima: No TPM chip found, activating TPM-bypass!429machine # [ 1.245695] ima: Allocated hash algorithm: sha1430machine # [ 1.250525] ima: No architecture policies found431machine # [ 1.254473] PM: Magic number: 10:298:299432machine # [ 1.259699] RAS: Correctable Errors collector initialized.433machine # [ 1.277647] clk: Disabling unused clocks434machine # [ 1.284472] PM: genpd: Disabling unused power domains435machine # [ 1.535590] Freeing initrd memory: 28316K436machine # [ 1.545908] Freeing unused decrypted memory: 2028K437machine # [ 1.554272] Freeing unused kernel image (initmem) memory: 3644K438machine # [ 1.556415] Write protecting the kernel read-only data: 32768k439machine # [ 1.559574] Freeing unused kernel image (text/rodata gap) memory: 1216K440machine # [ 1.562733] Freeing unused kernel image (rodata/data gap) memory: 756K441machine # [ 1.641778] x86/mm: Checked W+X mappings: passed, no W+X pages found.442machine # [ 1.644790] Run /init as init process443machine # [ 1.661129] systemd[1]: Inserted module 'autofs4'444machine # [ 1.687419] fuse: init (API version 7.45)445machine # [ 1.697159] ACPI: \_SB_.GSIG: Enabled at IRQ 22446machine # [ 1.701496] ACPI: \_SB_.GSIH: Enabled at IRQ 23447machine # [ 1.706631] ACPI: \_SB_.GSIE: Enabled at IRQ 20448machine # [ 1.710805] ACPI: \_SB_.GSIF: Enabled at IRQ 21449machine # [ 1.752194] systemd[1]: Successfully made /usr/ read-only.450machine # [ 2.089985] systemd[1]: systemd 262-2451b1a 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)451machine # [ 2.104196] systemd[1]: Detected virtualization kvm.452machine # [ 2.105549] systemd[1]: Detected architecture x86-64.453machine # [ 2.107492] systemd[1]: Running in initrd.454machine # [ 2.109655] systemd[1]: Initializing machine ID from random generator.455machine # [ 2.111753] systemd[1]: Hostname set to <machine>.456machine # [ 2.236535] systemd[1]: bpf-restrict-fs: LSM BPF program attached457machine # [ 2.302685] systemd[1]: Queued start job for default target Initrd Default Target.458machine # [ 2.314918] systemd[1]: Created slice Slice /system/modprobe.459machine # [ 2.316764] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.460machine # [ 2.321275] systemd[1]: Expecting device /dev/disk/by-label/nixos...461machine # [ 2.323720] systemd[1]: Reached target Path Units.462machine # [ 2.325610] systemd[1]: Reached target Slice Units.463machine # [ 2.327532] systemd[1]: Reached target Swaps.464machine # [ 2.328967] systemd[1]: Reached target Timer Units.465machine # [ 2.330621] systemd[1]: Listening on D-Bus System Message Bus Socket.466machine # [ 2.337033] systemd[1]: Listening on Journal Socket (/dev/log).467machine # [ 2.339574] systemd[1]: Listening on Journal Sockets.468machine # [ 2.345667] systemd[1]: Listening on udev Kernel Socket.469machine # [ 2.347104] systemd[1]: Reached target Socket Units.470machine # [ 2.354256] systemd[1]: Starting Create List of Static Device Nodes...471machine # [ 2.362559] systemd[1]: Starting Load Kernel Module 9pnet_virtio...472machine # [ 2.377567] systemd[1]: Starting Load Kernel Module configfs...473machine # [ 2.398195] systemd[1]: Starting Journal Service...474machine # [ 2.419571] systemd[1]: Starting Load Kernel Modules...475machine # [ 2.432577] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os476machine # [ 2.464415] netfs: FS-Cache loaded477machine # [ 2.472882] 9pnet: Installing 9P2000 support478machine # [ 2.491788] systemd[1]: Starting Coldplug All udev Devices...479machine # [ 2.516571] systemd[1]: Finished Create List of Static Device Nodes.480machine # [ 2.527647] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.481machine # [ 2.537569] systemd[1]: Finished Load Kernel Module 9pnet_virtio.482machine # [ 2.549200] systemd[1]: modprobe@configfs.service: Deactivated successfully.483machine # [ 2.556600] systemd-journald[68]: Collecting audit messages is disabled.484machine # [ 2.565063] systemd[1]: Finished Load Kernel Module configfs.485machine # [ 2.575158] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config486machine # [ 2.584392] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.487machine # [ 2.596685] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev488machine # [ 2.600119] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...489machine # [ 2.649279] systemd[1]: Finished Load Kernel Modules.490machine # [ 2.663038] systemd[1]: Starting Apply Kernel Variables...491machine # [ 2.691571] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.492machine # [ 2.706576] systemd[1]: Starting Create Static Device Nodes in /dev...493machine # [ 2.734632] systemd[1]: Finished Apply Kernel Variables.494machine # [ 2.762356] systemd[1]: Finished Create Static Device Nodes in /dev.495machine # [ 2.773007] systemd[1]: Started Journal Service.496machine # [ 2.504689] systemd-modules-load[69]: Inserted module 'dm_mod'497machine # [ 2.507350] systemd-modules-load[69]: Inserted module 'virtio_balloon'498machine # [ 2.509711] systemd-modules-load[69]: Inserted module 'virtio_gpu'499machine # [ 2.529147] systemd[1]: Reached target Preparation for Local File Systems.500machine # [ 2.531510] systemd[1]: Reached target Local File Systems.501machine # [ 2.536097] systemd[1]: Starting Create System Files and Directories...502machine # [ 2.545201] systemd[1]: Starting Rule-based Manager for Device Events and Files...503machine # [ 2.592763] systemd[1]: Finished Create System Files and Directories.504machine # [ 2.635376] systemd-udevd[83]: Using default interface naming scheme 'v261'.505machine # [ 2.678107] systemd[1]: Started Rule-based Manager for Device Events and Files.506machine # [ 2.742957] systemd[1]: Finished Coldplug All udev Devices.507machine # [ 2.751443] systemd[1]: Reached target System Initialization.508machine # [ 2.752987] systemd[1]: Reached target Basic System.509machine # [ 3.322222] virtio_blk virtio5: 1/0/0 default/read/poll queues510machine # [ 3.350913] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12511machine # [ 3.367155] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)512machine # [ 3.386973] ehci-pci 0000:00:1d.7: EHCI Host Controller513machine # [ 3.389040] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1514machine # [ 3.393369] serio: i8042 KBD port at 0x60,0x64 irq 1515machine # [ 3.396017] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000516machine # [ 3.407477] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00517machine # [ 3.409723] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18518machine # [ 3.413715] serio: i8042 AUX port at 0x60,0x64 irq 12519machine # [ 3.415646] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1520machine # [ 3.419455] usb usb1: Product: EHCI Host Controller521machine # [ 3.421603] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd522machine # [ 3.426614] usb usb1: SerialNumber: 0000:00:1d.7523machine # [ 3.429873] hub 1-0:1.0: USB hub found524machine # [ 3.433159] hub 1-0:1.0: 6 ports detected525machine # [ 3.441147] uhci_hcd 0000:00:1d.0: UHCI Host Controller526machine # [ 3.451074] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2527machine # [ 3.463746] uhci_hcd 0000:00:1d.0: detected 2 ports528machine # [ 3.474895] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200529machine # [ 3.492870] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18530machine # [ 3.495732] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1531machine # [ 3.527194] usb usb2: Product: UHCI Host Controller532machine # [ 3.532212] SCSI subsystem initialized533machine # [ 3.538471] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd534machine # [ 3.549687] usb usb2: SerialNumber: 0000:00:1d.0535machine # [ 3.290212] systemd[1]: Starting Virtual Console Setup...536machine # [ 3.301244] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.537machine # [ 3.580996] hub 2-0:1.0: USB hub found538machine # [ 3.592396] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0539machine # [ 3.327398] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.540machine # [ 3.333736] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.541machine # [ 3.614006] hub 2-0:1.0: 2 ports detected542machine # [ 3.364337] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.543machine # [ 3.370308] systemd[1]: Finished Virtual Console Setup.544machine # [ 3.645762] uhci_hcd 0000:00:1d.1: UHCI Host Controller545machine # [ 3.667402] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3546machine # [ 3.676478] usb 1-1: new high-speed USB device number 2 using ehci-pci547machine # [ 3.684856] uhci_hcd 0000:00:1d.1: detected 2 ports548machine # [ 3.419285] systemd[1]: Found device /dev/disk/by-label/nixos.549machine # [ 3.421600] systemd[1]: Reached target Initrd Root Device.550machine # [ 3.428102] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...551machine # [ 3.702779] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220552machine # [ 3.705842] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18553machine # [ 3.711457] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1554machine # [ 3.720465] usb usb3: Product: UHCI Host Controller555machine # [ 3.727462] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd556machine # [ 3.733025] usb usb3: SerialNumber: 0000:00:1d.1557machine # [ 3.738896] hub 3-0:1.0: USB hub found558machine # [ 3.744543] hub 3-0:1.0: 2 ports detected559machine # [ 3.489382] systemd-fsck[108]: nixos: clean, 12/65536 files, 13019/262144 blocks560machine # [ 3.764476] uhci_hcd 0000:00:1d.2: UHCI Host Controller561machine # [ 3.770237] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4562machine # [ 3.507643] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.563machine # [ 3.784564] uhci_hcd 0000:00:1d.2: detected 2 ports564machine # [ 3.789701] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240565machine # [ 3.793870] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18566machine # [ 3.798086] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode567machine # [ 3.800916] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1568machine # [ 3.804103] usb usb4: Product: UHCI Host Controller569machine # [ 3.805664] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)570machine # [ 3.808172] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd571machine # [ 3.810100] ahci 0000:00:1f.2: flags: 64bit ncq only572machine # [ 3.812273] usb usb4: SerialNumber: 0000:00:1d.2573machine # [ 3.816295] hub 4-0:1.0: USB hub found574machine # [ 3.819545] hub 4-0:1.0: 2 ports detected575machine # [ 3.825543] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00576machine # [ 3.827518] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10577machine # [ 3.829757] usb 1-1: Product: QEMU USB Tablet578machine # [ 3.831025] usb 1-1: Manufacturer: QEMU579machine # [ 3.835469] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1580machine # [ 3.839517] scsi host0: ahci581machine # [ 3.844845] scsi host1: ahci582machine # [ 3.846845] scsi host2: ahci583machine # [ 3.849823] scsi host3: ahci584machine # [ 3.856798] scsi host4: ahci585machine # [ 3.863900] scsi host5: ahci586machine # [ 3.871774] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1587machine # [ 3.888975] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1588machine # [ 3.905940] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1589machine # [ 3.916265] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1590machine # [ 3.926484] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1591machine # [ 3.935053] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1592machine # [ 3.945801] hid: raw HID events driver (C) Jiri Kosina593machine # [ 4.251153] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)594machine # [ 4.252760] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100595machine # [ 4.254302] ata3.00: applying bridge limits596machine # [ 4.255610] ata3.00: configured for UDMA/100597machine # [ 4.256974] ata1: SATA link down (SStatus 0 SControl 300)598machine # [ 4.262205] ata6: SATA link down (SStatus 0 SControl 300)599machine # [ 4.263765] ata4: SATA link down (SStatus 0 SControl 300)600machine # [ 4.265382] ata2: SATA link down (SStatus 0 SControl 300)601machine # [ 4.266874] ata5: SATA link down (SStatus 0 SControl 300)602machine # [ 4.268795] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5603machine # [ 4.309973] usbcore: registered new interface driver usbhid604machine # [ 4.319040] usbhid: USB HID core driver605machine # [ 4.328546] 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/input2606machine # [ 4.331824] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray607machine # [ 4.334012] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0608machine # [ 4.344595] cdrom: Uniform CD-ROM driver Revision: 3.20609machine # [ 4.237114] systemd[1]: Mounting /sysroot...610machine # [ 4.625263] EXT4-fs (vda): mounted filesystem 05327817-1c53-412b-a455-fdea169d1012 r/w with ordered data mode. Quota mode: none.611machine # [ 4.360328] systemd[1]: Mounted /sysroot.612machine # [ 4.363144] systemd[1]: Reached target Initrd Root File System.613machine # [ 4.365926] systemd[1]: Starting Mountpoints Configured in the Real Root...614machine # [ 4.381407] systemd-sysroot-fstab-check[143]: /sysroot should be mounted in the initrd, will request daemon-reload.615machine # [ 4.390171] systemd[1]: Reload requested from client PID 143 ('systemd-sysroot') (unit initrd-parse-etc.service)...616machine # [ 4.392645] systemd[1]: Reloading...617machine # [ 4.490555] systemd[1]: Reloading finished in 95 ms.618machine # [ 4.503930] systemd-sysroot-fstab-check[143]: Requesting initrd-fs.target/start/replace...619machine # [ 4.508172] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio620machine # [ 4.514368] systemd-sysroot-fstab-check[143]: Requesting swap.target/start/replace...621machine # [ 4.519187] systemd[1]: initrd-parse-etc.service: Deactivated successfully.622machine # [ 4.522086] systemd[1]: Finished Mountpoints Configured in the Real Root.623machine # [ 4.523741] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.624machine # [ 5.240131] systemd[1]: Mounting /sysroot/nix/.ro-store...625machine # [ 5.242192] systemd[1]: Mounting /sysroot/nix/.rw-store...626machine # [ 5.247189] systemd[1]: Mounting /sysroot/run...627machine # [ 5.256120] systemd[1]: Mounting /sysroot/tmp/shared...628machine # [ 5.263520] systemd[1]: Mounting /sysroot/tmp/xchg...629machine # [ 5.583377] 9p: Installing v9fs 9p2000 file system support630machine # [ 5.323608] systemd[1]: Mounted /sysroot/nix/.rw-store.631machine # [ 5.326663] systemd[1]: Mounted /sysroot/run.632machine # [ 5.334816] systemd[1]: Mounted /sysroot/nix/.ro-store.633machine # [ 5.337332] systemd[1]: Mounted /sysroot/tmp/shared.634machine # [ 5.341646] systemd[1]: Mounted /sysroot/tmp/xchg.635machine # [ 5.349195] systemd[1]: Starting rw-sysroot-nix-store.service...636machine # [ 5.370179] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.637machine # [ 5.380675] systemd[1]: Finished rw-sysroot-nix-store.service.638machine # [ 5.384376] systemd[1]: Mounting /sysroot/nix/store...639machine # [ 5.416701] systemd[1]: Mounted /sysroot/nix/store.640machine # [ 5.419148] systemd[1]: Reached target Initrd File Systems.641machine # [ 5.425907] systemd[1]: Starting Find NixOS closure...642machine # [ 5.429979] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...643machine # [ 5.459131] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.644machine # [ 5.472666] systemd[1]: Finished Find NixOS closure.645machine # [ 5.475308] systemd[1]: Reached target Initrd Default Target.646machine # [ 5.478779] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...647machine # [ 5.502043] systemd[1]: Stopped target Initrd Default Target.648machine # [ 5.505107] systemd[1]: Stopped target Basic System.649machine # [ 5.510316] systemd[1]: Stopped target Initrd Root Device.650machine # [ 5.511655] systemd[1]: Stopped target Path Units.651machine # [ 5.513424] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.652machine # [ 5.516079] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.653machine # [ 5.518990] systemd[1]: Stopped target Slice Units.654machine # [ 5.521341] systemd[1]: Stopped target Socket Units.655machine # [ 5.523465] systemd[1]: Stopped target System Initialization.656machine # [ 5.526144] systemd[1]: Stopped target Swaps.657machine # [ 5.527483] systemd[1]: Stopped target Timer Units.658machine # [ 5.532919] systemd[1]: dbus.socket: Deactivated successfully.659machine # [ 5.534591] systemd[1]: Closed D-Bus System Message Bus Socket.660machine # [ 5.536691] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.661machine # [ 5.538277] systemd[1]: Stopped Find NixOS closure.662machine # [ 5.540399] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio663machine # [ 5.545430] systemd[1]: Starting rw-sysroot-nix-store.service...664machine # [ 5.547559] systemd[1]: systemd-sysctl.service: Deactivated successfully.665machine # [ 5.550339] systemd[1]: Stopped Apply Kernel Variables.666machine # [ 5.553491] systemd[1]: systemd-modules-load.service: Deactivated successfully.667machine # [ 5.557095] systemd[1]: Stopped Load Kernel Modules.668machine # [ 5.558867] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.669machine # [ 5.560567] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.670machine # [ 5.566947] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.671machine # [ 5.568754] systemd[1]: Stopped Create System Files and Directories.672machine # [ 5.570224] systemd[1]: Stopped target Local File Systems.673machine # [ 5.574237] systemd[1]: Stopped target Preparation for Local File Systems.674machine # [ 5.576701] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.675machine # [ 5.579517] systemd[1]: Stopped Coldplug All udev Devices.676machine # [ 5.583255] systemd[1]: Stopping Rule-based Manager for Device Events and Files...677machine # [ 5.585795] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.678machine # [ 5.588138] systemd[1]: Stopped Virtual Console Setup.679machine # [ 5.603774] systemd[1]: initrd-cleanup.service: Deactivated successfully.680machine # [ 5.614341] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.681machine # [ 5.622178] systemd[1]: systemd-udevd.service: Deactivated successfully.682machine # [ 5.630173] systemd[1]: Stopped Rule-based Manager for Device Events and Files.683machine # [ 5.634639] systemd[1]: Starting Cleanup udev Database...684machine # [ 5.636571] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.685machine # [ 5.639494] systemd[1]: Stopped Create Static Device Nodes in /dev.686machine # [ 5.643102] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.687machine # [ 5.644962] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.688machine # [ 5.646621] systemd[1]: kmod-static-nodes.service: Deactivated successfully.689machine # [ 5.648207] systemd[1]: Stopped Create List of Static Device Nodes.690machine # [ 5.650198] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.691machine # [ 5.660700] systemd[1]: Finished rw-sysroot-nix-store.service.692machine # [ 5.686267] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.693machine # [ 5.693105] systemd[1]: Finished Cleanup udev Database.694machine # [ 5.694476] systemd[1]: Reached target Switch Root.695machine # [ 5.696940] systemd[1]: Starting NixOS Activation...696machine # [ 5.882720] initrd-nixos-activation-start[192]: booting system configuration /nix/store/j2q25p0d4qh7xi910y2ighcv6zpphhc2-nixos-system-machine-test697machine # [ 5.960178] initrd-nixos-activation-start[192]: running activation script...698machine # [ 6.458485] initrd-nixos-activation-start[215]: setting up /etc...699machine # [ 6.767889] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.700machine # [ 6.770386] systemd[1]: Finished NixOS Activation.701machine # [ 6.773569] systemd[1]: Starting Switch Root...702machine # [ 6.794410] systemd[1]: Switching root.703machine # [ 7.195232] systemd-journald[68]: Received SIGTERM from PID 1 (systemd).704machine # [ 7.375921] NET: Registered PF_VSOCK protocol family705machine # [ 7.776489] systemd[1]: systemd 262-2451b1a 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)706machine # [ 7.783217] systemd[1]: Detected virtualization kvm.707machine # [ 7.784460] systemd[1]: Detected architecture x86-64.708machine # [ 7.785814] systemd[1]: Detected first boot.709machine # [ 7.791397] systemd[1]: Initializing machine ID from random generator.710machine # [ 7.957495] systemd[1]: bpf-restrict-fs: LSM BPF program attached711machine # [ 8.122882] systemd[1]: Applying preset policy.712machine # [ 8.634536] systemd[1]: Populated /etc with preset unit settings.713machine # [ 9.217476] systemd[1]: initrd-switch-root.service: Deactivated successfully.714machine # [ 9.220396] systemd[1]: Stopped initrd-switch-root.service.715machine # [ 9.228940] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.716machine # [ 9.233279] systemd[1]: Created slice Slice /system/getty.717machine # [ 9.239658] systemd[1]: Created slice User and Session Slice.718machine # [ 9.241773] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.719machine # [ 9.247520] systemd[1]: Started Forward Password Requests to Wall Directory Watch.720machine # [ 9.249496] systemd[1]: Expecting device /dev/hvc0...721machine # [ 9.250796] systemd[1]: Expecting device /dev/ttyS0...722machine # [ 9.252096] systemd[1]: Reached target Local Encrypted Volumes.723machine # [ 9.253581] systemd[1]: Stopped target initrd-fs.target.724machine # [ 9.254898] systemd[1]: Stopped target initrd-root-fs.target.725machine # [ 9.256304] systemd[1]: Stopped target initrd-switch-root.target.726machine # [ 9.257831] systemd[1]: Reached target Virtual Machines and Containers.727machine # [ 9.259447] systemd[1]: Reached target Path Units.728machine # [ 9.260704] systemd[1]: Reached target Remote File Systems.729machine # [ 9.262097] systemd[1]: Reached target Slice Units.730machine # [ 9.263836] systemd[1]: Reached target Swaps.731machine # [ 9.290753] systemd[1]: Listening on Query the User Interactively for a Password.732machine # [ 9.295588] systemd[1]: Listening on Process Core Dump Socket.733machine # [ 9.299156] systemd[1]: Listening on Credential Encryption/Decryption.734machine # [ 9.302711] systemd[1]: Listening on Factory Reset Management.735machine # [ 9.304310] systemd[1]: Listening on Hostname Service Socket.736machine # [ 9.317047] systemd[1]: Starting Journal Log Access Socket...737machine # [ 9.319725] systemd[1]: Listening on Journal Audit Socket.738machine # [ 9.324942] systemd[1]: Listening on Console Output Muting Service Socket.739machine # [ 9.326839] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.740machine # [ 9.329332] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os741machine # [ 9.331644] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki742machine # [ 9.345211] systemd[1]: Listening on Disk Repartitioning Service Socket.743machine # [ 9.347100] systemd[1]: Listening on Resolve Monitor Varlink Socket.744machine # [ 9.348889] systemd[1]: Listening on Resolve Service Varlink Socket.745machine # [ 9.350668] systemd[1]: Listening on udev Varlink Socket.746machine # [ 9.356062] systemd[1]: Mounting Huge Pages File System...747machine # [ 9.361545] systemd[1]: Mounting POSIX Message Queue File System...748machine # [ 9.370347] systemd[1]: Mounting Kernel Debug File System...749machine # [ 9.383045] systemd[1]: Mounting Kernel Trace File System...750machine # [ 9.393883] systemd[1]: Starting Create List of Static Device Nodes...751machine # [ 9.398238] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio752machine # [ 9.420507] systemd[1]: Starting Load Kernel Module configfs...753machine # [ 9.423457] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm754machine # [ 9.428754] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore755machine # [ 9.435519] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse756machine # [ 9.501801] systemd[1]: Mounting FUSE Control File System...757machine # [ 9.509765] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67758machine # [ 9.546569] systemd[1]: Starting Journal Service...759machine # [ 9.559695] systemd[1]: Starting Load Kernel Modules...760machine # [ 9.577217] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...761machine # [ 9.591186] systemd[1]: Starting Remount Root and Kernel File Systems...762machine # [ 9.602802] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os763machine # [ 9.645775] systemd[1]: Starting Coldplug All udev Devices...764machine # [ 9.676505] systemd-journald[286]: Collecting audit messages is enabled.765machine # [ 9.683263] systemd[1]: Listening on Journal Log Access Socket.766machine # [ 9.694474] systemd[1]: Mounted Huge Pages File System.767machine # [ 9.699736] loop: module loaded768machine # [ 9.703940] systemd[1]: Mounted POSIX Message Queue File System.769machine # [ 9.713632] systemd[1]: Mounted Kernel Debug File System.770machine # [ 9.722546] systemd[1]: Mounted Kernel Trace File System.771machine # [ 9.723998] EXT4-fs (vda): re-mounted 05327817-1c53-412b-a455-fdea169d1012.772machine # [ 9.732982] systemd[1]: Finished Create List of Static Device Nodes.773machine # [ 9.470792] systemd[1]: Queued start job for default target Multi-User System.774machine # [ 9.476311] systemd[1]: systemd-journald.service: Deactivated successfully.775machine # [ 9.750237] systemd[1]: Started Journal Service.776machine # [ 9.482092] systemd-modules-load[287]: Inserted module 'loop'777machine # [ 9.490092] systemd[1]: modprobe@configfs.service: Deactivated successfully.778machine # [ 9.496121] systemd[1]: Finished Load Kernel Module configfs.779machine # [ 9.499111] systemd[1]: Mounted FUSE Control File System.780machine # [ 9.503150] systemd[1]: Finished Load Kernel Modules.781machine # [ 9.507860] systemd[1]: Finished Remount Root and Kernel File Systems.782machine # [ 9.537120] systemd[1]: Listening on Disk Image Download Service Socket.783machine # [ 9.548186] systemd[1]: Mounting Kernel Configuration File System...784machine # [ 9.557097] systemd[1]: Starting Firewall...785machine # [ 9.570096] systemd[1]: Starting Flush Journal to Persistent Storage...786machine # [ 9.581097] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore787machine # [ 9.603106] systemd[1]: Starting Load/Save OS Random Seed...788machine # [ 9.605957] systemd-oomd[288]: No swap; memory pressure usage will be degraded789machine # [ 9.630225] systemd[1]: Starting Apply Kernel Variables...790machine # [ 9.658374] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...791machine # [ 9.662299] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os792machine # [ 9.683503] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.793machine # [ 9.979727] systemd-journald[286]: Received client request to flush runtime journal.794machine # [ 9.984495] systemd[1]: Mounted Kernel Configuration File System.795machine # [ 9.991351] systemd[1]: Finished Load/Save OS Random Seed.796machine # [ 9.995608] systemd[1]: Reached target First Boot Complete.797machine # [ 9.997750] systemd[1]: Finished Apply Kernel Variables.798machine # [ 9.999795] systemd[1]: Starting Network Name Resolution...799machine # [ 10.001914] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.800machine # [ 10.004252] systemd[1]: Starting Create Static Device Nodes in /dev...801machine # [ 10.011607] systemd[1]: Finished Flush Journal to Persistent Storage.802machine # [ 10.092130] systemd[1]: Finished Create Static Device Nodes in /dev.803machine # [ 10.099179] systemd[1]: Reached target Preparation for Local File Systems.804machine # [ 10.110144] systemd[1]: Mounting /run/wrappers...805machine # [ 10.118252] systemd[1]: Starting Rule-based Manager for Device Events and Files...806machine # [ 10.213514] systemd-resolved[315]: Positive Trust Anchors:807machine # [ 10.218308] systemd-resolved[315]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d808machine # [ 10.220679] systemd-resolved[315]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16809machine # [ 10.223669] systemd-resolved[315]: 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 test810machine # [ 10.255184] systemd[1]: Mounted /run/wrappers.811machine # [ 10.256722] systemd[1]: Reached target Local File Systems.812machine # [ 10.259934] systemd[1]: Listening on Boot Loader Control Service Socket.813machine # [ 10.269144] systemd[1]: Starting register-nix-paths.service...814machine # [ 10.271129] systemd-resolved[315]: Using system hostname 'machine'.815machine # [ 10.286782] systemd[1]: Starting Create SUID/SGID Wrappers...816machine # [ 10.288290] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.817machine # [ 10.315106] systemd[1]: Starting Save Transient machine-id to Disk...818machine # [ 10.343217] systemd[1]: Starting Create System Files and Directories...819machine # [ 10.351928] systemd[1]: Started Network Name Resolution.820machine # [ 10.397902] systemd-udevd[332]: Using default interface naming scheme 'v261'.821machine # [ 10.410285] systemd[1]: Starting Network Time Synchronization...822machine # [ 10.504512] systemd[1]: Finished Save Transient machine-id to Disk.823machine # [ 10.576050] systemd[1]: Finished Coldplug All udev Devices.824machine # [ 10.655692] systemd[1]: Finished Create System Files and Directories.825machine # [ 10.676060] systemd[1]: Starting Rebuild Journal Catalog...826machine # [ 10.689642] systemd[1]: Starting Record System Boot/Shutdown in UTMP...827machine # [ 10.736258] systemd[1]: Started Rule-based Manager for Device Events and Files.828machine # [ 10.839811] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "WATCHDOG=1"829machine # [ 10.846453] systemd-timesyncd[350]: Bus bus-api-timesync: changing state UNSET → OPENING830machine # [ 10.851295] systemd-timesyncd[350]: sd-bus: starting bus bus-api-timesync by connecting to /run/dbus/system_bus_socket...831machine # [ 10.857881] systemd-timesyncd[350]: Added inotify watch 2 for /run on bus bus-api-timesync.832machine # [ 10.865241] systemd-timesyncd[350]: Added inotify watch 3 for /run/dbus on bus bus-api-timesync.833machine # [ 10.867683] systemd-timesyncd[350]: Added inotify watch 4 for /run/dbus/system_bus_socket on bus bus-api-timesync.834machine # [ 10.872872] systemd-timesyncd[350]: sd-bus: starting bus bus-api-timesync by connecting to /run/dbus/system_bus_socket...835machine # [ 10.879100] systemd-timesyncd[350]: Bus bus-api-timesync: changing state OPENING → WATCH_BIND836machine # [ 10.884745] systemd-timesyncd[350]: Registering bus object implementation for path=/org/freedesktop/timesync1 iface=org.freedesktop.timesync1.Manager837machine # [ 10.888972] systemd-timesyncd[350]: Registering bus object implementation for path=/org/freedesktop/LogControl1 iface=org.freedesktop.LogControl1838machine # [ 10.895976] systemd-timesyncd[350]: Added new fallback server fake.ntp.839machine # [ 10.900314] systemd-timesyncd[350]: Added new system server fake.ntp.840machine # [ 10.905197] systemd-timesyncd[350]: systemd-timesyncd running as pid 350841machine # [ 10.909040] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "READY=1\nSTATUS=Daemon is running"842machine # [ 10.913692] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."843machine # [ 10.920379] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."844machine # [ 10.923544] systemd-timesyncd[350]: Selected server fake.ntp.845machine # [ 10.928270] systemd-timesyncd[350]: Resolving fake.ntp...846machine # [ 10.932247] systemd-timesyncd[350]: varlink: Setting state idle-client847machine # [ 10.936709] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}848machine # [ 10.943452] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply849machine # [ 10.948108] systemd[1]: Started Network Time Synchronization.850machine # [ 10.952399] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}851machine # [ 10.954976] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply852machine # [ 10.957420] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown853machine # [ 10.964956] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."854machine # [ 10.968196] systemd-timesyncd[350]: Resolving fake.ntp...855machine # [ 10.972211] systemd-timesyncd[350]: varlink: Setting state idle-client856machine # [ 10.976492] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}857machine # [ 10.981302] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply858machine # [ 10.984986] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client859machine # [ 10.990544] systemd[1]: Finished Record System Boot/Shutdown in UTMP.860machine # [ 10.993601] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}861machine # [ 10.997257] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply862machine # [ 11.001198] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown863machine # [ 11.005281] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."864machine # [ 11.009380] systemd-timesyncd[350]: Resolving fake.ntp...865machine # [ 11.013283] systemd-timesyncd[350]: varlink: Setting state idle-client866machine # [ 11.015350] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}867machine # [ 11.021108] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply868machine # [ 11.023751] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client869machine # [ 11.027813] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}870machine # [ 11.031876] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply871machine # [ 11.036154] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown872machine # [ 11.040355] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."873machine # [ 11.042611] systemd-timesyncd[350]: Resolving fake.ntp...874machine # [ 11.044291] systemd-timesyncd[350]: varlink: Setting state idle-client875machine # [ 11.049124] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}876machine # [ 11.054286] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply877machine # [ 11.058262] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client878machine # [ 11.062185] systemd[1]: Reached target System Time Set.879machine # [ 11.065369] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}880machine # [ 11.072181] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply881machine # [ 11.074644] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown882machine # [ 11.077197] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."883machine # [ 11.079752] systemd-timesyncd[350]: Resolving fake.ntp...884machine # [ 11.084186] systemd-timesyncd[350]: varlink: Setting state idle-client885machine # [ 11.087335] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}886machine # [ 11.091544] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply887machine # [ 11.097256] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client888machine # [ 11.101518] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}889machine # [ 11.106336] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply890machine # [ 11.110167] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown891machine # [ 11.112775] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."892machine # [ 11.116834] systemd-timesyncd[350]: Resolving fake.ntp...893machine # [ 11.118630] systemd-timesyncd[350]: varlink: Setting state idle-client894machine # [ 11.123211] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}895machine # [ 11.129673] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply896machine # [ 11.133152] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client897machine # [ 11.135553] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}898machine # [ 11.140856] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply899machine # [ 11.143394] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown900machine # [ 11.147575] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."901machine # [ 11.151757] systemd-timesyncd[350]: Resolving fake.ntp...902machine # [ 11.154289] systemd-timesyncd[350]: varlink: Setting state idle-client903machine # [ 11.158631] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}904machine # [ 11.164147] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply905machine # [ 11.168186] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client906machine # [ 11.172159] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}907machine # [ 11.175349] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply908machine # [ 11.181215] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown909machine # [ 11.183553] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."910machine # [ 11.187599] systemd-timesyncd[350]: Resolving fake.ntp...911machine # [ 11.191096] systemd-timesyncd[350]: varlink: Setting state idle-client912machine # [ 11.195178] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}913machine # [ 11.198507] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply914machine # [ 11.202154] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.915machine # [ 11.207065] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client916machine # [ 11.209502] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}917machine # [ 11.213969] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply918machine # [ 11.217152] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown919machine # [ 11.220497] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."920machine # [ 11.224684] systemd-timesyncd[350]: Resolving fake.ntp...921machine # [ 11.226377] systemd-timesyncd[350]: varlink: Setting state idle-client922machine # [ 11.232101] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}923machine # [ 11.236203] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply924machine # [ 11.239170] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client925machine # [ 11.243377] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}926machine # [ 11.248306] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply927machine # [ 11.251537] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown928machine # [ 11.254919] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."929machine # [ 11.261091] systemd-timesyncd[350]: Resolving fake.ntp...930machine # [ 11.263827] systemd-timesyncd[350]: varlink: Setting state idle-client931machine # [ 11.268141] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}932machine # [ 11.272470] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply933machine # [ 11.276428] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client934machine # [ 11.280516] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"error":"io.systemd.Resolve.NetworkDown"}935machine # [ 11.284613] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply936machine # [ 11.291183] systemd-timesyncd[350]: Failed to resolve fake.ntp: io.systemd.Resolve.NetworkDown937machine # [ 11.293446] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."938machine # [ 11.295722] systemd-timesyncd[350]: Delaying attempts to contact servers.939machine # [ 11.297624] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client940machine # [ 11.302064] systemd[1]: Finished Rebuild Journal Catalog.941machine # [ 11.306075] systemd[1]: Starting Update is Completed...942machine # [ 11.342584] systemd[1]: Finished Update is Completed.943machine # [ 11.665616] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.944machine # [ 11.669655] systemd[1]: Finished Create SUID/SGID Wrappers.945machine # [ 11.674282] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse946machine # [ 11.880156] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.947machine # [ 11.955587] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.948machine # [ 12.043496] systemd[1]: Finished register-nix-paths.service.949machine # [ 12.046748] systemd[1]: Reached target System Initialization.950machine # [ 12.051204] systemd[1]: Started Discard unused filesystem blocks once a week.951machine # [ 12.055255] systemd[1]: Started Daily Cleanup of Temporary Directories.952machine # [ 12.056852] systemd[1]: Reached target Timer Units.953machine # [ 12.059933] systemd[1]: Listening on D-Bus System Message Bus Socket.954machine # [ 12.061532] systemd[1]: Listening on Nix Daemon Socket.955machine # [ 12.063513] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.956machine # [ 12.067233] systemd[1]: Reached target Socket Units.957machine # [ 12.068736] systemd[1]: Reached target Basic System.958machine # [ 12.072263] systemd-timesyncd[350]: Got inotify event on bus bus-api-timesync.959machine # [ 12.075388] systemd-timesyncd[350]: sd-bus: starting bus bus-api-timesync by connecting to /run/dbus/system_bus_socket...960machine # [ 12.079264] systemd-timesyncd[350]: Bus bus-api-timesync: changing state WATCH_BIND → AUTHENTICATING961machine # [ 12.082189] systemd-timesyncd[350]: Network configuration changed, trying to establish connection.962machine # [ 12.084571] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."963machine # [ 12.087813] systemd-timesyncd[350]: Delaying attempts to contact servers.964machine # [ 12.090265] systemd[1]: Started backdoor.service.965machine # [ 12.094110] (udev-worker)[444]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.966machine # [ 12.102571] (udev-worker)[444]: Network interface NamePolicy= disabled on kernel command line.967machine # [ 12.105485] (udev-worker)[436]: Network interface NamePolicy= disabled on kernel command line.968machine # [ 12.112478] systemd[1]: Starting DHCP Client...969machine # [ 12.127096] systemd[1]: Starting Import lastlog data into lastlog2 database...970machine # [ 12.144160] systemd[1]: Starting Name Service Cache Daemon (nsncd)...971machine # [ 12.178484] systemd[1]: Starting Post-Boot Actions...972machine # [ 12.215159] systemd[1]: Started Reset console on configuration changes.973machine # connecting to host...974machine # [ 12.310840] systemd[1]: Starting D-Bus System Message Bus...975machine: Guest shell says: b'Spawning backdoor root shell...\n'976machine: connected to guest root shell977machine: (connecting took 13.64 seconds)978machine: (finished: waiting for the VM to finish booting, in 13.96 seconds)979machine # [ 12.393195] systemd[1]: Finished Post-Boot Actions.980machine # [ 12.397607] nsncd[502]: Sep 03 22:17:17.383 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"981machine # [ 12.413863] systemd[1]: Finished Firewall.982machine # [ 12.416565] systemd[1]: Started Name Service Cache Daemon (nsncd).983machine # [ 12.453813] systemd-timesyncd[350]: Network configuration changed, trying to establish connection.984machine # [ 12.455784] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."985machine # [ 12.460072] systemd-timesyncd[350]: Delaying attempts to contact servers.986machine # [ 12.473241] systemd[1]: Reached target Preparation for Network.987machine # [ 12.474671] systemd[1]: Reached target Network.988machine # [ 12.475789] systemd[1]: Reached target Host and Network Name Lookups.989machine # [ 12.477254] systemd[1]: Reached target User and Group Name Lookups.990machine # [ 12.508131] systemd[1]: Starting User Login Management...991machine # [ 12.518916] systemd[1]: Starting Permit User Sessions...992machine # [ 12.537244] systemd[1]: Starting djbdns tinydns server...993machine # [ 12.545604] systemd[1]: Finished Import lastlog data into lastlog2 database.994machine # [ 12.571153] systemd-timesyncd[350]: Network configuration changed, trying to establish connection.995machine # [ 12.574429] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."996machine # [ 12.580321] systemd-timesyncd[350]: Delaying attempts to contact servers.997machine # [ 12.669460] systemd[1]: Finished Permit User Sessions.998machine # [ 12.672226] systemd[1]: Started D-Bus System Message Bus.999machine # [ 12.688200] systemd[1]: Condition check resulted in Virtio network device being skipped.1000machine # [ 12.716391] systemd[1]: Started Getty on tty1.1001machine # [ 12.717584] systemd[1]: Reached target Login Prompts.1002machine # [ 12.734696] systemd[1]: Starting Address configuration of eth1...1003machine # [ 12.762731] systemd-timesyncd[350]: Bus bus-api-timesync: changing state AUTHENTICATING → HELLO1004machine # [ 12.765616] systemd-timesyncd[350]: Sent message type=method_call sender=n/a destination=org.freedesktop.DBus path=/org/freedesktop/DBus interface=org.freedesktop.DBus member=Hello cookie=1 reply_cookie=0 signature=n/a error-name=n/a error-message=n/a1005machine # [ 12.772211] systemd-timesyncd[350]: Sent message type=method_call sender=n/a destination=org.freedesktop.DBus path=/org/freedesktop/DBus interface=org.freedesktop.DBus member=RequestName cookie=2 reply_cookie=0 signature=su error-name=n/a error-message=n/a1006machine # [ 12.778470] dbus-broker-launch[519]: Ready1007machine # [ 12.783858] systemd-timesyncd[350]: Got message type=method_return sender=org.freedesktop.DBus destination=:1.1 path=n/a interface=n/a member=n/a cookie=4294967295 reply_cookie=1 signature=s error-name=n/a error-message=n/a1008machine # [ 12.790310] systemd-timesyncd[350]: Bus bus-api-timesync: changing state HELLO → RUNNING1009machine # [ 12.794360] systemd-timesyncd[350]: Got message type=signal sender=org.freedesktop.DBus.Local destination=n/a path=/org/freedesktop/DBus/Local interface=org.freedesktop.DBus.Local member=Connected cookie=4294967295 reply_cookie=0 signature=n/a error-name=n/a error-message=n/a1010machine # [ 12.799690] systemd-timesyncd[350]: Got message type=signal sender=org.freedesktop.DBus destination=:1.1 path=/org/freedesktop/DBus interface=org.freedesktop.DBus member=NameAcquired cookie=4294967295 reply_cookie=0 signature=s error-name=n/a error-message=n/a1011machine # [ 12.806212] systemd-timesyncd[350]: Got message type=signal sender=org.freedesktop.DBus destination=:1.1 path=/org/freedesktop/DBus interface=org.freedesktop.DBus member=NameAcquired cookie=4294967295 reply_cookie=0 signature=s error-name=n/a error-message=n/a1012machine # [ 12.812961] systemd-timesyncd[350]: Got message type=method_return sender=org.freedesktop.DBus destination=:1.1 path=n/a interface=n/a member=n/a cookie=4294967295 reply_cookie=2 signature=u error-name=n/a error-message=n/a1013machine # [ 12.818137] systemd-timesyncd[350]: Successfully acquired requested service name.1014machine # [ 12.835135] systemd-timesyncd[350]: Network configuration changed, trying to establish connection.1015machine # [ 12.837140] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."1016machine # [ 12.839384] systemd-timesyncd[350]: Delaying attempts to contact servers.1017machine # [ 12.894492] systemd[1]: Started djbdns tinydns server.1018machine # [ 12.933686] systemd-logind[546]: New seat seat0.1019machine # [ 12.941528] systemd-timesyncd[350]: Network configuration changed, trying to establish connection.1020machine # [ 12.943947] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."1021machine # [ 12.946256] systemd-timesyncd[350]: Delaying attempts to contact servers.1022machine # [ 12.951324] systemd[1]: Started User Login Management.1023machine # [ 12.965799] systemd[1]: Starting linger-users.service...1024machine # [ 13.044537] run[569]: starting tinydns1025machine # [ 13.052576] network-addresses-eth1-start[562]: adding address 192.168.1.1/24... done1026machine # [ 13.068235] systemd[1]: linger-users.service: Deactivated successfully.1027machine # [ 13.071172] systemd[1]: Finished linger-users.service.1028machine # [ 13.080855] network-addresses-eth1-start[562]: adding address 2001:db8:1::1/64... done1029machine # [ 13.094355] dhcpcd[526]: dhcpcd-10.3.2 starting1030machine # [ 13.107914] dhcpcd[583]: dev: loaded udev1031machine # [ 13.111397] systemd[1]: Finished Address configuration of eth1.1032machine # [ 13.409527] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console1033machine # [ 13.411122] 8021q: 802.1Q VLAN Support v1.81034machine # [ 13.412208] 8021q: adding VLAN 0 to HW filter on device eth11035machine # [ 13.424009] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input31036machine # [ 13.377219] systemd-resolved[315]: Clock change detected. Flushing caches.1037machine # [ 13.477456] mousedev: PS/2 mouse device common for all mice1038machine # [ 13.484276] ACPI: button: Power Button [PWRF]1039machine # [ 13.635206] rtc_cmos 00:04: RTC can wake from S41040machine # [ 13.640070] cfg80211: Loading compiled-in X.509 certificates for regulatory database1041machine # [ 13.646334] rtc_cmos 00:04: registered as rtc01042machine # [ 13.646908] rtc_cmos 00:04: setting system clock to 2026-09-03T22:17:18 UTC (1788473838)1043machine # [ 13.647044] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs1044machine # [ 13.657310] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input41045machine # [ 13.659365] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized1046machine # [ 13.664212] parport_pc 00:02: reported by Plug and Play ACPI1047machine # [ 13.664325] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]1048machine # [ 13.681125] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1049machine # [ 13.681344] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1050machine # [ 13.682751] Console: switching to colour dummy device 80x251051machine # [ 13.685744] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21052machine # [ 13.685759] cfg80211: failed to load regulatory.db1053machine # [ 13.730655] [drm] Found bochs VGA, ID 0xb0c5.1054machine # [ 13.743953] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.1055machine # [ 13.476402] dhcpcd[595]: Dropped protocol specifier '.link' from 'eth0.link'. Using 'eth0' (ifindex=2).1056machine # [ 13.480243] dhcpcd[595]: Failed to revert interface configuration: Access denied1057machine # [ 13.753126] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic1058machine # [ 13.755279] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 01059machine # [ 13.761665] 8021q: adding VLAN 0 to HW filter on device eth01060machine # [ 13.493123] dhcpcd[583]: eth0: waiting for carrier1061machine # [ 13.494400] dhcpcd[583]: eth0: carrier acquired1062machine # [ 13.781773] Console: switching to colour frame buffer device 160x501063machine # [ 13.786947] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device1064machine # [ 13.520593] dhcpcd[583]: DUID 00:01:00:01:32:2c:ae:6e:52:54:00:12:34:561065machine # [ 13.522565] dhcpcd[583]: eth0: IAID 00:12:34:561066machine # [ 13.524852] dhcpcd[583]: eth0: adding address fe80::5054:ff:fe12:34561067machine # [ 13.934836] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt1068machine # [ 13.940627] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD1069machine # [ 13.682880] dhcpcd[583]: eth0: soliciting a DHCP lease1070machine # [ 13.985118] NET: Registered PF_PACKET protocol family1071machine # [ 13.727734] dhcpcd[583]: eth0: offered 10.0.2.15 from 10.0.2.21072machine # [ 13.730353] dhcpcd[583]: eth0: probing address 10.0.2.15/241073machine: (finished: waiting for unit tinydns.service, in 15.37 seconds)1074machine: waiting for unit systemd-timesyncd.service1075machine # [ 14.087113] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input61076machine # [ 14.089194] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input51077machine # [ 13.885896] systemd[1]: Starting Virtual Console Setup...1078machine: (finished: waiting for unit systemd-timesyncd.service, in 0.12 seconds)1079machine: must fail: resolvectl query fake.ntp1080machine # [ 13.931609] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1081machine # [ 13.963383] run[569]: 7f000001:e15c:f95c + 001c fake.ntp1082machine # [ 13.968654] run[569]: 7f000001:9bfe:0d7b + 0001 fake.ntp1083machine # [ 13.970506] run[569]: 7f000001:b8e1:fcc6 + 002b ntp1084machine # [ 13.972336] run[569]: 7f000001:eb3f:6882 + 002b fake.ntp1085machine # fake.ntp: resolve call failed: DNSSEC validation failed: no-signature1086machine # [ 13.976291] systemd-resolved[315]: DNSSEC validation failed for question ntp IN DS: no-signature1087machine # [ 13.978988] systemd-resolved[315]: DNSSEC validation failed for question fake.ntp IN AAAA: no-signature1088machine # [ 13.982573] systemd-resolved[315]: DNSSEC validation failed for question fake.ntp IN DS: no-signature1089machine # [ 13.986183] systemd-resolved[315]: DNSSEC validation failed for question fake.ntp IN A: no-signature1090machine: (finished: must fail: resolvectl query fake.ntp, in 0.09 seconds)1091machine: waiting for success: journalctl -u systemd-timesyncd.service --grep='Resolved address 192.0.2.1:123 for fake.ntp'1092machine # [ 14.040946] systemd-logind[546]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)1093machine # [ 14.062088] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1094machine # [ 14.065828] systemd[1]: Stopped Virtual Console Setup.1095machine # [ 14.078836] systemd-logind[546]: Watching system buttons on /dev/input/event2 (Power Button)1096machine # [ 14.097700] systemd[1]: Starting Virtual Console Setup...1097machine # [ 14.459375] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)1098machine # [ 14.502426] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)1099machine # [ 14.235544] systemd-logind[546]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1100machine # [ 14.515853] ppdev: user-space parallel port driver1101machine # [ 14.307824] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1102machine # [ 14.311758] systemd[1]: Stopped Virtual Console Setup.1103machine # [ 14.324707] systemd[1]: Starting Virtual Console Setup...1104machine # [ 14.771279] kvm_amd: TSC scaling supported1105machine # [ 14.777083] kvm_amd: Nested Virtualization enabled1106machine # [ 14.778963] kvm_amd: Nested Paging enabled1107machine # [ 14.781082] kvm_amd: LBR virtualization supported1108machine # [ 14.782731] kvm_amd: Virtual VMLOAD VMSAVE supported1109machine # [ 14.784260] kvm_amd: Virtual GIF supported1110machine # [ 14.785713] kvm_amd: Virtual NMI enabled1111machine # [ 14.837964] EDAC MC: Ver: 3.0.01112machine # [ 14.812759] systemd-vconsole-setup[634]: Configuration of first virtual console was skipped, ignoring remaining ones.1113machine # [ 14.820052] systemd[1]: Finished Virtual Console Setup.1114machine # [ 16.381702] dhcpcd[583]: eth0: soliciting an IPv6 router1115machine # [ 16.384646] dhcpcd[583]: eth0: Router Advertisement from fe80::21116machine # [ 16.386115] dhcpcd[583]: eth0: adding address fec0::5054:ff:fe12:3456/641117machine # [ 16.388360] dhcpcd[583]: eth0: adding route to fec0::/641118machine # [ 16.389935] dhcpcd[583]: eth0: adding default route via fe80::21119machine # [ 17.726448] dhcpcd[652]: Dropped protocol specifier '.ra' from 'eth0.ra'. Using 'eth0' (ifindex=2).1120machine # [ 17.731394] dhcpcd[652]: Failed to revert interface configuration: Access denied1121machine # [ 18.530730] dhcpcd[583]: eth0: leased 10.0.2.15 for 86400 seconds1122machine # [ 18.533677] dhcpcd[583]: eth0: adding route to 10.0.2.0/241123machine # [ 18.535513] dhcpcd[583]: eth0: adding default route via 10.0.2.21124machine # [ 18.552792] dhcpcd[660]: Dropped protocol specifier '.dhcp' from 'eth0.dhcp'. Using 'eth0' (ifindex=2).1125machine # [ 18.556056] dhcpcd[660]: Failed to set DNS configuration: Access denied1126machine # [ 18.562779] systemd[1]: Started DHCP Client.1127machine # [ 18.566525] systemd[1]: Reached target Multi-User System.1128machine # [ 18.568398] systemd[1]: Startup finished in 1.380s (kernel) + 5.647s (initrd) + 11.540s (userspace) = 18.567s.1129machine # [ 43.134187] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."1130machine # [ 43.136682] systemd-timesyncd[350]: Resolving fake.ntp...1131machine # [ 43.138896] systemd-timesyncd[350]: varlink: Setting state idle-client1132machine # [ 43.141140] systemd-timesyncd[350]: timesyncd-resolve: Sending message: {"method":"io.systemd.Resolve.ResolveHostname","parameters":{"name":"fake.ntp","flags":1024}}1133machine # [ 43.145421] run[569]: 7f000001:9ec1:b55d + 0001 fake.ntp1134machine # [ 43.147718] run[569]: 7f000001:d223:437e + 001c fake.ntp1135machine # [ 43.149403] systemd-timesyncd[350]: timesyncd-resolve: Changing state idle-client → awaiting-reply1136machine # [ 43.151705] systemd-timesyncd[350]: timesyncd-resolve: Received message: {"parameters":{"addresses":[{"family":2,"address":[192,0,2,1]}],"name":"fake.ntp","flags":8388609}}1137machine # [ 43.156293] systemd-timesyncd[350]: timesyncd-resolve: Changing state awaiting-reply → processing-reply1138machine # [ 43.159497] systemd-timesyncd[350]: Resolved address 192.0.2.1:123 for fake.ntp.1139machine # [ 43.162117] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Idle."1140machine # [ 43.165139] systemd-timesyncd[350]: Selected address 192.0.2.1:123 of server fake.ntp.1141machine # [ 43.167636] systemd-timesyncd[350]: Connecting to time server 192.0.2.1:123 (fake.ntp).1142machine # [ 43.170166] systemd-timesyncd[350]: Notify message sent to '/run/systemd/notify': "STATUS=Connecting to time server 192.0.2.1:123 (fake.ntp)."1143machine # [ 43.174046] systemd-timesyncd[350]: Sent NTP request to 192.0.2.1:123 (fake.ntp).1144machine # [ 43.176659] systemd-timesyncd[350]: timesyncd-resolve: Changing state processing-reply → idle-client1145machine: (finished: waiting for success: journalctl -u systemd-timesyncd.service --grep='Resolved address 192.0.2.1:123 for fake.ntp', in 29.32 seconds)1146(finished: run the VM test script, in 44.90 seconds)1147test script finished in 44.95s1148cleanup1149kill QemuMachine (pid 45)1150machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)1151(finished: cleanup, in 0.21 seconds)1152additionally exposed symbols:1153 machine,1154 vlan1,1155 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