vm-test-run-switch-test-basics
checks.x86_64-linux.switchTest-basics
· build #25
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.drqPn9t8Va', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 379e65fd-cc6e-4c57-8525-7b379362b01f17machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # 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)... ok[ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Sep 2 12:31:51 UTC 202641machine # [ 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/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/init regInfo=/nix/store/9005q1pah96a2c1kbvmwzpa974lazhxh-closure-info/registration console=ttyS0,115200n8 console=tty042machine # [ 0.000000] BIOS-provided physical RAM map:43machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable44machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved45machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved46machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable47machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved48machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved49machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved50machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved51machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved52machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved53machine # [ 0.000000] NX (Execute Disable) protection: active54machine # [ 0.000000] APIC: Static calls initialized55machine # [ 0.000000] SMBIOS 2.8 present.56machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201457machine # [ 0.000000] DMI: Memory slots populated: 1/158machine # [ 0.000000] Hypervisor detected: KVM59machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000060machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0061machine # [ 0.000000] kvm-clock: using sched offset of 478938346 cycles62machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns63machine # [ 0.000005] tsc: Detected 2400.012 MHz processor64machine # [ 0.000803] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000065machine # [ 0.000830] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs66machine # [ 0.000832] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT67machine # [ 0.002724] found SMP MP-table at [mem 0x000f5450-0x000f545f]68machine # [ 0.002736] Using GB pages for direct mapping69machine # [ 0.002797] RAMDISK: [mem 0x3e42b000-0x3ffcffff]70machine # [ 0.002805] ACPI: Early table checksum verification disabled71machine # [ 0.002808] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )72machine # [ 0.002813] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)73machine # [ 0.002817] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)74machine # [ 0.002824] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)75machine # [ 0.002826] ACPI: FACS 0x000000003FFE0000 00004076machine # [ 0.002827] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)77machine # [ 0.002829] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)78machine # [ 0.002830] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)79machine # [ 0.002832] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)80machine # [ 0.002833] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]81machine # [ 0.002834] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]82machine # [ 0.002835] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]83machine # [ 0.002835] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]84machine # [ 0.002836] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]85machine # [ 0.002836] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]86machine # [ 0.002837] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]87machine # [ 0.003066] No NUMA configuration found88machine # [ 0.003067] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]89machine # [ 0.003070] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]90machine # [ 0.005403] Zone ranges:91machine # [ 0.005404] DMA [mem 0x0000000000001000-0x0000000000ffffff]92machine # [ 0.005406] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]93machine # [ 0.005407] Normal empty94machine # [ 0.005408] Device empty95machine # [ 0.005409] Movable zone start for each node96machine # [ 0.005410] Early memory node ranges97machine # [ 0.005410] node 0: [mem 0x0000000000001000-0x000000000009efff]98machine # [ 0.005411] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]99machine # [ 0.005412] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]100machine # [ 0.005432] On node 0, zone DMA: 1 pages in unavailable ranges101machine # [ 0.005706] On node 0, zone DMA: 97 pages in unavailable ranges102machine # [ 0.024026] On node 0, zone DMA32: 40 pages in unavailable ranges103machine # [ 0.024476] ACPI: PM-Timer IO Port: 0x608104machine # [ 0.024487] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])105machine # [ 0.024518] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23106machine # [ 0.024521] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)107machine # [ 0.024523] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)108machine # [ 0.024524] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)109machine # [ 0.024525] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)110machine # [ 0.024526] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)111machine # [ 0.024528] ACPI: Using ACPI (MADT) for SMP configuration information112machine # [ 0.024529] ACPI: HPET id: 0x8086a201 base: 0xfed00000113machine # [ 0.024532] TSC deadline timer available114machine # [ 0.024537] CPU topo: Max. logical packages: 1115machine # [ 0.024537] CPU topo: Max. logical dies: 1116machine # [ 0.024538] CPU topo: Max. dies per package: 1117machine # [ 0.024541] CPU topo: Max. threads per core: 1118machine # [ 0.024542] CPU topo: Num. cores per package: 1119machine # [ 0.024542] CPU topo: Num. threads per package: 1120machine # [ 0.024542] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs121machine # [ 0.024560] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()122machine # [ 0.024590] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]123machine # [ 0.024592] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]124machine # [ 0.024593] [mem 0x40000000-0xafffffff] available for PCI devices125machine # [ 0.024595] Booting paravirtualized kernel on KVM126machine # [ 0.024597] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns127machine # [ 0.029056] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1128machine # [ 0.031541] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152129machine # [ 0.031587] kvm-guest: PV spinlocks disabled, single CPU130machine # [ 0.031589] 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/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/init regInfo=/nix/store/9005q1pah96a2c1kbvmwzpa974lazhxh-closure-info/registration console=ttyS0,115200n8 console=tty0131machine # [ 0.031684] Unknown kernel command line parameters "regInfo=/nix/store/9005q1pah96a2c1kbvmwzpa974lazhxh-closure-info/registration", will be passed to user space.132machine # [ 0.031697] random: crng init done133machine # [ 0.031697] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes134machine # [ 0.031719] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)135machine # [ 0.031731] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)136machine # [ 0.031761] Fallback order for Node 0: 0137machine # [ 0.031764] Built 1 zonelists, mobility grouping on. Total pages: 262006138machine # [ 0.031765] Policy zone: DMA32139machine # [ 0.034304] mem auto-init: stack:all(zero), heap alloc:on, heap free:off140machine # [ 0.036849] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1141machine # [ 0.039168] allocated 2097152 bytes of page_ext142machine # [ 0.049085] ftrace: allocating 48732 entries in 192 pages143machine # [ 0.049087] ftrace: allocated 192 pages with 2 groups144machine # [ 0.049978] Dynamic Preempt: lazy145machine # [ 0.050156] rcu: Preemptible hierarchical RCU implementation.146machine # [ 0.050157] rcu: RCU event tracing is enabled.147machine # [ 0.050157] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.148machine # [ 0.050159] Trampoline variant of Tasks RCU enabled.149machine # [ 0.050160] Rude variant of Tasks RCU enabled.150machine # [ 0.050160] Tracing variant of Tasks RCU enabled.151machine # [ 0.050161] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.152machine # [ 0.050161] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1153machine # [ 0.050176] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.154machine # [ 0.050178] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.155machine # [ 0.050179] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.156machine # [ 0.054560] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16157machine # [ 0.054852] rcu: srcu_init: Setting srcu_struct sizes based on contention.158machine # [ 0.054860] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns159machine # [ 0.054972] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)160machine # [ 0.058455] Console: colour VGA+ 80x25161machine # [ 0.058458] printk: legacy console [tty0] enabled162machine # [ 0.087459] printk: legacy console [ttyS0] enabled163machine # [ 0.193015] ACPI: Core revision 20250807164machine # [ 0.193921] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns165machine # [ 0.195493] APIC: Switch to symmetric I/O mode setup166machine # [ 0.196482] x2apic enabled167machine # [ 0.197268] APIC: Switched APIC routing to: physical x2apic168machine # [ 0.199084] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1169machine # [ 0.200119] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns170machine # [ 0.201885] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)171machine # [ 0.202969] x86/cpu: User Mode Instruction Prevention (UMIP) activated172machine # [ 0.205017] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127173machine # [ 0.205881] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0174machine # [ 0.206885] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto175machine # [ 0.207882] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl176machine # [ 0.209882] Transient Scheduler Attacks: Vulnerable: No microcode177machine # [ 0.210881] Spectre V2 : Mitigation: Enhanced / Automatic IBRS178machine # [ 0.211881] Speculative Return Stack Overflow: Mitigation: Safe RET179machine # [ 0.212881] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization180machine # [ 0.214890] Spectre V2 : Enabling IBPB for BPF181machine # [ 0.215882] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier182machine # [ 0.216882] active return thunk: srso_alias_return_thunk183machine # [ 0.217903] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'184machine # [ 0.218881] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'185machine # [ 0.220694] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'186machine # [ 0.221696] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'187machine # [ 0.222881] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'188machine # [ 0.223881] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'189machine # [ 0.224881] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'190machine # [ 0.225882] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256191machine # [ 0.226881] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64192machine # [ 0.227882] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512193machine # [ 0.228881] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024194machine # [ 0.229881] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8195machine # [ 0.230881] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.196machine # [ 0.265827] Freeing SMP alternatives memory: 44K197machine # [ 0.266461] pid_max: default: 32768 minimum: 301198machine # [ 0.266977] LSM: initializing lsm=capability,landlock,yama,bpf,ima199machine # [ 0.267981] landlock: Up and running.200machine # [ 0.269363] Yama: becoming mindful.201machine # [ 0.270101] LSM support for eBPF active202machine # [ 0.270969] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)203machine # [ 0.271902] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)204machine # [ 0.274986] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)205machine # [ 0.276451] Performance Events: Fam17h+ core perfctr, AMD PMU driver.206machine # [ 0.276890] ... version: 2207machine # [ 0.277628] ... bit width: 48208machine # [ 0.277884] ... generic counters: 6209machine # [ 0.278648] ... generic bitmap: 000000000000003f210machine # [ 0.278884] ... fixed-purpose counters: 0211machine # [ 0.279629] ... fixed-purpose bitmap: 0000000000000000212machine # [ 0.279884] ... value mask: 0000ffffffffffff213machine # [ 0.280819] ... max period: 00007fffffffffff214machine # [ 0.281620] ... global_ctrl mask: 000000000000003f215machine # [ 0.281980] signal: max sigframe size: 3376216machine # [ 0.282789] rcu: Hierarchical SRCU implementation.217machine # [ 0.283476] rcu: Max phase no-delay instances is 400.218machine # [ 0.288424] smp: Bringing up secondary CPUs ...219machine # [ 0.288896] smp: Brought up 1 node, 1 CPU220machine # [ 0.289589] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)221machine # [ 0.290045] Memory: 941796K/1048024K available (17215K kernel code, 2726K rwdata, 13584K rodata, 3644K init, 2988K bss, 98832K reserved, 0K cma-reserved)222machine # [ 0.291128] devtmpfs: initialized223machine # [ 0.291989] x86/mm: Memory block size: 128MB224machine # [ 0.293756] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)225machine # [ 0.294837] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).226machine # [ 0.295965] pinctrl core: initialized pinctrl subsystem227machine # [ 0.297136] PM: RTC time: 22:53:10, date: 2026-09-06228machine # [ 0.300713] NET: Registered PF_NETLINK/PF_ROUTE protocol family229machine # [ 0.302033] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations230machine # [ 0.302905] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations231machine # [ 0.304038] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations232machine # [ 0.304893] audit: initializing netlink subsys (disabled)233machine # [ 0.306042] thermal_sys: Registered thermal governor 'fair_share'234machine # [ 0.306044] thermal_sys: Registered thermal governor 'bang_bang'235machine # [ 0.306884] thermal_sys: Registered thermal governor 'step_wise'236machine # [ 0.307888] audit: type=2000 audit(1788735191.408:1): state=initialized audit_enabled=0 res=1237machine # [ 0.309887] thermal_sys: Registered thermal governor 'user_space'238machine # [ 0.309888] thermal_sys: Registered thermal governor 'power_allocator'239machine # [ 0.310896] cpuidle: using governor menu240machine # [ 0.313129] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5241machine # [ 0.314211] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]242machine # [ 0.314887] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry243machine # [ 0.315896] PCI: Using configuration type 1 for base access244machine # [ 0.317040] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.245machine # [ 0.322139] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages246machine # [ 0.322885] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page247machine # [ 0.327885] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages248machine # [ 0.328883] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page249machine # [ 0.339244] ACPI: Added _OSI(Module Device)250machine # [ 0.339886] ACPI: Added _OSI(Processor Device)251machine # [ 0.340653] ACPI: Added _OSI(Processor Aggregator Device)252machine # [ 0.349500] ACPI: 1 ACPI AML tables successfully acquired and loaded253machine # [ 0.353313] ACPI: Interpreter enabled254machine # [ 0.353900] ACPI: PM: (supports S0 S3 S4 S5)255machine # [ 0.354626] ACPI: Using IOAPIC for interrupt routing256machine # [ 0.354937] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug257machine # [ 0.355884] PCI: Using E820 reservations for host bridge windows258machine # [ 0.359024] ACPI: Enabled 2 GPEs in block 00 to 3F259machine # [ 0.367730] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])260machine # [ 0.368709] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]261machine # [ 0.370406] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]262machine # [ 0.371015] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]263machine # [ 0.372229] PCI host bridge to bus 0000:00264machine # [ 0.372887] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]265machine # [ 0.373884] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]266machine # [ 0.374884] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]267machine # [ 0.375884] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]268machine # [ 0.376884] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]269machine # [ 0.377884] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]270machine # [ 0.378885] pci_bus 0000:00: root bus resource [bus 00-ff]271machine # [ 0.379896] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint272machine # [ 0.381328] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint273machine # [ 0.383962] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]274machine # [ 0.384896] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]275machine # [ 0.385905] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]276machine # [ 0.387196] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]277machine # [ 0.388585] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint278machine # [ 0.391918] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]279machine # [ 0.392781] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]280machine # [ 0.393666] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]281machine # [ 0.394787] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]282machine # [ 0.396235] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint283machine # [ 0.398757] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]284machine # [ 0.399584] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]285machine # [ 0.399905] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]286machine # [ 0.401436] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287machine # [ 0.404765] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]288machine # [ 0.405505] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]289machine # [ 0.405905] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]290machine # [ 0.407460] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291machine # [ 0.408915] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]292machine # [ 0.409813] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]293machine # [ 0.410695] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]294machine # [ 0.412313] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint295machine # [ 0.414916] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]296machine # [ 0.415824] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]297machine # [ 0.416689] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]298machine # [ 0.418352] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint299machine # [ 0.420916] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]300machine # [ 0.421891] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]301machine # [ 0.422901] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]302machine # [ 0.424539] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint303machine # [ 0.425913] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]304machine # [ 0.426824] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]305machine # [ 0.427683] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]306machine # [ 0.428810] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]307machine # [ 0.430481] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint308machine # [ 0.431896] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]309machine # [ 0.432889] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]310machine # [ 0.434413] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint311machine # [ 0.436533] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]312machine # [ 0.436891] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]313machine # [ 0.437906] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]314machine # [ 0.439445] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint315machine # [ 0.440891] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]316machine # [ 0.441754] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]317machine # [ 0.442696] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]318machine # [ 0.444365] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint319machine # [ 0.445557] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]320machine # [ 0.446104] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint321machine # [ 0.447509] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]322machine # [ 0.448072] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint323machine # [ 0.450550] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]324machine # [ 0.451114] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint325machine # [ 0.452459] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]326machine # [ 0.453154] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint327machine # [ 0.454169] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO328machine # [ 0.455136] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint329machine # [ 0.456896] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]330machine # [ 0.457788] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]331machine # [ 0.458969] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint332machine # [ 0.460547] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]333machine # [ 0.463817] ACPI: PCI: Interrupt link LNKA configured for IRQ 10334machine # [ 0.464784] ACPI: PCI: Interrupt link LNKB configured for IRQ 10335machine # [ 0.465767] ACPI: PCI: Interrupt link LNKC configured for IRQ 11336machine # [ 0.466777] ACPI: PCI: Interrupt link LNKD configured for IRQ 11337machine # [ 0.467774] ACPI: PCI: Interrupt link LNKE configured for IRQ 10338machine # [ 0.468748] ACPI: PCI: Interrupt link LNKF configured for IRQ 10339machine # [ 0.469783] ACPI: PCI: Interrupt link LNKG configured for IRQ 11340machine # [ 0.470783] ACPI: PCI: Interrupt link LNKH configured for IRQ 11341machine # [ 0.471693] ACPI: PCI: Interrupt link GSIA configured for IRQ 16342machine # [ 0.472689] ACPI: PCI: Interrupt link GSIB configured for IRQ 17343machine # [ 0.473689] ACPI: PCI: Interrupt link GSIC configured for IRQ 18344machine # [ 0.474701] ACPI: PCI: Interrupt link GSID configured for IRQ 19345machine # [ 0.475690] ACPI: PCI: Interrupt link GSIE configured for IRQ 20346machine # [ 0.476689] ACPI: PCI: Interrupt link GSIF configured for IRQ 21347machine # [ 0.477810] ACPI: PCI: Interrupt link GSIG configured for IRQ 22348machine # [ 0.478714] ACPI: PCI: Interrupt link GSIH configured for IRQ 23349machine # [ 0.480685] iommu: Default domain type: Translated350machine # [ 0.481488] iommu: DMA domain TLB invalidation policy: lazy mode351machine # [ 0.482168] ACPI: bus type USB registered352machine # [ 0.482947] usbcore: registered new interface driver usbfs353machine # [ 0.483869] usbcore: registered new interface driver hub354machine # [ 0.484599] usbcore: registered new device driver usb355machine # [ 0.485991] NetLabel: Initializing356machine # [ 0.486660] NetLabel: domain hash size = 128357machine # [ 0.486884] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO358machine # [ 0.487867] NetLabel: unlabeled traffic allowed by default359machine # [ 0.488599] PCI: Using ACPI for IRQ routing360machine # [ 0.531410] pci 0000:00:01.0: vgaarb: setting as boot VGA device361machine # [ 0.531880] pci 0000:00:01.0: vgaarb: bridge control possible362machine # [ 0.531880] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none363machine # [ 0.531888] vgaarb: loaded364machine # [ 0.532654] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0365machine # [ 0.532886] hpet0: 3 comparators, 64-bit 100.000000 MHz counter366machine # [ 0.537979] clocksource: Switched to clocksource kvm-clock367machine # [ 0.541536] VFS: Disk quotas dquot_6.6.0368machine # [ 0.542247] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)369machine # [ 0.543635] pnp: PnP ACPI init370machine # [ 0.544436] ACPI: IRQ 4 override to edge(!), high(!)371machine # [ 0.545425] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved372machine # [ 0.547034] pnp: PnP ACPI: found 6 devices373machine # [ 0.554650] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns374machine # [ 0.556147] clocksource: Switched to clocksource acpi_pm375machine # [ 0.557142] NET: Registered PF_INET protocol family376machine # [ 0.558218] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)377machine # [ 0.575238] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)378machine # [ 0.576788] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)379machine # [ 0.578136] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)380machine # [ 0.579473] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)381machine # [ 0.580723] TCP: Hash tables configured (established 8192 bind 8192)382machine # [ 0.581850] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)383machine # [ 0.583170] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)384machine # [ 0.584314] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)385machine # [ 0.585526] NET: Registered PF_UNIX/PF_LOCAL protocol family386machine # [ 0.586511] NET: Registered PF_XDP protocol family387machine # [ 0.587394] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]388machine # [ 0.588426] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]389machine # [ 0.589433] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]390machine # [ 0.590531] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]391machine # [ 0.591640] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]392machine # [ 0.593422] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]393machine # [ 0.595601] ACPI: \_SB_.GSIA: Enabled at IRQ 16394machine # [ 0.597963] ACPI: \_SB_.GSIB: Enabled at IRQ 17395machine # [ 0.600325] ACPI: \_SB_.GSIC: Enabled at IRQ 18396machine # [ 0.602401] ACPI: \_SB_.GSID: Enabled at IRQ 19397machine # [ 0.604126] PCI: CLS 0 bytes, default 64398machine # [ 0.605157] Trying to unpack rootfs image as initramfs...399machine # [ 0.609396] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns400machine # [ 0.650440] Initialise system trusted keyrings401machine # [ 0.651383] workingset: timestamp_bits=40 max_order=18 bucket_order=0402machine # [ 0.675060] Key type asymmetric registered403machine # [ 0.675752] Asymmetric key parser 'x509' registered404machine # [ 0.676550] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)405machine # [ 0.680195] io scheduler mq-deadline registered406machine # [ 0.680931] io scheduler kyber registered407machine # [ 0.684541] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled408machine # [ 0.685816] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A409machine # [ 0.689822] Linux agpgart interface v0.103410machine # [ 0.690649] ACPI: bus type drm_connector registered411machine # [ 0.693610] usbcore: registered new interface driver usbserial_generic412machine # [ 0.694721] usbserial: USB Serial support registered for generic413machine # [ 0.699078] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.414machine # [ 0.699078] Please enable it if your BIOS has the CPPC option.415machine # [ 0.701409] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled416machine # [ 0.704172] drop_monitor: Initializing network drop monitor service417machine # [ 0.705401] NET: Registered PF_INET6 protocol family418machine # [ 0.708506] Segment Routing with IPv6419machine # [ 0.712078] In-situ OAM (IOAM) with IPv6420machine # [ 0.713144] IPI shorthand broadcast: enabled421machine # [ 0.721516] sched_clock: Marking stable (578015865, 143020585)->(793991110, -72954660)422machine # [ 0.725229] registered taskstats version 1423machine # [ 0.726242] Loading compiled-in X.509 certificates424machine # [ 0.747065] Demotion targets for Node 0: null425machine # [ 0.747926] Key type .fscrypt registered426machine # [ 0.749050] Key type fscrypt-provisioning registered427machine # [ 0.750015] ima: No TPM chip found, activating TPM-bypass!428machine # [ 0.750981] ima: Allocated hash algorithm: sha1429machine # [ 0.756074] ima: No architecture policies found430machine # [ 0.757067] PM: Magic number: 10:144:906431machine # [ 0.758770] RAS: Correctable Errors collector initialized.432machine # [ 0.767694] clk: Disabling unused clocks433machine # [ 0.772047] PM: genpd: Disabling unused power domains434machine # [ 0.933350] Freeing initrd memory: 28308K435machine # [ 0.936564] Freeing unused decrypted memory: 2028K436machine # [ 0.939162] Freeing unused kernel image (initmem) memory: 3644K437machine # [ 0.940282] Write protecting the kernel read-only data: 32768k438machine # [ 0.942213] Freeing unused kernel image (text/rodata gap) memory: 1216K439machine # [ 0.943747] Freeing unused kernel image (rodata/data gap) memory: 752K440machine # [ 0.994858] x86/mm: Checked W+X mappings: passed, no W+X pages found.441machine # [ 0.995920] Run /init as init process442machine # [ 1.006363] systemd[1]: Inserted module 'autofs4'443machine # [ 1.022590] fuse: init (API version 7.45)444machine # [ 1.028405] ACPI: \_SB_.GSIG: Enabled at IRQ 22445machine # [ 1.030723] ACPI: \_SB_.GSIH: Enabled at IRQ 23446machine # [ 1.033769] ACPI: \_SB_.GSIE: Enabled at IRQ 20447machine # [ 1.036106] ACPI: \_SB_.GSIF: Enabled at IRQ 21448machine # [ 1.060732] systemd[1]: Successfully made /usr/ read-only.449machine # [ 1.397093] systemd[1]: systemd 262-9457f81 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)450machine # [ 1.408925] systemd[1]: Detected virtualization kvm.451machine # [ 1.411081] systemd[1]: Detected architecture x86-64.452machine # [ 1.413187] systemd[1]: Running in initrd.453machine # [ 1.415594] systemd[1]: Initializing machine ID from random generator.454machine # [ 1.418431] systemd[1]: Hostname set to <machine>.455machine # [ 1.509834] systemd[1]: bpf-restrict-fs: LSM BPF program attached456machine # [ 1.546116] systemd[1]: Queued start job for default target Initrd Default Target.457machine # [ 1.549263] systemd[1]: Created slice Slice /system/modprobe.458machine # [ 1.550446] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459machine # [ 1.551876] systemd[1]: Expecting device /dev/disk/by-label/nixos...460machine # [ 1.553008] systemd[1]: Reached target Path Units.461machine # [ 1.553914] systemd[1]: Reached target Slice Units.462machine # [ 1.554838] systemd[1]: Reached target Swaps.463machine # [ 1.555673] systemd[1]: Reached target Timer Units.464machine # [ 1.556640] systemd[1]: Listening on D-Bus System Message Bus Socket.465machine # [ 1.557923] systemd[1]: Listening on Journal Socket (/dev/log).466machine # [ 1.559153] systemd[1]: Listening on Journal Sockets.467machine # [ 1.560157] systemd[1]: Listening on udev Kernel Socket.468machine # [ 1.561126] systemd[1]: Reached target Socket Units.469machine # [ 1.562852] systemd[1]: Starting Create List of Static Device Nodes...470machine # [ 1.566829] systemd[1]: Starting Load Kernel Module 9pnet_virtio...471machine # [ 1.574223] systemd[1]: Starting Load Kernel Module configfs...472machine # [ 1.588104] systemd[1]: Starting Journal Service...473machine # [ 1.600346] systemd[1]: Starting Load Kernel Modules...474machine # [ 1.608127] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os475machine # [ 1.629594] netfs: FS-Cache loaded476machine # [ 1.636762] 9pnet: Installing 9P2000 support477machine # [ 1.642093] systemd-journald[67]: Collecting audit messages is disabled.478machine # [ 1.651229] systemd[1]: Starting Coldplug All udev Devices...479machine # [ 1.664629] systemd[1]: Finished Create List of Static Device Nodes.480machine # [ 1.671673] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.481machine # [ 1.679405] systemd[1]: Finished Load Kernel Module 9pnet_virtio.482machine # [ 1.685511] systemd[1]: modprobe@configfs.service: Deactivated successfully.483machine # [ 1.692400] systemd[1]: Finished Load Kernel Module configfs.484machine # [ 1.696508] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config485machine # [ 1.701299] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.486machine # [ 1.706677] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev487machine # [ 1.711122] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...488machine # [ 1.737600] systemd[1]: Finished Load Kernel Modules.489machine # [ 1.746220] systemd[1]: Starting Apply Kernel Variables...490machine # [ 1.606901] systemd-modules-load[68]: Inserted module 'dm_mod'491machine # [ 1.610917] systemd-modules-load[68]: Inserted module 'virtio_balloon'492machine # [ 1.611954] systemd-modules-load[68]: Inserted module 'virtio_gpu'493machine # [ 1.757288] systemd[1]: Started Journal Service.494machine # [ 1.620544] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.495machine # [ 1.631264] systemd[1]: Starting Create Static Device Nodes in /dev...496machine # [ 1.640673] systemd[1]: Finished Apply Kernel Variables.497machine # [ 1.652341] systemd[1]: Finished Create Static Device Nodes in /dev.498machine # [ 1.654728] systemd[1]: Reached target Preparation for Local File Systems.499machine # [ 1.656134] systemd[1]: Reached target Local File Systems.500machine # [ 1.659070] systemd[1]: Starting Create System Files and Directories...501machine # [ 1.664078] systemd[1]: Starting Rule-based Manager for Device Events and Files...502machine # [ 1.690341] systemd[1]: Finished Create System Files and Directories.503machine # [ 1.712191] systemd-udevd[83]: Using default interface naming scheme 'v261'.504machine # [ 1.736489] systemd[1]: Started Rule-based Manager for Device Events and Files.505machine # [ 1.784063] systemd[1]: Finished Coldplug All udev Devices.506machine # [ 1.784918] systemd[1]: Reached target System Initialization.507machine # [ 1.785800] systemd[1]: Reached target Basic System.508machine # [ 2.104621] virtio_blk virtio5: 1/0/0 default/read/poll queues509machine # [ 2.116154] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12510machine # [ 2.132810] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)511machine # [ 2.137335] serio: i8042 KBD port at 0x60,0x64 irq 1512machine # [ 2.138013] serio: i8042 AUX port at 0x60,0x64 irq 12513machine # [ 2.144851] ehci-pci 0000:00:1d.7: EHCI Host Controller514machine # [ 2.146275] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1515machine # [ 2.150730] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000516machine # [ 2.157055] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00517machine # [ 2.157919] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18518machine # [ 2.159081] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1519machine # [ 2.162655] usb usb1: Product: EHCI Host Controller520machine # [ 2.165044] usb usb1: Manufacturer: Linux 6.18.49 ehci_hcd521machine # [ 2.165882] usb usb1: SerialNumber: 0000:00:1d.7522machine # [ 2.168199] hub 1-0:1.0: USB hub found523machine # [ 2.169304] hub 1-0:1.0: 6 ports detected524machine # [ 2.172972] uhci_hcd 0000:00:1d.0: UHCI Host Controller525machine # [ 2.173711] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2526machine # [ 2.179723] uhci_hcd 0000:00:1d.0: detected 2 ports527machine # [ 2.182650] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200528machine # [ 2.190698] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18529machine # [ 2.196757] SCSI subsystem initialized530machine # [ 2.200273] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1531machine # [ 2.207346] usb usb2: Product: UHCI Host Controller532machine # [ 2.208001] usb usb2: Manufacturer: Linux 6.18.49 uhci_hcd533machine # [ 2.214913] usb usb2: SerialNumber: 0000:00:1d.0534machine # [ 2.218609] hub 2-0:1.0: USB hub found535machine # [ 2.222737] hub 2-0:1.0: 2 ports detected536machine # [ 2.097077] systemd[1]: Starting Virtual Console Setup...537machine # [ 2.247165] uhci_hcd 0000:00:1d.1: UHCI Host Controller538machine # [ 2.247894] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3539machine # [ 2.106719] (udev-worker)[87]: Network interface NamePolicy= disabled on kernel command line.540machine # [ 2.256572] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0541machine # [ 2.123245] (udev-worker)[89]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.542machine # [ 2.274065] uhci_hcd 0000:00:1d.1: detected 2 ports543machine # [ 2.274841] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220544machine # [ 2.135677] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.545machine # [ 2.138561] (udev-worker)[89]: Network interface NamePolicy= disabled on kernel command line.546machine # [ 2.139672] systemd[1]: Finished Virtual Console Setup.547machine # [ 2.292617] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18548machine # [ 2.293750] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1549machine # [ 2.303059] usb usb3: Product: UHCI Host Controller550machine # [ 2.303758] usb usb3: Manufacturer: Linux 6.18.49 uhci_hcd551machine # [ 2.309696] usb usb3: SerialNumber: 0000:00:1d.1552machine # [ 2.171583] systemd[1]: Found device /dev/disk/by-label/nixos.553machine # [ 2.172546] systemd[1]: Reached target Initrd Root Device.554machine # [ 2.317577] hub 3-0:1.0: USB hub found555machine # [ 2.175425] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...556machine # [ 2.321053] hub 3-0:1.0: 2 ports detected557machine # [ 2.326680] uhci_hcd 0000:00:1d.2: UHCI Host Controller558machine # [ 2.329049] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4559machine # [ 2.338779] uhci_hcd 0000:00:1d.2: detected 2 ports560machine # [ 2.339892] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240561machine # [ 2.341851] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18562machine # [ 2.344054] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1563machine # [ 2.345069] usb usb4: Product: UHCI Host Controller564machine # [ 2.345719] usb usb4: Manufacturer: Linux 6.18.49 uhci_hcd565machine # [ 2.357736] usb usb4: SerialNumber: 0000:00:1d.2566machine # [ 2.359301] hub 4-0:1.0: USB hub found567machine # [ 2.217621] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks568machine # [ 2.363363] hub 4-0:1.0: 2 ports detected569machine # [ 2.222860] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.570machine # [ 2.381364] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode571machine # [ 2.387941] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)572machine # [ 2.390565] ahci 0000:00:1f.2: flags: 64bit ncq only573machine # [ 2.399961] scsi host0: ahci574machine # [ 2.400708] scsi host1: ahci575machine # [ 2.404145] scsi host2: ahci576machine # [ 2.406135] usb 1-1: new high-speed USB device number 2 using ehci-pci577machine # [ 2.407935] scsi host3: ahci578machine # [ 2.411356] scsi host4: ahci579machine # [ 2.415209] scsi host5: ahci580machine # [ 2.415761] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1581machine # [ 2.418057] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1582machine # [ 2.420317] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1583machine # [ 2.422324] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1584machine # [ 2.423459] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1585machine # [ 2.424623] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1586machine # [ 2.536245] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00587machine # [ 2.539074] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10588machine # [ 2.542160] usb 1-1: Product: QEMU USB Tablet589machine # [ 2.543878] usb 1-1: Manufacturer: QEMU590machine # [ 2.545500] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1591machine # [ 2.577957] hid: raw HID events driver (C) Jiri Kosina592machine # [ 2.522425] systemd[1]: Mounting /sysroot...593machine # [ 2.734225] ata5: SATA link down (SStatus 0 SControl 300)594machine # [ 2.736748] ata6: SATA link down (SStatus 0 SControl 300)595machine # [ 2.739329] ata2: SATA link down (SStatus 0 SControl 300)596machine # [ 2.741604] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)597machine # [ 2.743975] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100598machine # [ 2.746098] ata3.00: applying bridge limits599machine # [ 2.747957] ata4: SATA link down (SStatus 0 SControl 300)600machine # [ 2.750405] ata1: SATA link down (SStatus 0 SControl 300)601machine # [ 2.752472] ata3.00: configured for UDMA/100602machine # [ 2.754905] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5603machine # [ 2.816119] usbcore: registered new interface driver usbhid604machine # [ 2.816891] usbhid: USB HID core driver605machine # [ 2.846991] 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 # [ 2.852133] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0607machine # [ 2.860325] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray608machine # [ 2.868276] EXT4-fs (vda): mounted filesystem 379e65fd-cc6e-4c57-8525-7b379362b01f r/w with ordered data mode. Quota mode: none.609machine # [ 2.871490] cdrom: Uniform CD-ROM driver Revision: 3.20610machine # [ 2.732072] systemd[1]: Mounted /sysroot.611machine # [ 2.732718] systemd[1]: Reached target Initrd Root File System.612machine # [ 2.734390] systemd[1]: Starting Mountpoints Configured in the Real Root...613machine # [ 2.751701] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload.614machine # [ 2.754436] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)...615machine # [ 2.755911] systemd[1]: Reloading...616machine # [ 2.832709] systemd[1]: Reloading finished in 75 ms.617machine # [ 2.841072] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace...618machine # [ 2.843255] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace...619machine # [ 2.848153] systemd[1]: initrd-parse-etc.service: Deactivated successfully.620machine # [ 2.849467] systemd[1]: Finished Mountpoints Configured in the Real Root.621machine # [ 2.850455] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.622machine # [ 2.852765] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio623machine # [ 3.522397] systemd[1]: Mounting /sysroot/nix/.ro-store...624machine # [ 3.529164] systemd[1]: Mounting /sysroot/nix/.rw-store...625machine # [ 3.537289] systemd[1]: Mounting /sysroot/run...626machine # [ 3.545151] systemd[1]: Mounting /sysroot/tmp/shared...627machine # [ 3.558746] systemd[1]: Mounting /sysroot/tmp/xchg...628machine # [ 3.740464] 9p: Installing v9fs 9p2000 file system support629machine # [ 3.599779] systemd[1]: Mounted /sysroot/nix/.rw-store.630machine # [ 3.604123] systemd[1]: Mounted /sysroot/run.631machine # [ 3.610616] systemd[1]: Mounted /sysroot/nix/.ro-store.632machine # [ 3.613134] systemd[1]: Mounted /sysroot/tmp/shared.633machine # [ 3.613955] systemd[1]: Mounted /sysroot/tmp/xchg.634machine # [ 3.617722] systemd[1]: Starting rw-sysroot-nix-store.service...635machine # [ 3.628410] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.636machine # [ 3.629826] systemd[1]: Finished rw-sysroot-nix-store.service.637machine # [ 3.631795] systemd[1]: Mounting /sysroot/nix/store...638machine # [ 3.650298] systemd[1]: Mounted /sysroot/nix/store.639machine # [ 3.651888] systemd[1]: Reached target Initrd File Systems.640machine # [ 3.652889] systemd[1]: Starting Find NixOS closure...641machine # [ 3.655434] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...642machine # [ 3.673983] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.643machine # [ 3.681906] systemd[1]: Finished Find NixOS closure.644machine # [ 3.683172] systemd[1]: Reached target Initrd Default Target.645machine # [ 3.684690] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...646machine # [ 3.697466] systemd[1]: Stopped target Initrd Default Target.647machine # [ 3.698704] systemd[1]: Stopped target Basic System.648machine # [ 3.700050] systemd[1]: Stopped target Initrd Root Device.649machine # [ 3.700810] systemd[1]: Stopped target Path Units.650machine # [ 3.701548] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.651machine # [ 3.702533] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.652machine # [ 3.703648] systemd[1]: Stopped target Slice Units.653machine # [ 3.704720] systemd[1]: Stopped target Socket Units.654machine # [ 3.705656] systemd[1]: Stopped target System Initialization.655machine # [ 3.706781] systemd[1]: Stopped target Swaps.656machine # [ 3.707640] systemd[1]: Stopped target Timer Units.657machine # [ 3.709129] systemd[1]: dbus.socket: Deactivated successfully.658machine # [ 3.709907] systemd[1]: Closed D-Bus System Message Bus Socket.659machine # [ 3.710826] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.660machine # [ 3.711814] systemd[1]: Stopped Find NixOS closure.661machine # [ 3.712564] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio662machine # [ 3.714515] systemd[1]: Starting rw-sysroot-nix-store.service...663machine # [ 3.716165] systemd[1]: systemd-sysctl.service: Deactivated successfully.664machine # [ 3.717316] systemd[1]: Stopped Apply Kernel Variables.665machine # [ 3.718344] systemd[1]: systemd-modules-load.service: Deactivated successfully.666machine # [ 3.719482] systemd[1]: Stopped Load Kernel Modules.667machine # [ 3.720504] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.668machine # [ 3.721749] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.669machine # [ 3.723111] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.670machine # [ 3.724218] systemd[1]: Stopped Create System Files and Directories.671machine # [ 3.725548] systemd[1]: Stopped target Local File Systems.672machine # [ 3.726413] systemd[1]: Stopped target Preparation for Local File Systems.673machine # [ 3.727868] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.674machine # [ 3.729101] systemd[1]: Stopped Coldplug All udev Devices.675machine # [ 3.731324] systemd[1]: Stopping Rule-based Manager for Device Events and Files...676machine # [ 3.732318] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.677machine # [ 3.733280] systemd[1]: Stopped Virtual Console Setup.678machine # [ 3.742939] systemd[1]: initrd-cleanup.service: Deactivated successfully.679machine # [ 3.746067] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.680machine # [ 3.747065] systemd[1]: systemd-udevd.service: Deactivated successfully.681machine # [ 3.750100] systemd[1]: Stopped Rule-based Manager for Device Events and Files.682machine # [ 3.754846] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.683machine # [ 3.756290] systemd[1]: Finished rw-sysroot-nix-store.service.684machine # [ 3.758253] systemd[1]: Starting Cleanup udev Database...685machine # [ 3.759449] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.686machine # [ 3.760488] systemd[1]: Stopped Create Static Device Nodes in /dev.687machine # [ 3.761308] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.688machine # [ 3.763126] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.689machine # [ 3.764482] systemd[1]: kmod-static-nodes.service: Deactivated successfully.690machine # [ 3.765406] systemd[1]: Stopped Create List of Static Device Nodes.691machine # [ 3.780384] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.692machine # [ 3.781579] systemd[1]: Finished Cleanup udev Database.693machine # [ 3.783111] systemd[1]: Reached target Switch Root.694machine # [ 3.784205] systemd[1]: Starting NixOS Activation...695machine # [ 3.934236] initrd-nixos-activation-start[191]: booting system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test696machine # [ 3.995117] initrd-nixos-activation-start[191]: running activation script...697machine # [ 4.391513] initrd-nixos-activation-start[214]: setting up /etc...698machine # [ 4.643751] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.699machine # [ 4.645076] systemd[1]: Finished NixOS Activation.700machine # [ 4.646847] systemd[1]: Starting Switch Root...701machine # [ 4.660366] systemd[1]: Switching root.702machine # [ 4.933984] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).703machine # [ 5.070485] NET: Registered PF_VSOCK protocol family704machine # [ 5.453011] systemd[1]: systemd 262-9457f81 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)705machine # [ 5.462388] systemd[1]: Detected virtualization kvm.706machine # [ 5.464098] systemd[1]: Detected architecture x86-64.707machine # [ 5.465925] systemd[1]: Detected first boot.708machine # [ 5.472932] systemd[1]: Initializing machine ID from random generator.709machine # [ 5.596578] systemd[1]: bpf-restrict-fs: LSM BPF program attached710machine # [ 5.718428] systemd[1]: Applying preset policy.711machine # [ 6.180975] systemd[1]: Populated /etc with preset unit settings.712machine # [ 6.660754] systemd[1]: initrd-switch-root.service: Deactivated successfully.713machine # [ 6.663542] systemd[1]: Stopped initrd-switch-root.service.714machine # [ 6.666538] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.715machine # [ 6.668795] systemd[1]: Created slice Slice /system/getty.716machine # [ 6.670185] systemd[1]: Created slice User and Session Slice.717machine # [ 6.671219] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.718machine # [ 6.672367] systemd[1]: Started Forward Password Requests to Wall Directory Watch.719machine # [ 6.673422] systemd[1]: Expecting device /dev/hvc0...720machine # [ 6.674087] systemd[1]: Expecting device /dev/ttyS0...721machine # [ 6.674795] systemd[1]: Reached target Local Encrypted Volumes.722machine # [ 6.675602] systemd[1]: Stopped target initrd-fs.target.723machine # [ 6.676325] systemd[1]: Stopped target initrd-root-fs.target.724machine # [ 6.677116] systemd[1]: Stopped target initrd-switch-root.target.725machine # [ 6.677914] systemd[1]: Reached target Virtual Machines and Containers.726machine # [ 6.678786] systemd[1]: Reached target Path Units.727machine # [ 6.679443] systemd[1]: Reached target Remote File Systems.728machine # [ 6.680180] systemd[1]: Reached target Slice Units.729machine # [ 6.680863] systemd[1]: Reached target Swaps.730machine # [ 6.685099] systemd[1]: Listening on Query the User Interactively for a Password.731machine # [ 6.689601] systemd[1]: Listening on Process Core Dump Socket.732machine # [ 6.692978] systemd[1]: Listening on Credential Encryption/Decryption.733machine # [ 6.696120] systemd[1]: Listening on Factory Reset Management.734machine # [ 6.708210] systemd[1]: Listening on Hostname Service Socket.735machine # [ 6.712708] systemd[1]: Starting Journal Log Access Socket...736machine # [ 6.714705] systemd[1]: Listening on Journal Audit Socket.737machine # [ 6.717964] systemd[1]: Listening on Console Output Muting Service Socket.738machine # [ 6.719469] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.739machine # [ 6.721126] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os740machine # [ 6.722470] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki741machine # [ 6.733662] systemd[1]: Listening on Disk Repartitioning Service Socket.742machine # [ 6.734702] systemd[1]: Listening on udev Varlink Socket.743machine # [ 6.739786] systemd[1]: Mounting Huge Pages File System...744machine # [ 6.743035] systemd[1]: Mounting POSIX Message Queue File System...745machine # [ 6.747105] systemd[1]: Mounting Kernel Debug File System...746machine # [ 6.755001] systemd[1]: Mounting Kernel Trace File System...747machine # [ 6.761825] systemd[1]: Starting Create List of Static Device Nodes...748machine # [ 6.762792] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio749machine # [ 6.772369] systemd[1]: Starting Load Kernel Module configfs...750machine # [ 6.773950] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm751machine # [ 6.775667] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore752machine # [ 6.777598] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse753machine # [ 6.787234] systemd[1]: Mounting FUSE Control File System...754machine # [ 6.788594] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67755machine # [ 6.822378] systemd[1]: Starting Journal Service...756machine # [ 6.840783] systemd[1]: Starting Load Kernel Modules...757machine # [ 6.859920] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...758machine # [ 6.871425] systemd[1]: Starting Remount Root and Kernel File Systems...759machine # [ 6.877239] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os760machine # [ 6.895592] systemd[1]: Starting Coldplug All udev Devices...761machine # [ 6.910988] systemd[1]: Listening on Journal Log Access Socket.762machine # [ 6.914062] systemd-journald[285]: Collecting audit messages is enabled.763machine # [ 6.916293] systemd[1]: Mounted Huge Pages File System.764machine # [ 6.923284] systemd[1]: Mounted POSIX Message Queue File System.765machine # [ 6.926684] systemd[1]: Mounted Kernel Debug File System.766machine # [ 6.932557] systemd[1]: Mounted Kernel Trace File System.767machine # [ 6.941088] systemd[1]: Finished Create List of Static Device Nodes.768machine # [ 6.942919] loop: module loaded769machine # [ 6.946412] systemd[1]: modprobe@configfs.service: Deactivated successfully.770machine # [ 6.807433] systemd[1]: Queued start job for default target Multi-User System.771machine # [ 6.810596] systemd[1]: systemd-journald.service: Deactivated successfully.772machine # [ 6.955305] systemd[1]: Finished Load Kernel Module configfs.773machine # [ 6.813543] systemd-modules-load[286]: Inserted module 'loop'774machine # [ 6.957300] EXT4-fs (vda): re-mounted 379e65fd-cc6e-4c57-8525-7b379362b01f.775machine # [ 6.963383] systemd[1]: Started Journal Service.776machine # [ 6.824624] systemd[1]: Mounted FUSE Control File System.777machine # [ 6.827073] systemd[1]: Finished Load Kernel Modules.778machine # [ 6.829434] systemd[1]: Finished Remount Root and Kernel File Systems.779machine # [ 6.845083] systemd[1]: Listening on Disk Image Download Service Socket.780machine # [ 6.854063] systemd[1]: Mounting Kernel Configuration File System...781machine # [ 6.859064] systemd[1]: Starting Firewall...782machine # [ 6.865950] systemd[1]: Starting Flush Journal to Persistent Storage...783machine # [ 6.867692] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore784machine # [ 6.874254] systemd-oomd[288]: No swap; memory pressure usage will be degraded785machine # [ 6.884068] systemd[1]: Starting Load/Save OS Random Seed...786machine # [ 6.898975] systemd[1]: Starting Apply Kernel Variables...787machine # [ 6.905611] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...788machine # [ 6.906686] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os789machine # [ 6.909161] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.790machine # [ 7.090660] systemd-journald[285]: Received client request to flush runtime journal.791machine # [ 7.084470] systemd[1]: Finished Load/Save OS Random Seed.792machine # [ 7.085386] systemd[1]: Mounted Kernel Configuration File System.793machine # [ 7.086239] systemd[1]: Reached target First Boot Complete.794machine # [ 7.089208] systemd[1]: Finished Apply Kernel Variables.795machine # [ 7.090144] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.796machine # [ 7.095174] systemd[1]: Starting Create Static Device Nodes in /dev...797machine # [ 7.101157] systemd[1]: Finished Flush Journal to Persistent Storage.798machine # [ 7.168631] systemd[1]: Finished Create Static Device Nodes in /dev.799machine # [ 7.170094] systemd[1]: Reached target Preparation for Local File Systems.800machine # [ 7.175420] systemd[1]: Starting Rule-based Manager for Device Events and Files...801machine # [ 7.229234] systemd[1]: Finished Coldplug All udev Devices.802machine # [ 7.263559] systemd-udevd[327]: Using default interface naming scheme 'v261'.803machine # [ 7.373573] systemd[1]: Started Rule-based Manager for Device Events and Files.804machine # [ 7.505195] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse805machine # [ 7.523154] systemd[1]: Mounting /run/wrappers...806machine # [ 7.565822] systemd[1]: Mounted /run/wrappers.807machine # [ 7.568091] systemd[1]: Reached target Local File Systems.808machine # [ 7.572350] systemd[1]: Listening on Boot Loader Control Service Socket.809machine # [ 7.577206] systemd[1]: Starting register-nix-paths.service...810machine # [ 7.583205] systemd[1]: Starting Create SUID/SGID Wrappers...811machine # [ 7.584121] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.812machine # [ 7.593977] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 7.610316] systemd[1]: Starting Create System Files and Directories...814machine # [ 7.649823] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.815machine # [ 7.695654] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.816machine # [ 7.703584] systemd[1]: Finished Save Transient machine-id to Disk.817machine # [ 7.724537] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.818machine # [ 7.770482] systemd[1]: Finished Create System Files and Directories.819machine # [ 7.781152] systemd[1]: Starting Rebuild Journal Catalog...820machine # [ 7.788144] systemd[1]: Starting Record System Boot/Shutdown in UTMP...821machine # [ 7.793956] (udev-worker)[362]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.822machine # [ 7.800590] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line.823machine # [ 7.803964] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line.824machine # [ 7.886846] systemd[1]: Finished Record System Boot/Shutdown in UTMP.825machine # [ 7.933254] systemd[1]: Finished Rebuild Journal Catalog.826machine # [ 7.941946] systemd[1]: Starting Update is Completed...827machine # [ 7.997459] systemd[1]: Finished Update is Completed.828machine # [ 8.030479] systemd[1]: Condition check resulted in Virtio network device being skipped.829machine # [ 8.033307] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore830machine # [ 8.035429] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.831machine # [ 8.037735] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67832machine # [ 8.040382] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore833machine # [ 8.042417] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os834machine # [ 8.044621] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os835machine # [ 8.219873] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.836machine # [ 8.223464] systemd[1]: Finished Create SUID/SGID Wrappers.837machine # [ 8.408986] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3838machine # [ 8.410842] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console839machine # [ 8.306120] systemd[1]: Finished Firewall.840machine # [ 8.450857] ACPI: button: Power Button [PWRF]841machine # [ 8.460532] mousedev: PS/2 mouse device common for all mice842machine # [ 8.522975] rtc_cmos 00:04: RTC can wake from S4843machine # [ 8.536709] rtc_cmos 00:04: registered as rtc0844machine # [ 8.536787] rtc_cmos 00:04: setting system clock to 2026-09-06T22:53:19 UTC (1788735199)845machine # [ 8.536863] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs846machine # [ 8.537279] systemd-journald[285]: Time jumped backwards, rotating.847machine # [ 8.565737] parport_pc 00:02: reported by Plug and Play ACPI848machine # [ 8.565819] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]849machine # [ 8.574854] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4850machine # [ 8.584640] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized851machine # [ 8.594399] Console: switching to colour dummy device 80x25852machine # [ 8.689792] [drm] Found bochs VGA, ID 0xb0c5.853machine # [ 8.689794] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.854machine # [ 8.692230] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic855machine # [ 8.692897] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0856machine # [ 8.560555] systemd[1]: Finished register-nix-paths.service.857machine # [ 8.561730] systemd[1]: Reached target System Initialization.858machine # [ 8.707188] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt859machine # [ 8.707837] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD860machine # [ 8.568775] systemd[1]: Started Discard unused filesystem blocks once a week.861machine # [ 8.569777] systemd[1]: Started Daily Cleanup of Temporary Directories.862machine # [ 8.570659] systemd[1]: Reached target Timer Units.863machine # [ 8.571400] systemd[1]: Listening on D-Bus System Message Bus Socket.864machine # [ 8.572448] systemd[1]: Listening on Nix Daemon Socket.865machine # [ 8.573838] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.866machine # [ 8.574957] systemd[1]: Reached target Socket Units.867machine # [ 8.576132] systemd[1]: Reached target Basic System.868machine # [ 8.579602] systemd[1]: Started backdoor.service.869machine # [ 8.582589] systemd[1]: Starting Import lastlog data into lastlog2 database...870machine # [ 8.590529] systemd[1]: Starting Name Service Cache Daemon (nsncd)...871machine # [ 8.605761] systemd[1]: Starting Post-Boot Actions...872machine # [ 8.618076] systemd[1]: Started Reset console on configuration changes.873machine # [ 8.634635] systemd[1]: Starting resolvconf update...874machine # [ 8.791231] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6875machine # [ 8.792434] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5876machine # [ 8.673088] systemd[1]: Starting D-Bus System Message Bus...877machine # [ 8.710221] nsncd[503]: Sep 06 22:53:19.812 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"878machine # connecting to host...879machine # [ 8.717728] systemd[1]: Finished Post-Boot Actions.880machine # [ 8.723735] systemd[1]: Started Name Service Cache Daemon (nsncd).881machine # [ 8.740980] systemd[1]: Reached target Host and Network Name Lookups.882machine # [ 8.741953] systemd[1]: Reached target User and Group Name Lookups.883machine: Guest shell says: b'Spawning backdoor root shell...\n'884machine: connected to guest root shell885machine # [ 8.760271] systemd[1]: Starting User Login Management...886machine: (connecting took 9.45 seconds)887machine: (finished: waiting for the VM to finish booting, in 9.65 seconds)888machine # [ 8.787190] systemd[1]: Finished Import lastlog data into lastlog2 database.889machine # [ 8.810217] systemd[1]: Starting Virtual Console Setup...890machine # [ 8.889133] dbus-broker-launch[510]: Looking up NSS user entry for 'systemd-timesync'...891machine # [ 9.038770] Console: switching to colour frame buffer device 160x50892machine # [ 9.081103] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device893machine # [ 8.940488] systemd-logind[529]: New seat seat0.894machine # [ 8.954084] systemd[1]: Started User Login Management.895machine # [ 8.956058] systemd-logind[529]: Watching system buttons on /dev/input/event2 (Power Button)896machine # [ 8.961205] systemd-logind[529]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)897machine # [ 8.970635] dbus-broker-launch[510]: NSS returned no entry for 'systemd-timesync'898machine # [ 8.971825] dbus-broker-launch[510]: Invalid user-name in /nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"899machine # [ 8.977671] systemd[1]: Stopped target Host and Network Name Lookups.900machine # [ 8.979255] systemd[1]: Stopping Host and Network Name Lookups...901machine # [ 8.981403] systemd[1]: Stopped target User and Group Name Lookups.902machine # [ 8.982404] systemd[1]: Stopping User and Group Name Lookups...903machine # [ 8.989657] systemd[1]: Starting linger-users.service...904machine # [ 8.990419] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...905machine # [ 8.999094] systemd[1]: nscd.service: Deactivated successfully.906machine # [ 9.001197] systemd[1]: Stopped Name Service Cache Daemon (nsncd).907machine # [ 9.013913] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.908machine # [ 9.018133] systemd[1]: Stopped Virtual Console Setup.909machine # [ 9.026330] systemd[1]: Started D-Bus System Message Bus.910machine # [ 9.059190] systemd[1]: Starting Name Service Cache Daemon (nsncd)...911machine # [ 9.066781] systemd[1]: Starting Virtual Console Setup...912machine # [ 9.073243] dbus-broker-launch[510]: Ready913machine # [ 9.152153] systemd[1]: Created slice Slice /user/1001.914machine # [ 9.159220] systemd[1]: Starting User Runtime Directory /run/user/1001...915machine # [ 9.174596] systemd[1]: linger-users.service: Deactivated successfully.916machine # [ 9.319771] ppdev: user-space parallel port driver917machine # [ 9.179157] systemd[1]: Finished linger-users.service.918machine # [ 9.187312] systemd[1]: Finished resolvconf update.919machine # [ 9.338804] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)920machine # [ 9.198187] systemd[1]: Reached target Preparation for Network.921machine # [ 9.204091] systemd[1]: Starting DHCP Client...922machine # [ 9.212322] nsncd[592]: Sep 06 22:53:20.308 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"923machine # [ 9.214246] systemd[1]: Starting Address configuration of eth1...924machine # [ 9.368349] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)925machine # [ 9.226226] systemd[1]: Starting Extra networking commands....926machine # [ 9.227341] systemd[1]: Started Name Service Cache Daemon (nsncd).927machine # [ 9.228169] systemd[1]: Reached target Host and Network Name Lookups.928machine # [ 9.228982] systemd[1]: Reached target User and Group Name Lookups.929machine # [ 9.241154] systemd-logind[529]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)930machine # [ 9.293450] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.931machine # [ 9.294973] systemd[1]: Stopped Virtual Console Setup.932machine # [ 9.303093] systemd[1]: Starting Virtual Console Setup...933machine # [ 9.337602] systemd[1]: Finished User Runtime Directory /run/user/1001.934machine # [ 9.344873] systemd[1]: Starting User Manager for UID 1001...935machine # [ 9.440738] (systemd)[631]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)936machine # [ 9.459925] systemd-logind[529]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.937machine # [ 9.494270] network-addresses-eth1-start[623]: adding address 192.168.1.1/24... done938machine # [ 9.505902] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy939machine # [ 9.723688] kvm_amd: TSC scaling supported940machine # [ 9.725953] kvm_amd: Nested Virtualization enabled941machine # [ 9.729213] kvm_amd: Nested Paging enabled942machine # [ 9.729700] kvm_amd: LBR virtualization supported943machine # [ 9.591077] systemd[1]: Finished Address configuration of eth1.944machine # [ 9.735052] kvm_amd: Virtual VMLOAD VMSAVE supported945machine # [ 9.735549] kvm_amd: Virtual GIF supported946machine # [ 9.735904] kvm_amd: Virtual NMI enabled947machine # [ 9.593556] network-addresses-eth1-start[623]: adding address 2001:db8:1::1/64... done948machine # [ 9.675453] systemd[1]: Finished Extra networking commands..949machine # [ 9.676869] systemd[1]: Reached target Network.950machine # [ 9.680906] systemd[1]: Starting Permit User Sessions...951machine # [ 9.831662] EDAC MC: Ver: 3.0.0952machine # [ 9.712944] dhcpcd[639]: dhcpcd-10.3.2 starting953machine # [ 9.725903] dhcpcd[702]: dev: loaded udev954machine # [ 9.733236] systemd[1]: Finished Permit User Sessions.955machine # [ 9.739219] systemd[1]: Started Getty on tty1.956machine # [ 9.740604] systemd[1]: Reached target Login Prompts.957machine # [ 9.745710] systemd[631]: Queued start job for default target Main User Target.958machine # [ 9.749520] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy959machine # [ 9.752093] systemd[631]: Created slice User Application Slice.960machine # [ 9.754384] systemd[631]: Started Daily Cleanup of User's Temporary Directories.961machine # [ 9.756366] systemd[631]: Reached target Paths.962machine # [ 9.757807] systemd[631]: Reached target Timers.963machine # [ 9.759098] systemd[631]: Starting D-Bus User Message Bus Socket...964machine # [ 9.905322] 8021q: 802.1Q VLAN Support v1.8965machine # [ 9.905754] 8021q: adding VLAN 0 to HW filter on device eth1966machine # [ 9.766364] systemd[631]: Starting Create User Files and Directories...967machine # [ 9.799611] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.968machine # [ 9.823451] systemd[631]: Finished Create User Files and Directories.969machine # [ 10.023790] cfg80211: Loading compiled-in X.509 certificates for regulatory database970machine # [ 9.894494] systemd[631]: Listening on D-Bus User Message Bus Socket.971machine # [ 9.895916] systemd[631]: Reached target Sockets.972machine # [ 9.896951] systemd[631]: Reached target Basic System.973machine # [ 9.898983] systemd[1]: Started User Manager for UID 1001.974machine # [ 9.901949] systemd[631]: Starting Run user-specific NixOS activation...975machine # [ 10.061493] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'976machine # [ 10.062355] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'977machine # [ 10.065502] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2978machine # [ 10.066407] cfg80211: failed to load regulatory.db979machine # [ 9.949672] systemd[631]: Finished Run user-specific NixOS activation.980machine # [ 9.951185] systemd[631]: Reached target Main User Target.981machine # [ 9.952720] systemd[631]: Startup finished in 463ms.982machine # [ 10.125594] 8021q: adding VLAN 0 to HW filter on device eth0983machine # [ 9.983850] dhcpcd[702]: eth0: waiting for carrier984machine # [ 9.984676] dhcpcd[702]: eth0: carrier acquired985machine # [ 9.993909] dhcpcd[702]: DUID 00:01:00:01:32:30:ab:61:52:54:00:12:34:56986machine # [ 9.994805] dhcpcd[702]: eth0: IAID 00:12:34:56987machine # [ 9.995460] dhcpcd[702]: eth0: adding address fe80::5054:ff:fe12:3456988machine # [ 10.035400] systemd-vconsole-setup[627]: Configuration of first virtual console was skipped, ignoring remaining ones.989machine # [ 10.040084] systemd[1]: Finished Virtual Console Setup.990machine # [ 11.245617] dhcpcd[702]: eth0: soliciting a DHCP lease991machine # [ 11.407882] NET: Registered PF_PACKET protocol family992machine # [ 11.269620] dhcpcd[702]: eth0: offered 10.0.2.15 from 10.0.2.2993machine # [ 11.273217] dhcpcd[702]: eth0: probing address 10.0.2.15/24994machine # [ 12.053770] dhcpcd[702]: eth0: soliciting an IPv6 router995machine # [ 12.056394] dhcpcd[702]: eth0: Router Advertisement from fe80::2996machine # [ 12.058828] dhcpcd[702]: eth0: adding address fec0::5054:ff:fe12:3456/64997machine # [ 12.060987] dhcpcd[702]: eth0: adding route to fec0::/64998machine # [ 12.062833] dhcpcd[702]: eth0: adding default route via fe80::2999machine # [ 16.174070] dhcpcd[702]: eth0: leased 10.0.2.15 for 86400 seconds1000machine # [ 16.176978] dhcpcd[702]: eth0: adding route to 10.0.2.0/241001machine # [ 16.179133] dhcpcd[702]: eth0: adding default route via 10.0.2.21002machine # [ 16.287864] systemd[1]: Started DHCP Client.1003machine # [ 16.289883] systemd[1]: Reached target Multi-User System.1004machine # [ 16.291159] systemd[1]: Startup finished in 856ms (kernel) + 4.012s (initrd) + 11.420s (userspace) = 16.289s.1005machine: (finished: waiting for unit multi-user.target, in 17.59 seconds)1006machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test1007machine # Checking switch inhibitors... done1008machine # [ 17.155580] nixos[850]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1009machine # [ 17.157913] systemd[1]: Stopped target Remote File Systems.1010machine # [ 17.159410] systemd[1]: Stopped target Local File Systems.1011machine # activating the configuration...1012machine # setting up /etc...1013machine # [ 17.518846] systemd[1]: Reload requested from client PID 850 ('.switch-to-conf') (unit backdoor.service)...1014machine # [ 17.520439] systemd[1]: Reloading...1015machine # [ 17.974852] systemd[1]: Reloading finished in 452 ms.1016machine # reloading user units for usertest...1017machine # [ 18.006261] systemd[631]: Created slice User Core Session Slice.1018machine # [ 18.009267] systemd[631]: Starting D-Bus User Message Bus...1019machine # [ 18.058144] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.import1.service'1020machine # [ 18.060710] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.machine1.service'1021machine # [ 18.063518] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.portable1.service'1022machine # [ 18.066443] dbus-broker-launch[920]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'1023machine # [ 18.069760] dbus-broker-launch[920]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored1024machine # [ 18.072054] dbus-broker-launch[920]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored1025machine # [ 18.073962] systemd[631]: Started D-Bus User Message Bus.1026machine # [ 18.081528] dbus-broker-launch[920]: Ready1027machine # [ 18.161601] systemd[631]: Reexecution requested from client PID 919 ('switch-to-confi')...1028machine # [ 18.162836] systemd[631]: Reexecuting.1029machine # [ 18.188346] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1030machine # [ 18.316944] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1031machine # [ 18.321987] systemd[631]: Reload requested from client PID 919 ('switch-to-confi')...1032machine # [ 18.323533] systemd[631]: Reloading...1033machine # [ 18.454568] systemd[631]: Reloading finished in 129 ms.1034machine # [ 18.457846] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1035machine # restarting the following user units: nixos-activation.service1036machine # [ 18.465301] systemd[631]: Stopped Run user-specific NixOS activation.1037machine # [ 18.466216] systemd[631]: Stopping Run user-specific NixOS activation...1038machine # [ 18.468913] systemd[631]: Starting Run user-specific NixOS activation...1039machine # [ 18.501178] systemd[631]: Finished Run user-specific NixOS activation.1040machine # restarting sysinit-reactivation.target1041machine # [ 18.513486] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1042machine # [ 18.603131] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1043machine # [ 18.604204] systemd[1]: Reached target Reactivate sysinit units.1044machine # [ 18.608387] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1045machine # [ 18.610512] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1046machine # [ 18.612598] systemd[1]: Reached target Remote File Systems.1047machine # [ 18.616509] systemd[1]: Starting linger-users.service...1048machine # [ 18.627151] systemd[1]: Reached target Local File Systems.1049machine # [ 18.629672] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1050machine # [ 18.634284] systemd[1]: Starting Create SUID/SGID Wrappers...1051machine # [ 18.635447] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1052machine # [ 18.637428] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671053machine # [ 18.639379] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1054machine # [ 18.640762] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1055machine # [ 18.641872] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1056machine # [ 18.687498] systemd[1]: linger-users.service: Deactivated successfully.1057machine # [ 18.688527] systemd[1]: Finished linger-users.service.1058machine # [ 18.929649] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1059machine # [ 18.931287] systemd[1]: Finished Create SUID/SGID Wrappers.1060machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service1061machine # [ 19.192520] nixos[850]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1062machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test, in 2.49 seconds)1063machine: must succeed: rm /etc/NIXOS1064machine: (finished: must succeed: rm /etc/NIXOS, in 0.04 seconds)1065machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/bin/switch-to-configuration test1066machine # this should succeed (config: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test, action: test)1067machine # Checking switch inhibitors... done1068machine # [ 19.771690] nixos[997]: switching to system configuration /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test1069machine # [ 19.774037] systemd[1]: Stopped target Local File Systems.1070machine # activating the configuration...1071machine # [ 19.776224] systemd[1]: Stopped target Remote File Systems.1072machine # removing user ‘usertest’1073machine # setting up /etc...1074machine # [ 20.160549] systemd[1]: Reload requested from client PID 997 ('.switch-to-conf') (unit backdoor.service)...1075machine # [ 20.162263] systemd[1]: Reloading...1076machine # [ 20.722651] systemd[1]: Reloading finished in 557 ms.1077machine # reloading user units for usertest...1078machine # [ 20.837270] systemd[631]: Reexecution requested from client PID 1069 ('switch-to-confi')...1079machine # [ 20.838556] systemd[631]: Reexecuting.1080machine # [ 20.865399] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1081machine # [ 21.000541] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1082machine # [ 21.006583] systemd[631]: Reload requested from client PID 1069 ('switch-to-confi')...1083machine # [ 21.007755] systemd[631]: Reloading...1084machine # [ 21.140883] systemd[631]: Reloading finished in 131 ms.1085machine # [ 21.145032] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1086machine # restarting the following user units: nixos-activation.service1087machine # [ 21.153074] systemd[631]: Stopped Run user-specific NixOS activation.1088machine # [ 21.154047] systemd[631]: Stopping Run user-specific NixOS activation...1089machine # [ 21.156816] systemd[631]: Starting Run user-specific NixOS activation...1090machine # [ 21.194474] systemd[631]: Finished Run user-specific NixOS activation.1091machine # restarting sysinit-reactivation.target1092machine # [ 21.198508] systemd[1]: Stopped target Reactivate sysinit units.1093machine # reloading the following units: dbus-broker.service1094machine # [ 21.200867] systemd[1]: Stopping Reactivate sysinit units...1095machine # [ 21.201852] systemd[1]: Reached target Reactivate sysinit units.1096machine # [ 21.203869] systemd[1]: Reloading D-Bus System Message Bus...1097machine # [ 21.205281] dbus-broker-launch[510]: Caught SIGHUP, trigger reload.1098machine # [ 21.224063] dbus-broker-launch[510]: Looking up NSS user entry for 'systemd-timesync'...1099machine # [ 21.225861] dbus-broker-launch[510]: NSS returned no entry for 'systemd-timesync'1100machine # [ 21.226948] dbus-broker-launch[510]: Invalid user-name in /nix/store/yl6shlfxw95siygj3vrskihkygz4y1d6-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1101machine # [ 21.249907] systemd[1]: Reloaded D-Bus System Message Bus.1102machine # restarting the following units: network-addresses-eth1.service1103machine # [ 21.255749] systemd[1]: Stopping Address configuration of eth1...1104machine # [ 21.293910] network-addresses-eth1-pre-stop[1081]: deleting address 192.168.1.1/24... done1105machine # [ 21.304522] network-addresses-eth1-pre-stop[1081]: deleting address 2001:db8:1::1/64... done1106machine # [ 21.312898] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1107machine # [ 21.314798] systemd[1]: Stopped Address configuration of eth1.1108machine # [ 21.318398] systemd[1]: Starting Address configuration of eth1...1109machine # [ 21.377268] network-addresses-eth1-start[1086]: adding address 192.168.1.2/24... done1110machine # [ 21.388309] network-addresses-eth1-start[1086]: adding address 2001:db8:1::2/64... done1111machine # [ 21.401744] systemd[1]: Finished Address configuration of eth1.1112machine # [ 21.406342] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1113machine # [ 21.408626] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1114machine # [ 21.410635] systemd[1]: Reached target Remote File Systems.1115machine # [ 21.414078] systemd[1]: Starting linger-users.service...1116machine # [ 21.416369] systemd[1]: Reached target Local File Systems.1117machine # [ 21.422107] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1118machine # [ 21.427064] systemd[1]: Starting Create SUID/SGID Wrappers...1119machine # [ 21.427851] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1120machine # [ 21.429053] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671121machine # [ 21.430986] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1122machine # [ 21.432363] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1123machine # [ 21.433556] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1124machine # [ 21.476457] linger-users-start[1101]: id: ‘usertest’: no such user1125machine # [ 21.478170] linger-users-start[1097]: Removing linger for missing user usertest1126machine # [ 21.486683] systemd[1]: linger-users.service: Deactivated successfully.1127machine # [ 21.488204] systemd[1]: Finished linger-users.service.1128machine # [ 21.786364] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1129machine # [ 21.788076] systemd[1]: Finished Create SUID/SGID Wrappers.1130machine # [ 22.042874] nixos[997]: finished switching to system configuration /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test1131machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/bin/switch-to-configuration test, in 2.81 seconds)1132subtest: pre-switch checks1133machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/bin/switch-to-configuration check1134machine # this should succeed (config: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test, action: check)1135machine # Checking switch inhibitors... done1136machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/bin/switch-to-configuration check, in 0.07 seconds)1137machine: must fail: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&11138machine: (finished: must fail: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1, in 0.04 seconds)1139machine: must fail: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&11140machine: (finished: must fail: /nix/store/b828xxq6n75nv4kyap381pidrwk9lpsh-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&1, in 0.04 seconds)1141(finished: subtest: pre-switch checks, in 0.16 seconds)1142subtest: switch inhibitors1143machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11144machine # [ 22.731143] nixos[1186]: switching to system configuration /nix/store/d7xkfkgxrk4fpylz6l4qkvrls0grw24z-nixos-system-machine-test1145machine # [ 22.733961] systemd[1]: Stopped target Remote File Systems.1146machine # [ 22.735797] systemd[1]: Stopped target Local File Systems.1147machine # [ 23.141769] systemd[1]: Reload requested from client PID 1186 ('.switch-to-conf') (unit backdoor.service)...1148machine # [ 23.143443] systemd[1]: Reloading...1149machine # [ 23.606059] systemd[1]: Reloading finished in 460 ms.1150machine # [ 23.721302] systemd[631]: Reexecution requested from client PID 1257 ('switch-to-confi')...1151machine # [ 23.723576] systemd[631]: Reexecuting.1152machine # [ 23.749451] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1153machine # [ 23.884190] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1154machine # [ 23.889725] systemd[631]: Reload requested from client PID 1257 ('switch-to-confi')...1155machine # [ 23.891332] systemd[631]: Reloading...1156machine # [ 24.037453] systemd[631]: Reloading finished in 144 ms.1157machine # [ 24.042819] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1158machine # [ 24.049258] systemd[631]: Stopped Run user-specific NixOS activation.1159machine # [ 24.050435] systemd[631]: Stopping Run user-specific NixOS activation...1160machine # [ 24.054050] systemd[631]: Starting Run user-specific NixOS activation...1161machine # [ 24.092908] systemd[631]: Finished Run user-specific NixOS activation.1162machine # [ 24.096834] systemd[1]: Stopped target Reactivate sysinit units.1163machine # [ 24.098718] systemd[1]: Stopping Reactivate sysinit units...1164machine # [ 24.099731] systemd[1]: Reached target Reactivate sysinit units.1165machine # [ 24.101855] dbus-broker-launch[510]: Caught SIGHUP, trigger reload.1166machine # [ 24.103339] systemd[1]: Reloading D-Bus System Message Bus...1167machine # [ 24.116612] dbus-broker-launch[510]: Looking up NSS user entry for 'systemd-timesync'...1168machine # [ 24.119223] dbus-broker-launch[510]: NSS returned no entry for 'systemd-timesync'1169machine # [ 24.120444] dbus-broker-launch[510]: Invalid user-name in /nix/store/wvv8w41xz1ya3m77c3n7zq9mi8fszl1v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1170machine # [ 24.138604] systemd[1]: Reloaded D-Bus System Message Bus.1171machine # [ 24.143760] systemd[1]: Stopping Address configuration of eth1...1172machine # [ 24.184956] network-addresses-eth1-pre-stop[1269]: deleting address 192.168.1.2/24... done1173machine # [ 24.195453] network-addresses-eth1-pre-stop[1269]: deleting address 2001:db8:1::2/64... done1174machine # [ 24.203626] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1175machine # [ 24.205416] systemd[1]: Stopped Address configuration of eth1.1176machine # [ 24.209383] systemd[1]: Starting Address configuration of eth1...1177machine # [ 24.267866] network-addresses-eth1-start[1274]: adding address 192.168.1.1/24... done1178machine # [ 24.279367] network-addresses-eth1-start[1274]: adding address 2001:db8:1::1/64... done1179machine # [ 24.292377] systemd[1]: Finished Address configuration of eth1.1180machine # [ 24.297969] systemd[1]: Reached target Local File Systems.1181machine # [ 24.299717] systemd[1]: Reached target Remote File Systems.1182machine # [ 24.302650] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1183machine # [ 24.304566] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1184machine # [ 24.309055] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1185machine # [ 24.313058] systemd[1]: Starting Create SUID/SGID Wrappers...1186machine # [ 24.313957] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1187machine # [ 24.315914] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671188machine # [ 24.318816] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1189machine # [ 24.320919] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1190machine # [ 24.323060] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1191machine # [ 24.625865] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1192machine # [ 24.627077] systemd[1]: Finished Create SUID/SGID Wrappers.1193machine # [ 24.631707] systemd[1]: Starting linger-users.service...1194machine # [ 24.671715] systemd[1]: linger-users.service: Deactivated successfully.1195machine # [ 24.673948] systemd[1]: Finished linger-users.service.1196machine # [ 24.930951] nixos[1186]: finished switching to system configuration /nix/store/d7xkfkgxrk4fpylz6l4qkvrls0grw24z-nixos-system-machine-test1197machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 2.73 seconds)1198machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&11199machine # [ 25.488459] nixos[1343]: switching to system configuration /nix/store/qzlkci5nph45rm43r851xp6azk413prm-nixos-system-machine-test1200machine # [ 25.490789] systemd[1]: Stopped target Remote File Systems.1201machine # [ 25.492780] systemd[1]: Stopped target Local File Systems.1202machine # [ 25.858921] systemd[1]: Reload requested from client PID 1343 ('.switch-to-conf') (unit backdoor.service)...1203machine # [ 25.860778] systemd[1]: Reloading...1204machine # [ 26.365928] systemd[1]: Reloading finished in 503 ms.1205machine # [ 26.485948] systemd[631]: Reexecution requested from client PID 1413 ('switch-to-confi')...1206machine # [ 26.487206] systemd[631]: Reexecuting.1207machine # [ 26.516311] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1208machine # [ 26.667927] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1209machine # [ 26.673885] systemd[631]: Reload requested from client PID 1413 ('switch-to-confi')...1210machine # [ 26.675295] systemd[631]: Reloading...1211machine # [ 26.817185] systemd[631]: Reloading finished in 139 ms.1212machine # [ 26.822095] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1213machine # [ 26.830211] systemd[631]: Stopped Run user-specific NixOS activation.1214machine # [ 26.831225] systemd[631]: Stopping Run user-specific NixOS activation...1215machine # [ 26.834315] systemd[631]: Starting Run user-specific NixOS activation...1216machine # [ 26.870178] systemd[631]: Finished Run user-specific NixOS activation.1217machine # [ 26.873702] systemd[1]: Stopped target Reactivate sysinit units.1218machine # [ 26.875320] systemd[1]: Stopping Reactivate sysinit units...1219machine # [ 26.876757] systemd[1]: Reached target Reactivate sysinit units.1220machine # [ 26.877911] systemd[1]: Reached target Remote File Systems.1221machine # [ 26.879469] systemd[1]: Reached target Local File Systems.1222machine # [ 26.889442] systemd[1]: Starting linger-users.service...1223machine # [ 26.892419] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1224machine # [ 26.897294] systemd[1]: Starting Create SUID/SGID Wrappers...1225machine # [ 26.899423] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1226machine # [ 26.902112] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671227machine # [ 26.904778] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1228machine # [ 26.907182] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1229machine # [ 26.910450] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1230machine # [ 26.911862] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1231machine # [ 26.913218] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1232machine # [ 26.965506] systemd[1]: linger-users.service: Deactivated successfully.1233machine # [ 26.967161] systemd[1]: Finished linger-users.service.1234machine # [ 27.208489] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1235machine # [ 27.210086] systemd[1]: Finished Create SUID/SGID Wrappers.1236machine # [ 27.468144] nixos[1343]: finished switching to system configuration /nix/store/qzlkci5nph45rm43r851xp6azk413prm-nixos-system-machine-test1237machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1, in 2.54 seconds)1238machine: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&11239machine: (finished: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1, in 0.07 seconds)1240machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&11241machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1, in 0.04 seconds)1242machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&11243machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1, in 0.53 seconds)1244machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&11245machine # [ 28.549369] nixos[1509]: switching to system configuration /nix/store/jsp9iwvpgfln226y22wzdf5npj8anm75-nixos-system-machine-test1246machine # [ 28.551703] systemd[1]: Stopped target Remote File Systems.1247machine # [ 28.553318] systemd[1]: Stopped target Local File Systems.1248machine # [ 28.904622] systemd[1]: Reload requested from client PID 1509 ('.switch-to-conf') (unit backdoor.service)...1249machine # [ 28.906164] systemd[1]: Reloading...1250machine # [ 29.352359] systemd[1]: Reloading finished in 444 ms.1251machine # [ 29.460275] systemd[631]: Reexecution requested from client PID 1579 ('switch-to-confi')...1252machine # [ 29.461488] systemd[631]: Reexecuting.1253machine # [ 29.482906] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1254machine # [ 29.602604] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1255machine # [ 29.608545] systemd[631]: Reload requested from client PID 1579 ('switch-to-confi')...1256machine # [ 29.609664] systemd[631]: Reloading...1257machine # [ 29.744675] systemd[631]: Reloading finished in 133 ms.1258machine # [ 29.750097] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1259machine # [ 29.758065] systemd[631]: Stopped Run user-specific NixOS activation.1260machine # [ 29.758900] systemd[631]: Stopping Run user-specific NixOS activation...1261machine # [ 29.761569] systemd[631]: Starting Run user-specific NixOS activation...1262machine # [ 29.796521] systemd[631]: Finished Run user-specific NixOS activation.1263machine # [ 29.800040] systemd[1]: Stopped target Reactivate sysinit units.1264machine # [ 29.801361] systemd[1]: Stopping Reactivate sysinit units...1265machine # [ 29.802233] systemd[1]: Reached target Reactivate sysinit units.1266machine # [ 29.807464] systemd[1]: Reached target Local File Systems.1267machine # [ 29.811115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1268machine # [ 29.815242] systemd[1]: Starting Create SUID/SGID Wrappers...1269machine # [ 29.816189] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1270machine # [ 29.817329] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671271machine # [ 29.820771] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1272machine # [ 29.822962] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1273machine # [ 29.825301] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1274machine # [ 29.827114] systemd[1]: Reached target Remote File Systems.1275machine # [ 29.829880] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1276machine # [ 29.831443] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1277machine # [ 30.107128] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1278machine # [ 30.109559] systemd[1]: Finished Create SUID/SGID Wrappers.1279machine # [ 30.113521] systemd[1]: Starting linger-users.service...1280machine # [ 30.160743] systemd[1]: linger-users.service: Deactivated successfully.1281machine # [ 30.161735] systemd[1]: Finished linger-users.service.1282machine # [ 30.418657] nixos[1509]: finished switching to system configuration /nix/store/jsp9iwvpgfln226y22wzdf5npj8anm75-nixos-system-machine-test1283machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1, in 2.31 seconds)1284machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11285machine # [ 31.002417] nixos[1651]: switching to system configuration /nix/store/d7xkfkgxrk4fpylz6l4qkvrls0grw24z-nixos-system-machine-test1286machine # [ 31.004858] systemd[1]: Stopped target Remote File Systems.1287machine # [ 31.006531] systemd[1]: Stopped target Local File Systems.1288machine # [ 31.390283] systemd[1]: Reload requested from client PID 1651 ('.switch-to-conf') (unit backdoor.service)...1289machine # [ 31.391954] systemd[1]: Reloading...1290machine # [ 31.938091] systemd[1]: Reloading finished in 544 ms.1291machine # [ 32.065438] systemd[631]: Reexecution requested from client PID 1721 ('switch-to-confi')...1292machine # [ 32.068058] systemd[631]: Reexecuting.1293machine # [ 32.096625] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1294machine # [ 32.270845] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1295machine # [ 32.276345] systemd[631]: Reload requested from client PID 1721 ('switch-to-confi')...1296machine # [ 32.277515] systemd[631]: Reloading...1297machine # [ 32.439034] systemd[631]: Reloading finished in 159 ms.1298machine # [ 32.444804] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1299machine # [ 32.452110] systemd[631]: Stopped Run user-specific NixOS activation.1300machine # [ 32.453034] systemd[631]: Stopping Run user-specific NixOS activation...1301machine # [ 32.455186] systemd[631]: Starting Run user-specific NixOS activation...1302machine # [ 32.492864] systemd[631]: Finished Run user-specific NixOS activation.1303machine # [ 32.496470] systemd[1]: Stopped target Reactivate sysinit units.1304machine # [ 32.498399] systemd[1]: Stopping Reactivate sysinit units...1305machine # [ 32.499286] systemd[1]: Reached target Reactivate sysinit units.1306machine # [ 32.503181] systemd[1]: Reached target Local File Systems.1307machine # [ 32.503917] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1308machine # [ 32.508089] systemd[1]: Starting Create SUID/SGID Wrappers...1309machine # [ 32.508854] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1310machine # [ 32.510040] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671311machine # [ 32.511937] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1312machine # [ 32.515024] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1313machine # [ 32.517439] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1314machine # [ 32.519215] systemd[1]: Reached target Remote File Systems.1315machine # [ 32.526696] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1316machine # [ 32.528082] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1317machine # [ 32.834066] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1318machine # [ 32.835638] systemd[1]: Finished Create SUID/SGID Wrappers.1319machine # [ 32.840347] systemd[1]: Starting linger-users.service...1320machine # [ 32.890701] systemd[1]: linger-users.service: Deactivated successfully.1321machine # [ 32.892273] systemd[1]: Finished linger-users.service.1322machine # [ 33.149974] nixos[1651]: finished switching to system configuration /nix/store/d7xkfkgxrk4fpylz6l4qkvrls0grw24z-nixos-system-machine-test1323machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 2.73 seconds)1324(finished: subtest: switch inhibitors, in 10.95 seconds)1325subtest: actions1326machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&11327machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1, in 0.07 seconds)1328machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration switch 2>&11329machine # [ 33.777483] nixos[1800]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1330machine # [ 33.780955] systemd[1]: Stopped target Remote File Systems.1331machine # [ 33.781880] systemd[1]: Stopped target Local File Systems.1332machine # [ 34.193427] systemd[1]: Reload requested from client PID 1800 ('.switch-to-conf') (unit backdoor.service)...1333machine # [ 34.195059] systemd[1]: Reloading...1334machine # [ 34.722691] systemd[1]: Reloading finished in 525 ms.1335machine # [ 34.852178] systemd[631]: Reexecution requested from client PID 1870 ('switch-to-confi')...1336machine # [ 34.854790] systemd[631]: Reexecuting.1337machine # [ 34.881372] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1338machine # [ 35.034765] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1339machine # [ 35.040617] systemd[631]: Reload requested from client PID 1870 ('switch-to-confi')...1340machine # [ 35.041828] systemd[631]: Reloading...1341machine # [ 35.197745] systemd[631]: Reloading finished in 153 ms.1342machine # [ 35.201868] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1343machine # [ 35.208399] systemd[631]: Stopped Run user-specific NixOS activation.1344machine # [ 35.210069] systemd[631]: Stopping Run user-specific NixOS activation...1345machine # [ 35.212575] systemd[631]: Starting Run user-specific NixOS activation...1346machine # [ 35.249069] systemd[631]: Finished Run user-specific NixOS activation.1347machine # [ 35.252369] systemd[1]: Stopped target Reactivate sysinit units.1348machine # [ 35.253792] systemd[1]: Stopping Reactivate sysinit units...1349machine # [ 35.254765] systemd[1]: Reached target Reactivate sysinit units.1350machine # [ 35.258650] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1351machine # [ 35.260337] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1352machine # [ 35.262362] systemd[1]: Reached target Remote File Systems.1353machine # [ 35.264679] systemd[1]: Reached target Local File Systems.1354machine # [ 35.266805] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1355machine # [ 35.271824] systemd[1]: Starting Create SUID/SGID Wrappers...1356machine # [ 35.272617] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1357machine # [ 35.273749] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671358machine # [ 35.275659] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1359machine # [ 35.279060] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1360machine # [ 35.280336] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1361machine # [ 35.603410] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1362machine # [ 35.605069] systemd[1]: Finished Create SUID/SGID Wrappers.1363machine # [ 35.609539] systemd[1]: Starting linger-users.service...1364machine # [ 35.658799] systemd[1]: linger-users.service: Deactivated successfully.1365machine # [ 35.661069] systemd[1]: Finished linger-users.service.1366machine # [ 35.917887] nixos[1800]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1367machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1, in 2.69 seconds)1368machine: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&11369machine: (finished: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1, in 0.04 seconds)1370machine: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration 2>&11371machine: (finished: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration 2>&1, in 0.03 seconds)1372(finished: subtest: actions, in 2.84 seconds)1373subtest: init interface version1374machine: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&11375machine: (finished: must fail: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&1, in 0.05 seconds)1376(finished: subtest: init interface version, in 0.05 seconds)1377subtest: systemd restarts1378machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11379machine # [ 36.490831] nixos[1957]: switching to system configuration /nix/store/jc9g2ndf18qxfkiijb40czjc4qc0qday-nixos-system-machine-test1380machine # [ 36.493483] systemd[1]: Stopped target Remote File Systems.1381machine # [ 36.495225] systemd[1]: Stopped target Local File Systems.1382machine # [ 36.896982] systemd[1]: Reexecution requested from client PID 1957 ('.switch-to-conf') (unit backdoor.service)...1383machine # [ 36.900782] systemd[1]: Reexecuting.1384machine # [ 37.199838] systemd[1]: systemd 262-9457f81 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)1385machine # [ 37.207409] systemd[1]: Detected virtualization kvm.1386machine # [ 37.209211] systemd[1]: Detected architecture x86-64.1387machine # [ 37.303780] systemd[1]: bpf-restrict-fs: LSM BPF program attached1388machine # [ 37.625538] systemd[1]: Reload requested from client PID 1957 ('.switch-to-conf') (unit backdoor.service)...1389machine # [ 37.627309] systemd[1]: Reloading...1390machine # [ 38.157080] systemd[1]: Reloading finished in 526 ms.1391machine # [ 38.290312] systemd[631]: Reexecution requested from client PID 2060 ('switch-to-confi')...1392machine # [ 38.292493] systemd[631]: Reexecuting.1393machine # [ 38.317858] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1394machine # [ 38.458359] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1395machine # [ 38.463952] systemd[631]: Reload requested from client PID 2060 ('switch-to-confi')...1396machine # [ 38.465431] systemd[631]: Reloading...1397machine # [ 38.604924] systemd[631]: Reloading finished in 138 ms.1398machine # [ 38.610827] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 38.618064] systemd[631]: Stopped Run user-specific NixOS activation.1400machine # [ 38.618909] systemd[631]: Stopping Run user-specific NixOS activation...1401machine # [ 38.621569] systemd[631]: Starting Run user-specific NixOS activation...1402machine # [ 38.657409] systemd[631]: Finished Run user-specific NixOS activation.1403machine # [ 38.660960] systemd[1]: Stopped target Reactivate sysinit units.1404machine # [ 38.662454] systemd[1]: Stopping Reactivate sysinit units...1405machine # [ 38.663513] systemd[1]: Reached target Reactivate sysinit units.1406machine # [ 38.667079] systemd[1]: Reached target Local File Systems.1407machine # [ 38.670418] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1408machine # [ 38.675733] systemd[1]: Starting Create SUID/SGID Wrappers...1409machine # [ 38.676730] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1410machine # [ 38.678556] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671411machine # [ 38.680637] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1412machine # [ 38.685043] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1413machine # [ 38.686226] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1414machine # [ 38.687361] systemd[1]: Reached target Remote File Systems.1415machine # [ 38.694098] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1416machine # [ 38.696659] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1417machine # [ 38.997775] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1418machine # [ 38.999073] systemd[1]: Finished Create SUID/SGID Wrappers.1419machine # [ 39.005249] systemd[1]: Starting linger-users.service...1420machine # [ 39.055747] systemd[1]: linger-users.service: Deactivated successfully.1421machine # [ 39.058078] systemd[1]: Finished linger-users.service.1422machine # [ 39.313779] nixos[1957]: finished switching to system configuration /nix/store/jc9g2ndf18qxfkiijb40czjc4qc0qday-nixos-system-machine-test1423machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 3.28 seconds)1424(finished: subtest: systemd restarts, in 3.28 seconds)1425subtest: continuing from an aborted switch1426machine: must succeed: echo dbus-broker.service > /run/nixos/start-list1427machine: (finished: must succeed: echo dbus-broker.service > /run/nixos/start-list, in 0.02 seconds)1428machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11429machine # [ 39.922927] nixos[2135]: switching to system configuration /nix/store/jc9g2ndf18qxfkiijb40czjc4qc0qday-nixos-system-machine-test1430machine # [ 39.925471] systemd[1]: Stopped target Local File Systems.1431machine # [ 39.926951] systemd[1]: Stopped target Remote File Systems.1432machine # [ 40.327820] systemd[1]: Reload requested from client PID 2135 ('.switch-to-conf') (unit backdoor.service)...1433machine # [ 40.329494] systemd[1]: Reloading...1434machine # [ 40.816293] systemd[1]: Reloading finished in 484 ms.1435machine # [ 40.930110] systemd[631]: Reexecution requested from client PID 2204 ('switch-to-confi')...1436machine # [ 40.931407] systemd[631]: Reexecuting.1437machine # [ 40.957714] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1438machine # [ 41.090767] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1439machine # [ 41.096673] systemd[631]: Reload requested from client PID 2204 ('switch-to-confi')...1440machine # [ 41.097882] systemd[631]: Reloading...1441machine # [ 41.235514] systemd[631]: Reloading finished in 135 ms.1442machine # [ 41.239818] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1443machine # [ 41.246299] systemd[631]: Stopped Run user-specific NixOS activation.1444machine # [ 41.248175] systemd[631]: Stopping Run user-specific NixOS activation...1445machine # [ 41.250232] systemd[631]: Starting Run user-specific NixOS activation...1446machine # [ 41.285582] systemd[631]: Finished Run user-specific NixOS activation.1447machine # [ 41.288924] systemd[1]: Stopped target Reactivate sysinit units.1448machine # [ 41.290625] systemd[1]: Stopping Reactivate sysinit units...1449machine # [ 41.291676] systemd[1]: Reached target Reactivate sysinit units.1450machine # [ 41.294355] systemd[1]: Reached target Remote File Systems.1451machine # [ 41.297287] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1452machine # [ 41.298946] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1453machine # [ 41.301052] systemd[1]: Reached target Local File Systems.1454machine # [ 41.303744] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1455machine # [ 41.309336] systemd[1]: Starting Create SUID/SGID Wrappers...1456machine # [ 41.310257] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1457machine # [ 41.311414] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671458machine # [ 41.313319] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1459machine # [ 41.314781] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1460machine # [ 41.315916] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1461machine # [ 41.599109] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1462machine # [ 41.601599] systemd[1]: Finished Create SUID/SGID Wrappers.1463machine # [ 41.605261] systemd[1]: Starting linger-users.service...1464machine # [ 41.653061] systemd[1]: linger-users.service: Deactivated successfully.1465machine # [ 41.654612] systemd[1]: Finished linger-users.service.1466machine # [ 41.912638] nixos[2135]: finished switching to system configuration /nix/store/jc9g2ndf18qxfkiijb40czjc4qc0qday-nixos-system-machine-test1467machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 2.57 seconds)1468(finished: subtest: continuing from an aborted switch, in 2.60 seconds)1469subtest: aborts on already locked lock file1470??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1471 File "/nix/store/wqwvv2w9ih8r1f0lsa0h3fqf91nblq7g-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391472machine # Could not acquire lock1473(finished: subtest: aborts on already locked lock file, in 0.07 seconds)1474subtest: fstab mounts1475machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&11476machine # [ 42.491743] nixos[2281]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1477machine # [ 42.494063] systemd[1]: Stopped target Remote File Systems.1478machine # [ 42.495707] systemd[1]: Stopped target Local File Systems.1479machine # [ 42.875620] systemd[1]: Reexecution requested from client PID 2281 ('.switch-to-conf') (unit backdoor.service)...1480machine # [ 42.879514] systemd[1]: Reexecuting.1481machine # [ 43.176853] systemd[1]: systemd 262-9457f81 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)1482machine # [ 43.184443] systemd[1]: Detected virtualization kvm.1483machine # [ 43.186238] systemd[1]: Detected architecture x86-64.1484machine # [ 43.284168] systemd[1]: bpf-restrict-fs: LSM BPF program attached1485machine # [ 43.626994] systemd[1]: Reload requested from client PID 2281 ('.switch-to-conf') (unit backdoor.service)...1486machine # [ 43.628754] systemd[1]: Reloading...1487machine # [ 44.122959] systemd[1]: Reloading finished in 492 ms.1488machine # [ 44.244296] systemd[631]: Reexecution requested from client PID 2384 ('switch-to-confi')...1489machine # [ 44.246603] systemd[631]: Reexecuting.1490machine # [ 44.273714] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 44.413140] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1492machine # [ 44.418811] systemd[631]: Reload requested from client PID 2384 ('switch-to-confi')...1493machine # [ 44.420588] systemd[631]: Reloading...1494machine # [ 44.549142] systemd[631]: Reloading finished in 127 ms.1495machine # [ 44.554838] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1496machine # [ 44.561074] systemd[631]: Stopped Run user-specific NixOS activation.1497machine # [ 44.562904] systemd[631]: Stopping Run user-specific NixOS activation...1498machine # [ 44.565103] systemd[631]: Starting Run user-specific NixOS activation...1499machine # [ 44.600180] systemd[631]: Finished Run user-specific NixOS activation.1500machine # [ 44.603352] systemd[1]: Stopped target Reactivate sysinit units.1501machine # [ 44.604617] systemd[1]: Stopping Reactivate sysinit units...1502machine # [ 44.605615] systemd[1]: Reached target Reactivate sysinit units.1503machine # [ 44.610038] systemd[1]: Reached target Local File Systems.1504machine # [ 44.612181] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1505machine # [ 44.616193] systemd[1]: Starting Create SUID/SGID Wrappers...1506machine # [ 44.617134] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1507machine # [ 44.618281] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671508machine # [ 44.621258] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1509machine # [ 44.623555] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1510machine # [ 44.626137] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1511machine # [ 44.627603] systemd[1]: Reached target Remote File Systems.1512machine # [ 44.632637] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1513machine # [ 44.634120] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1514machine # [ 44.920823] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1515machine # [ 44.922072] systemd[1]: Finished Create SUID/SGID Wrappers.1516machine # [ 44.927418] systemd[1]: Starting linger-users.service...1517machine # [ 44.972717] systemd[1]: linger-users.service: Deactivated successfully.1518machine # [ 44.974238] systemd[1]: Finished linger-users.service.1519machine # [ 45.230672] nixos[2281]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1520machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 3.24 seconds)1521machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11522machine # [ 45.767475] nixos[2455]: switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1523machine # [ 45.769867] systemd[1]: Stopped target Local File Systems.1524machine # [ 45.771554] systemd[1]: Stopped target Remote File Systems.1525machine # [ 46.215867] systemd[1]: Reload requested from client PID 2455 ('.switch-to-conf') (unit backdoor.service)...1526machine # [ 46.217526] systemd[1]: Reloading...1527machine # [ 46.712213] systemd[1]: Reloading finished in 492 ms.1528machine # [ 46.826740] systemd[631]: Reexecution requested from client PID 2524 ('switch-to-confi')...1529machine # [ 46.828060] systemd[631]: Reexecuting.1530machine # [ 46.856590] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1531machine # [ 46.993104] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1532machine # [ 46.998245] systemd[631]: Reload requested from client PID 2524 ('switch-to-confi')...1533machine # [ 46.999700] systemd[631]: Reloading...1534machine # [ 47.136405] systemd[631]: Reloading finished in 134 ms.1535machine # [ 47.140810] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 47.147489] systemd[631]: Stopped Run user-specific NixOS activation.1537machine # [ 47.148455] systemd[631]: Stopping Run user-specific NixOS activation...1538machine # [ 47.151593] systemd[631]: Starting Run user-specific NixOS activation...1539machine # [ 47.190534] systemd[631]: Finished Run user-specific NixOS activation.1540machine # [ 47.193972] systemd[1]: Stopped target Reactivate sysinit units.1541machine # [ 47.195647] systemd[1]: Stopping Reactivate sysinit units...1542machine # [ 47.196751] systemd[1]: Reached target Reactivate sysinit units.1543machine # [ 47.199839] systemd[1]: Reached target Remote File Systems.1544machine # [ 47.204173] systemd[1]: Mounting /test...1545machine # [ 47.208726] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1546machine # [ 47.209903] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1547machine # [ 47.218951] systemd[1]: Starting linger-users.service...1548machine # [ 47.222389] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1549machine # [ 47.227738] systemd[1]: Starting Create SUID/SGID Wrappers...1550machine # [ 47.228537] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671551machine # [ 47.230430] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1552machine # [ 47.231882] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1553machine # [ 47.233068] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1554machine # [ 47.258101] systemd[1]: Mounted /test.1555machine # [ 47.259774] systemd[1]: Reached target Local File Systems.1556machine # [ 47.260565] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1557machine # [ 47.294629] systemd[1]: linger-users.service: Deactivated successfully.1558machine # [ 47.297531] systemd[1]: Finished linger-users.service.1559machine # [ 47.531411] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1560machine # [ 47.534057] systemd[1]: Finished Create SUID/SGID Wrappers.1561machine # [ 47.791313] nixos[2455]: finished switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1562machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.56 seconds)1563machine: must succeed: systemctl stop test.mount1564machine # [ 47.838785] systemd[1]: Stopped target Local File Systems.1565machine # [ 47.844090] systemd[1]: Unmounting /test...1566machine # [ 47.879287] systemd[1]: test.mount: Deactivated successfully.1567machine # [ 47.880827] systemd[1]: Unmounted /test.1568machine: (finished: must succeed: systemctl stop test.mount, in 0.08 seconds)1569machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11570machine # [ 48.300096] nixos[2603]: switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1571machine # [ 48.302412] systemd[1]: Stopped target Remote File Systems.1572machine # [ 48.652826] systemd[1]: Reload requested from client PID 2603 ('.switch-to-conf') (unit backdoor.service)...1573machine # [ 48.654444] systemd[1]: Reloading...1574machine # [ 49.131041] systemd[1]: Reloading finished in 474 ms.1575machine # [ 49.247312] systemd[631]: Reexecution requested from client PID 2672 ('switch-to-confi')...1576machine # [ 49.249636] systemd[631]: Reexecuting.1577machine # [ 49.278776] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 49.419280] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 49.425407] systemd[631]: Reload requested from client PID 2672 ('switch-to-confi')...1580machine # [ 49.426627] systemd[631]: Reloading...1581machine # [ 49.572674] systemd[631]: Reloading finished in 144 ms.1582machine # [ 49.577835] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 49.585088] systemd[631]: Stopped Run user-specific NixOS activation.1584machine # [ 49.585950] systemd[631]: Stopping Run user-specific NixOS activation...1585machine # [ 49.588563] systemd[631]: Starting Run user-specific NixOS activation...1586machine # [ 49.625315] systemd[631]: Finished Run user-specific NixOS activation.1587machine # [ 49.628754] systemd[1]: Stopped target Reactivate sysinit units.1588machine # [ 49.630455] systemd[1]: Stopping Reactivate sysinit units...1589machine # [ 49.631478] systemd[1]: Reached target Reactivate sysinit units.1590machine # [ 49.638514] systemd[1]: Mounting /test...1591machine # [ 49.639672] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1592machine # [ 49.642895] systemd[1]: Starting Create SUID/SGID Wrappers...1593machine # [ 49.643673] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671594machine # [ 49.645538] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1595machine # [ 49.649395] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1596machine # [ 49.650628] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1597machine # [ 49.661275] systemd[1]: Reached target Remote File Systems.1598machine # [ 49.663960] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1599machine # [ 49.665855] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1600machine # [ 49.690166] systemd[1]: Mounted /test.1601machine # [ 49.692950] systemd[1]: Reached target Local File Systems.1602machine # [ 49.693703] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1603machine # [ 49.914257] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1604machine # [ 49.915863] systemd[1]: Finished Create SUID/SGID Wrappers.1605machine # [ 49.920204] systemd[1]: Starting linger-users.service...1606machine # [ 49.962896] systemd[1]: linger-users.service: Deactivated successfully.1607machine # [ 49.964371] systemd[1]: Finished linger-users.service.1608machine # [ 50.221498] nixos[2603]: finished switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1609machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.34 seconds)1610machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&11611machine # [ 50.830454] nixos[2745]: switching to system configuration /nix/store/z0cmm1g3zgzxd7q7dxw4p9bmvpnjlzgr-nixos-system-machine-test1612machine # [ 50.833873] systemd[1]: Stopped target Local File Systems.1613machine # [ 50.834708] systemd[1]: Stopped target Remote File Systems.1614machine # [ 51.311859] systemd[1]: Reload requested from client PID 2745 ('.switch-to-conf') (unit backdoor.service)...1615machine # [ 51.313502] systemd[1]: Reloading...1616machine # [ 51.876127] systemd[1]: Reloading finished in 559 ms.1617machine # [ 52.011417] systemd[631]: Reexecution requested from client PID 2814 ('switch-to-confi')...1618machine # [ 52.013778] systemd[631]: Reexecuting.1619machine # [ 52.041609] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1620machine # [ 52.199955] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1621machine # [ 52.205262] systemd[631]: Reload requested from client PID 2814 ('switch-to-confi')...1622machine # [ 52.206441] systemd[631]: Reloading...1623machine # [ 52.362889] systemd[631]: Reloading finished in 154 ms.1624machine # [ 52.367830] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1625machine # [ 52.375096] systemd[631]: Stopped Run user-specific NixOS activation.1626machine # [ 52.376029] systemd[631]: Stopping Run user-specific NixOS activation...1627machine # [ 52.379190] systemd[631]: Starting Run user-specific NixOS activation...1628machine # [ 52.418666] systemd[631]: Finished Run user-specific NixOS activation.1629machine # [ 52.421817] systemd[1]: Stopped target Reactivate sysinit units.1630machine # [ 52.423253] systemd[1]: Stopping Reactivate sysinit units...1631machine # [ 52.424948] systemd[1]: Reached target Reactivate sysinit units.1632machine # [ 52.427436] systemd[1]: Reloading /test...1633machine # [ 52.458074] systemd[1]: Reloaded /test.1634machine # [ 52.462408] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1635machine # [ 52.464109] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1636machine # [ 52.466689] systemd[1]: Reached target Remote File Systems.1637machine # [ 52.470672] systemd[1]: Starting linger-users.service...1638machine # [ 52.472059] systemd[1]: Reached target Local File Systems.1639machine # [ 52.474833] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1640machine # [ 52.480711] systemd[1]: Starting Create SUID/SGID Wrappers...1641machine # [ 52.481793] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1642machine # [ 52.483095] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671643machine # [ 52.485151] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1644machine # [ 52.486610] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 52.487727] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 52.545606] systemd[1]: linger-users.service: Deactivated successfully.1647machine # [ 52.546536] systemd[1]: Finished linger-users.service.1648machine # [ 52.819757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1649machine # [ 52.821086] systemd[1]: Finished Create SUID/SGID Wrappers.1650machine # [ 53.078991] nixos[2745]: finished switching to system configuration /nix/store/z0cmm1g3zgzxd7q7dxw4p9bmvpnjlzgr-nixos-system-machine-test1651machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1, in 2.86 seconds)1652machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&11653machine # [ 53.689373] nixos[2887]: switching to system configuration /nix/store/29xnhfvr1yd22y5ld4v4ikrjcfw2k4sq-nixos-system-machine-test1654machine # [ 53.691607] systemd[1]: Stopped target Local File Systems.1655machine # [ 53.693517] systemd[1]: Stopped target Remote File Systems.1656machine # [ 54.167564] systemd[1]: Reload requested from client PID 2887 ('.switch-to-conf') (unit backdoor.service)...1657machine # [ 54.169271] systemd[1]: Reloading...1658machine # [ 54.575908] systemd[1]: Reloading finished in 404 ms.1659machine # [ 54.697760] systemd[631]: Reexecution requested from client PID 2956 ('switch-to-confi')...1660machine # [ 54.699036] systemd[631]: Reexecuting.1661machine # [ 54.726856] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1662machine # [ 54.863495] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1663machine # [ 54.869403] systemd[631]: Reload requested from client PID 2956 ('switch-to-confi')...1664machine # [ 54.871150] systemd[631]: Reloading...1665machine # [ 55.010351] systemd[631]: Reloading finished in 137 ms.1666machine # [ 55.015855] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1667machine # [ 55.023093] systemd[631]: Stopped Run user-specific NixOS activation.1668machine # [ 55.023947] systemd[631]: Stopping Run user-specific NixOS activation...1669machine # [ 55.026928] systemd[631]: Starting Run user-specific NixOS activation...1670machine # [ 55.061863] systemd[631]: Finished Run user-specific NixOS activation.1671machine # [ 55.065541] systemd[1]: Stopped target Reactivate sysinit units.1672machine # [ 55.066977] systemd[1]: Stopping Reactivate sysinit units...1673machine # [ 55.067990] systemd[1]: Reached target Reactivate sysinit units.1674machine # [ 55.070667] systemd[1]: Unmounting /test...1675machine # [ 55.098200] systemd[1]: test.mount: Deactivated successfully.1676machine # [ 55.099708] systemd[1]: Unmounted /test.1677machine # [ 55.103266] systemd[1]: Mounting /test...1678machine # [ 55.131086] systemd[1]: Mounted /test.1679machine # [ 55.136338] systemd[1]: Reached target Local File Systems.1680machine # [ 55.140217] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1681machine # [ 55.144354] systemd[1]: Starting Create SUID/SGID Wrappers...1682machine # [ 55.145187] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1683machine # [ 55.147115] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671684machine # [ 55.149333] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1685machine # [ 55.151646] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1686machine # [ 55.152973] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1687machine # [ 55.158039] systemd[1]: Reached target Remote File Systems.1688machine # [ 55.163061] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1689machine # [ 55.164597] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1690machine # [ 55.445557] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1691machine # [ 55.446648] systemd[1]: Finished Create SUID/SGID Wrappers.1692machine # [ 55.451261] systemd[1]: Starting linger-users.service...1693machine # [ 55.498965] systemd[1]: linger-users.service: Deactivated successfully.1694machine # [ 55.501215] systemd[1]: Finished linger-users.service.1695machine # [ 55.757853] nixos[2887]: finished switching to system configuration /nix/store/29xnhfvr1yd22y5ld4v4ikrjcfw2k4sq-nixos-system-machine-test1696machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1, in 2.68 seconds)1697machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11698machine # [ 56.315298] nixos[3031]: switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1699machine # [ 56.317536] systemd[1]: Stopped target Remote File Systems.1700machine # [ 56.319401] systemd[1]: Stopped target Local File Systems.1701machine # [ 56.672747] systemd[1]: Reload requested from client PID 3031 ('.switch-to-conf') (unit backdoor.service)...1702machine # [ 56.674365] systemd[1]: Reloading...1703machine # [ 57.104136] systemd[1]: Reloading finished in 427 ms.1704machine # [ 57.218603] systemd[631]: Reexecution requested from client PID 3100 ('switch-to-confi')...1705machine # [ 57.220138] systemd[631]: Reexecuting.1706machine # [ 57.246778] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1707machine # [ 57.362818] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 57.368679] systemd[631]: Reload requested from client PID 3100 ('switch-to-confi')...1709machine # [ 57.370133] systemd[631]: Reloading...1710machine # [ 57.515243] systemd[631]: Reloading finished in 143 ms.1711machine # [ 57.520839] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1712machine # [ 57.527290] systemd[631]: Stopped Run user-specific NixOS activation.1713machine # [ 57.529060] systemd[631]: Stopping Run user-specific NixOS activation...1714machine # [ 57.531551] systemd[631]: Starting Run user-specific NixOS activation...1715machine # [ 57.568967] systemd[631]: Finished Run user-specific NixOS activation.1716machine # [ 57.572289] systemd[1]: Stopped target Reactivate sysinit units.1717machine # [ 57.573712] systemd[1]: Stopping Reactivate sysinit units...1718machine # [ 57.574704] systemd[1]: Reached target Reactivate sysinit units.1719machine # [ 57.577393] systemd[1]: Unmounting /test...1720machine # [ 57.607260] systemd[1]: test.mount: Deactivated successfully.1721machine # [ 57.608545] systemd[1]: Unmounted /test.1722machine # [ 57.612544] systemd[1]: Mounting /test...1723machine # [ 57.641817] systemd[1]: Mounted /test.1724machine # [ 57.645923] systemd[1]: Reached target Remote File Systems.1725machine # [ 57.649768] systemd[1]: Starting linger-users.service...1726machine # [ 57.651888] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1727machine # [ 57.653450] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1728machine # [ 57.661114] systemd[1]: Reached target Local File Systems.1729machine # [ 57.668072] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1730machine # [ 57.672274] systemd[1]: Starting Create SUID/SGID Wrappers...1731machine # [ 57.673986] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1732machine # [ 57.675163] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671733machine # [ 57.677101] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1734machine # [ 57.678466] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1735machine # [ 57.679650] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1736machine # [ 57.724082] systemd[1]: linger-users.service: Deactivated successfully.1737machine # [ 57.725634] systemd[1]: Finished linger-users.service.1738machine # [ 58.006631] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1739machine # [ 58.009258] systemd[1]: Finished Create SUID/SGID Wrappers.1740machine # [ 58.262702] nixos[3031]: finished switching to system configuration /nix/store/p2w50zslsfwjmd8cjxsdymkm7yv5jbcx-nixos-system-machine-test1741machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.50 seconds)1742machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&11743machine # [ 58.900656] nixos[3175]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1744machine # [ 58.903258] systemd[1]: Stopped target Remote File Systems.1745machine # [ 58.905428] systemd[1]: Stopped target Local File Systems.1746machine # [ 58.908409] systemd[1]: Unmounting /test...1747machine # [ 58.938689] systemd[1]: test.mount: Deactivated successfully.1748machine # [ 58.940228] systemd[1]: Unmounted /test.1749machine # [ 59.374738] systemd[1]: Reload requested from client PID 3175 ('.switch-to-conf') (unit backdoor.service)...1750machine # [ 59.376388] systemd[1]: Reloading...1751machine # [ 59.913628] systemd[1]: Reloading finished in 534 ms.1752machine # [ 60.022317] systemd[631]: Reexecution requested from client PID 3246 ('switch-to-confi')...1753machine # [ 60.024468] systemd[631]: Reexecuting.1754machine # [ 60.051825] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1755machine # [ 60.184743] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 60.189789] systemd[631]: Reload requested from client PID 3246 ('switch-to-confi')...1757machine # [ 60.191070] systemd[631]: Reloading...1758machine # [ 60.347430] systemd[631]: Reloading finished in 154 ms.1759machine # [ 60.351842] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1760machine # [ 60.358709] systemd[631]: Stopped Run user-specific NixOS activation.1761machine # [ 60.359657] systemd[631]: Stopping Run user-specific NixOS activation...1762machine # [ 60.363300] systemd[631]: Starting Run user-specific NixOS activation...1763machine # [ 60.402557] systemd[631]: Finished Run user-specific NixOS activation.1764machine # [ 60.405903] systemd[1]: Stopped target Reactivate sysinit units.1765machine # [ 60.407294] systemd[1]: Stopping Reactivate sysinit units...1766machine # [ 60.408395] systemd[1]: Reached target Reactivate sysinit units.1767machine # [ 60.413064] systemd[1]: Reached target Local File Systems.1768machine # [ 60.413810] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1769machine # [ 60.418146] systemd[1]: Starting Create SUID/SGID Wrappers...1770machine # [ 60.418983] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1771machine # [ 60.420111] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671772machine # [ 60.423473] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1773machine # [ 60.425717] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1774machine # [ 60.427777] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1775machine # [ 60.431721] systemd[1]: Reached target Remote File Systems.1776machine # [ 60.433216] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1777machine # [ 60.435243] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1778machine # [ 60.760984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1779machine # [ 60.762671] systemd[1]: Finished Create SUID/SGID Wrappers.1780machine # [ 60.767468] systemd[1]: Starting linger-users.service...1781machine # [ 60.820503] systemd[1]: linger-users.service: Deactivated successfully.1782machine # [ 60.821502] systemd[1]: Finished linger-users.service.1783machine # [ 61.079619] nixos[3175]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1784machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.82 seconds)1785machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&11786machine # [ 61.763219] nixos[3317]: switching to system configuration /nix/store/g924za7vr6dlp7pszznsc1w6zvqfw7js-nixos-system-machine-test1787machine # [ 61.766830] systemd[1]: Stopped target Local File Systems.1788machine # [ 61.767666] systemd[1]: Stopped target Remote File Systems.1789machine # [ 62.267864] systemd[1]: Reload requested from client PID 3317 ('.switch-to-conf') (unit backdoor.service)...1790machine # [ 62.269518] systemd[1]: Reloading...1791machine # [ 62.826171] systemd[1]: Reloading finished in 553 ms.1792machine # [ 62.962300] systemd[631]: Reexecution requested from client PID 3386 ('switch-to-confi')...1793machine # [ 62.964549] systemd[631]: Reexecuting.1794machine # [ 62.993705] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1795machine # [ 63.156520] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1796machine # [ 63.161722] systemd[631]: Reload requested from client PID 3386 ('switch-to-confi')...1797machine # [ 63.163465] systemd[631]: Reloading...1798machine # [ 63.327451] systemd[631]: Reloading finished in 162 ms.1799machine # [ 63.332824] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 63.340075] systemd[631]: Stopped Run user-specific NixOS activation.1801machine # [ 63.340951] systemd[631]: Stopping Run user-specific NixOS activation...1802machine # [ 63.343450] systemd[631]: Starting Run user-specific NixOS activation...1803machine # [ 63.386735] systemd[631]: Finished Run user-specific NixOS activation.1804machine # [ 63.390074] systemd[1]: Stopped target Reactivate sysinit units.1805machine # [ 63.391637] systemd[1]: Stopping Reactivate sysinit units...1806machine # [ 63.392576] systemd[1]: Reached target Reactivate sysinit units.1807machine # [ 63.398065] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1808machine # [ 63.399810] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1809machine # [ 63.402479] systemd[1]: Reached target Remote File Systems.1810machine # [ 63.406444] systemd[1]: Starting linger-users.service...1811machine # [ 63.408923] systemd[1]: Reached target Local File Systems.1812machine # [ 63.415160] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1813machine # [ 63.420601] systemd[1]: Starting Create SUID/SGID Wrappers...1814machine # [ 63.421388] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1815machine # [ 63.422486] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671816machine # [ 63.424373] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1817machine # [ 63.425786] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1818machine # [ 63.426902] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1819machine # [ 63.481567] systemd[1]: linger-users.service: Deactivated successfully.1820machine # [ 63.483102] systemd[1]: Finished linger-users.service.1821machine # [ 63.759757] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1822machine # [ 63.762313] systemd[1]: Finished Create SUID/SGID Wrappers.1823machine # [ 64.019068] nixos[3317]: finished switching to system configuration /nix/store/g924za7vr6dlp7pszznsc1w6zvqfw7js-nixos-system-machine-test1824machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1, in 2.94 seconds)1825machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&11826machine # [ 64.473719] nixos[3457]: switching to system configuration /nix/store/gqzl3i0f1psdj424xk722di33z81nrvl-nixos-system-machine-test1827machine # [ 64.476043] systemd[1]: Stopped target Remote File Systems.1828machine # [ 64.477822] systemd[1]: Stopped target Local File Systems.1829machine # [ 64.957663] systemd[1]: Reload requested from client PID 3457 ('.switch-to-conf') (unit backdoor.service)...1830machine # [ 64.959420] systemd[1]: Reloading...1831machine # [ 65.569053] systemd[1]: Reloading finished in 606 ms.1832machine # [ 65.712304] systemd[631]: Reexecution requested from client PID 3526 ('switch-to-confi')...1833machine # [ 65.714370] systemd[631]: Reexecuting.1834machine # [ 65.744160] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1835machine # [ 65.908490] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1836machine # [ 65.912750] systemd[631]: Reload requested from client PID 3526 ('switch-to-confi')...1837machine # [ 65.914377] systemd[631]: Reloading...1838machine # [ 66.085760] systemd[631]: Reloading finished in 168 ms.1839machine # [ 66.088093] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1840machine # [ 66.095738] systemd[631]: Stopped Run user-specific NixOS activation.1841machine # [ 66.096694] systemd[631]: Stopping Run user-specific NixOS activation...1842machine # [ 66.099984] systemd[631]: Starting Run user-specific NixOS activation...1843machine # [ 66.136700] systemd[631]: Finished Run user-specific NixOS activation.1844machine # [ 66.139964] systemd[1]: Stopped target Reactivate sysinit units.1845machine # [ 66.141224] systemd[1]: Stopping Reactivate sysinit units...1846machine # [ 66.141980] systemd[1]: Reached target Reactivate sysinit units.1847machine # [ 66.145887] systemd[1]: Set up automount testauto.automount.1848machine # [ 66.146680] systemd[1]: Reached target Local File Systems.1849machine # [ 66.150459] systemd[1]: Reached target Remote File Systems.1850machine # [ 66.154200] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1851machine # [ 66.158515] systemd[1]: Starting Create SUID/SGID Wrappers...1852machine # [ 66.159290] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1853machine # [ 66.160401] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671854machine # [ 66.163381] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1855machine # [ 66.165580] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1856machine # [ 66.167401] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1857machine # [ 66.171263] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1858machine # [ 66.172474] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1859machine # [ 66.483104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1860machine # [ 66.484797] systemd[1]: Finished Create SUID/SGID Wrappers.1861machine # [ 66.489749] systemd[1]: Starting linger-users.service...1862machine # [ 66.543358] systemd[1]: linger-users.service: Deactivated successfully.1863machine # [ 66.544395] systemd[1]: Finished linger-users.service.1864machine # [ 66.802879] nixos[3457]: finished switching to system configuration /nix/store/gqzl3i0f1psdj424xk722di33z81nrvl-nixos-system-machine-test1865machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1, in 2.78 seconds)1866machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&11867machine # [ 67.402477] nixos[3597]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1868machine # [ 67.405072] systemd[1]: Stopped target Local File Systems.1869machine # [ 67.407986] systemd[1]: testauto.automount: Deactivated successfully.1870machine # [ 67.408877] systemd[1]: Unset automount testauto.automount.1871machine # [ 67.410333] systemd[1]: Stopped target Remote File Systems.1872machine # [ 67.840816] systemd[1]: Reload requested from client PID 3597 ('.switch-to-conf') (unit backdoor.service)...1873machine # [ 67.842453] systemd[1]: Reloading...1874machine # [ 68.432463] systemd[1]: Reloading finished in 587 ms.1875machine # [ 68.577843] systemd[631]: Reexecution requested from client PID 3666 ('switch-to-confi')...1876machine # [ 68.579853] systemd[631]: Reexecuting.1877machine # [ 68.610283] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1878machine # [ 68.766994] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1879machine # [ 68.772224] systemd[631]: Reload requested from client PID 3666 ('switch-to-confi')...1880machine # [ 68.773642] systemd[631]: Reloading...1881machine # [ 68.931610] systemd[631]: Reloading finished in 156 ms.1882machine # [ 68.936822] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1883machine # [ 68.943874] systemd[631]: Stopped Run user-specific NixOS activation.1884machine # [ 68.944797] systemd[631]: Stopping Run user-specific NixOS activation...1885machine # [ 68.947492] systemd[631]: Starting Run user-specific NixOS activation...1886machine # [ 68.984432] systemd[631]: Finished Run user-specific NixOS activation.1887machine # [ 68.987619] systemd[1]: Stopped target Reactivate sysinit units.1888machine # [ 68.988850] systemd[1]: Stopping Reactivate sysinit units...1889machine # [ 68.989855] systemd[1]: Reached target Reactivate sysinit units.1890machine # [ 68.991889] systemd[1]: Reached target Local File Systems.1891machine # [ 68.994133] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1892machine # [ 68.997200] systemd[1]: Starting Create SUID/SGID Wrappers...1893machine # [ 68.997981] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1894machine # [ 69.000913] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671895machine # [ 69.003718] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1896machine # [ 69.005954] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1897machine # [ 69.008448] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1898machine # [ 69.009684] systemd[1]: Reached target Remote File Systems.1899machine # [ 69.012110] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1900machine # [ 69.013285] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1901machine # [ 69.259825] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1902machine # [ 69.261058] systemd[1]: Finished Create SUID/SGID Wrappers.1903machine # [ 69.265444] systemd[1]: Starting linger-users.service...1904machine # [ 69.303701] systemd[1]: linger-users.service: Deactivated successfully.1905machine # [ 69.305825] systemd[1]: Finished linger-users.service.1906machine # [ 69.559425] nixos[3597]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1907machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.75 seconds)1908(finished: subtest: fstab mounts, in 27.57 seconds)1909subtest: swaps1910machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&11911machine # [ 70.299799] nixos[3737]: switching to system configuration /nix/store/679x68ykhb794x3cy9v5q01f5gs66yk7-nixos-system-machine-test1912machine # [ 70.302343] systemd[1]: Stopped target Local File Systems.1913machine # [ 70.303858] systemd[1]: Stopped target Remote File Systems.1914machine # [ 70.813372] systemd[1]: Reload requested from client PID 3737 ('.switch-to-conf') (unit backdoor.service)...1915machine # [ 70.815052] systemd[1]: Reloading...1916machine # [ 71.452738] systemd[1]: Reloading finished in 635 ms.1917machine # [ 71.551042] systemd[631]: Reexecution requested from client PID 3806 ('switch-to-confi')...1918machine # [ 71.554069] systemd[631]: Reexecuting.1919machine # [ 71.581365] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1920machine # [ 71.725439] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1921machine # [ 71.730080] systemd[631]: Reload requested from client PID 3806 ('switch-to-confi')...1922machine # [ 71.731892] systemd[631]: Reloading...1923machine # [ 71.872520] systemd[631]: Reloading finished in 139 ms.1924machine # [ 71.877814] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1925machine # [ 71.884830] systemd[631]: Stopped Run user-specific NixOS activation.1926machine # [ 71.885710] systemd[631]: Stopping Run user-specific NixOS activation...1927machine # [ 71.888180] systemd[631]: Starting Run user-specific NixOS activation...1928machine # [ 71.923151] systemd[631]: Finished Run user-specific NixOS activation.1929machine # [ 71.926273] systemd[1]: Stopped target Reactivate sysinit units.1930machine # [ 71.927777] systemd[1]: Stopping Reactivate sysinit units...1931machine # [ 71.928729] systemd[1]: Reached target Reactivate sysinit units.1932machine # [ 71.932312] systemd[1]: Reached target Local File Systems.1933machine # [ 71.934461] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1934machine # [ 71.937273] systemd[1]: Starting Create SUID/SGID Wrappers...1935machine # [ 71.938854] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1936machine # [ 71.940529] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671937machine # [ 71.943343] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1938machine # [ 71.945423] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1939machine # [ 71.947489] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1940machine # [ 71.950157] systemd[1]: Reached target Remote File Systems.1941machine # [ 71.953321] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1942machine # [ 71.954730] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1943machine # [ 71.961573] systemd[1]: Starting Initialisation of swap device /swapfile...1944machine # [ 72.039308] mkswap-swapfile-start[3819]: Creating swap file using dd and mkswap.1945machine # [ 72.066410] mkswap-swapfile-start[3840]: 1+0 records in1946machine # [ 72.067230] mkswap-swapfile-start[3840]: 1+0 records out1947machine # [ 72.067938] mkswap-swapfile-start[3840]: 1048576 bytes (1.0 MB, 1.0 MiB) copied, 0.00292412 s, 359 MB/s1948machine # [ 72.084745] mkswap-swapfile-start[3843]: Setting up swapspace version 1, size = 1020 KiB (1044480 bytes)1949machine # [ 72.086169] mkswap-swapfile-start[3843]: no label, UUID=12c34ddf-64bc-463f-8b3f-b972c2158e791950machine # [ 72.089563] systemd[1]: mkswap-swapfile.service: Deactivated successfully.1951machine # [ 72.091101] systemd[1]: Finished Initialisation of swap device /swapfile.1952machine # [ 72.092726] systemd[1]: mkswap-swapfile.service: Consumed 27ms CPU time over 129ms wall clock time, 3.3M memory peak, 1M written to disk.1953machine # [ 72.097364] systemd[1]: Activating swap /swapfile...1954machine # [ 72.274629] Adding 1020k swap on /swapfile. Priority:-2 extents:1 across:1020k1955machine # [ 72.134412] systemd[1]: Activated swap /swapfile.1956machine # [ 72.277833] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1957machine # [ 72.279695] systemd[1]: Finished Create SUID/SGID Wrappers.1958machine # [ 72.284497] systemd[1]: Starting linger-users.service...1959machine # [ 72.335969] systemd[1]: linger-users.service: Deactivated successfully.1960machine # [ 72.337479] systemd[1]: Finished linger-users.service.1961machine # [ 72.591925] nixos[3737]: finished switching to system configuration /nix/store/679x68ykhb794x3cy9v5q01f5gs66yk7-nixos-system-machine-test1962machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1, in 3.03 seconds)1963machine: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&11964machine # [ 73.105781] systemd[1]: swapfile.swap: Deactivated successfully.1965machine # [ 73.107360] nixos[3891]: switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test1966machine # [ 73.109793] systemd[1]: Stopped target Remote File Systems.1967machine # [ 73.110986] systemd[1]: Stopped target Local File Systems.1968machine # [ 73.518925] systemd[1]: Reload requested from client PID 3891 ('.switch-to-conf') (unit backdoor.service)...1969machine # [ 73.520579] systemd[1]: Reloading...1970machine # [ 74.061898] systemd[1]: Reloading finished in 538 ms.1971machine # [ 74.189587] systemd[631]: Reexecution requested from client PID 3960 ('switch-to-confi')...1972machine # [ 74.190983] systemd[631]: Reexecuting.1973machine # [ 74.215798] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1974machine # [ 74.340126] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1975machine # [ 74.345229] systemd[631]: Reload requested from client PID 3960 ('switch-to-confi')...1976machine # [ 74.346452] systemd[631]: Reloading...1977machine # [ 74.491657] systemd[631]: Reloading finished in 143 ms.1978machine # [ 74.496848] systemd[631]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1979machine # [ 74.503240] systemd[631]: Stopped Run user-specific NixOS activation.1980machine # [ 74.505088] systemd[631]: Stopping Run user-specific NixOS activation...1981machine # [ 74.507320] systemd[631]: Starting Run user-specific NixOS activation...1982machine # [ 74.544660] systemd[631]: Finished Run user-specific NixOS activation.1983machine # [ 74.548660] systemd[1]: Stopped target Reactivate sysinit units.1984machine # [ 74.549691] systemd[1]: Stopping Reactivate sysinit units...1985machine # [ 74.550782] systemd[1]: Reached target Reactivate sysinit units.1986machine # [ 74.556273] systemd[1]: Reached target Remote File Systems.1987machine # [ 74.558842] systemd[1]: Reached target Local File Systems.1988machine # [ 74.560837] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1989machine # [ 74.562480] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1990machine # [ 74.565115] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1991machine # [ 74.570021] systemd[1]: Starting Create SUID/SGID Wrappers...1992machine # [ 74.570812] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1993machine # [ 74.571950] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671994machine # [ 74.574830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1995machine # [ 74.576983] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1996machine # [ 74.578994] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1997machine # [ 74.872300] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1998machine # [ 74.873851] systemd[1]: Finished Create SUID/SGID Wrappers.1999machine # [ 74.878493] systemd[1]: Starting linger-users.service...2000machine # [ 74.927772] systemd[1]: linger-users.service: Deactivated successfully.2001machine # [ 74.928779] systemd[1]: Finished linger-users.service.2002machine # [ 75.183664] nixos[3891]: finished switching to system configuration /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test2003machine: (finished: must succeed: /nix/store/47x71a1wv6w095br8zyds33m8sxj1a24-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.59 seconds)2004(finished: subtest: swaps, in 5.62 seconds)2005(finished: run the VM test script, in 76.07 seconds)2006test script finished in 76.10s2007cleanup2008kill QemuMachine (pid 45)2009machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/b5bpi6zfajzzrwwpgba2q6li3nnya4bs-python3-3.14.7/bin/python3.14)2010(finished: cleanup, in 0.13 seconds)2011additionally exposed symbols:2012 machine, other,2013 vlan1,2014 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