vm-test-run-switch-test-basics
checks.x86_64-linux.switchTest-basics
· build #19
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/tmp.pBnZ8styUV', 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: 57a3eab9-0c44-4042-a129-b65fa839d64217machine # 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)... o[ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Aug 28 06:22:54 UTC 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/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/init regInfo=/nix/store/ys52nh56hxzs5bb06qgjg903zm6b5n0z-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 452317115 cycles62machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns63machine # [ 0.000004] tsc: Detected 2400.010 MHz processor64machine # [ 0.000814] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000065machine # [ 0.000842] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs66machine # [ 0.000844] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT67machine # [ 0.002746] found SMP MP-table at [mem 0x000f5450-0x000f545f]68machine # [ 0.002758] Using GB pages for direct mapping69machine # [ 0.002830] RAMDISK: [mem 0x3e429000-0x3ffcffff]70machine # [ 0.002837] ACPI: Early table checksum verification disabled71machine # [ 0.002840] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )72machine # [ 0.002844] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)73machine # [ 0.002848] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)74machine # [ 0.002855] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)75machine # [ 0.002857] ACPI: FACS 0x000000003FFE0000 00004076machine # [ 0.002858] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)77machine # [ 0.002860] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)78machine # [ 0.002861] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)79machine # [ 0.002863] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)80machine # [ 0.002864] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]81machine # [ 0.002865] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]82machine # [ 0.002866] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]83machine # [ 0.002866] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]84machine # [ 0.002867] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]85machine # [ 0.002867] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]86machine # [ 0.002868] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]87machine # [ 0.003089] No NUMA configuration found88machine # [ 0.003090] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]89machine # [ 0.003092] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]90machine # [ 0.005344] Zone ranges:91machine # [ 0.005345] DMA [mem 0x0000000000001000-0x0000000000ffffff]92machine # [ 0.005347] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]93machine # [ 0.005348] Normal empty94machine # [ 0.005349] Device empty95machine # [ 0.005349] Movable zone start for each node96machine # [ 0.005350] Early memory node ranges97machine # [ 0.005351] node 0: [mem 0x0000000000001000-0x000000000009efff]98machine # [ 0.005352] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]99machine # [ 0.005353] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]100machine # [ 0.005371] On node 0, zone DMA: 1 pages in unavailable ranges101machine # [ 0.005615] On node 0, zone DMA: 97 pages in unavailable ranges102machine # [ 0.022118] On node 0, zone DMA32: 40 pages in unavailable ranges103machine # [ 0.022573] ACPI: PM-Timer IO Port: 0x608104machine # [ 0.022583] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])105machine # [ 0.022609] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23106machine # [ 0.022611] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)107machine # [ 0.022613] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)108machine # [ 0.022614] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)109machine # [ 0.022615] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)110machine # [ 0.022616] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)111machine # [ 0.022618] ACPI: Using ACPI (MADT) for SMP configuration information112machine # [ 0.022619] ACPI: HPET id: 0x8086a201 base: 0xfed00000113machine # [ 0.022622] TSC deadline timer available114machine # [ 0.022626] CPU topo: Max. logical packages: 1115machine # [ 0.022627] CPU topo: Max. logical dies: 1116machine # [ 0.022627] CPU topo: Max. dies per package: 1117machine # [ 0.022630] CPU topo: Max. threads per core: 1118machine # [ 0.022631] CPU topo: Num. cores per package: 1119machine # [ 0.022631] CPU topo: Num. threads per package: 1120machine # [ 0.022632] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs121machine # [ 0.022648] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()122machine # [ 0.022678] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]123machine # [ 0.022679] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]124machine # [ 0.022681] [mem 0x40000000-0xafffffff] available for PCI devices125machine # [ 0.022682] Booting paravirtualized kernel on KVM126machine # [ 0.022685] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns127machine # [ 0.027127] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1128machine # [ 0.029184] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152129machine # [ 0.029226] kvm-guest: PV spinlocks disabled, single CPU130machine # [ 0.029228] 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/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/init regInfo=/nix/store/ys52nh56hxzs5bb06qgjg903zm6b5n0z-closure-info/registration console=ttyS0,115200n8 console=tty0131machine # [ 0.029329] Unknown kernel command line parameters "regInfo=/nix/store/ys52nh56hxzs5bb06qgjg903zm6b5n0z-closure-info/registration", will be passed to user space.132machine # [ 0.029341] random: crng init done133machine # [ 0.029342] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes134machine # [ 0.029362] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)135machine # [ 0.029374] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)136machine # [ 0.029404] Fallback order for Node 0: 0137machine # [ 0.029407] Built 1 zonelists, mobility grouping on. Total pages: 262006138machine # [ 0.029408] Policy zone: DMA32139machine # [ 0.031697] mem auto-init: stack:all(zero), heap alloc:on, heap free:off140machine # [ 0.033947] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1141machine # [ 0.036076] allocated 2097152 bytes of page_ext142machine # [ 0.045399] ftrace: allocating 48733 entries in 192 pages143machine # [ 0.045401] ftrace: allocated 192 pages with 2 groups144machine # [ 0.046204] Dynamic Preempt: lazy145machine # [ 0.046346] rcu: Preemptible hierarchical RCU implementation.146machine # [ 0.046346] rcu: RCU event tracing is enabled.147machine # [ 0.046347] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.148machine # [ 0.046348] Trampoline variant of Tasks RCU enabled.149machine # [ 0.046349] Rude variant of Tasks RCU enabled.150machine # [ 0.046349] Tracing variant of Tasks RCU enabled.151machine # [ 0.046350] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.152machine # [ 0.046351] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1153machine # [ 0.046402] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.154machine # [ 0.046403] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.155machine # [ 0.046404] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.156machine # [ 0.050693] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16157machine # [ 0.050959] rcu: srcu_init: Setting srcu_struct sizes based on contention.158machine # [ 0.050965] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns159machine # [ 0.051067] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)160machine # [ 0.054583] Console: colour VGA+ 80x25161machine # [ 0.054587] printk: legacy console [tty0] enabled162machine # [ 0.083636] printk: legacy console [ttyS0] enabled163machine # [ 0.190419] ACPI: Core revision 20250807164machine # [ 0.191325] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns165machine # [ 0.192893] APIC: Switch to symmetric I/O mode setup166machine # [ 0.193939] x2apic enabled167machine # [ 0.194691] APIC: Switched APIC routing to: physical x2apic168machine # [ 0.196604] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1169machine # [ 0.197684] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns170machine # [ 0.199440] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400010)171machine # [ 0.201497] x86/cpu: User Mode Instruction Prevention (UMIP) activated172machine # [ 0.202583] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127173machine # [ 0.203437] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0174machine # [ 0.204441] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto175machine # [ 0.205437] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl176machine # [ 0.206437] Transient Scheduler Attacks: Vulnerable: No microcode177machine # [ 0.207437] Spectre V2 : Mitigation: Enhanced / Automatic IBRS178machine # [ 0.208437] Speculative Return Stack Overflow: Mitigation: Safe RET179machine # [ 0.209436] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization180machine # [ 0.211446] Spectre V2 : Enabling IBPB for BPF181machine # [ 0.212438] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier182machine # [ 0.213437] active return thunk: srso_alias_return_thunk183machine # [ 0.215144] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'184machine # [ 0.216436] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'185machine # [ 0.217437] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'186machine # [ 0.218437] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'187machine # [ 0.219436] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'188machine # [ 0.220436] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'189machine # [ 0.221436] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'190machine # [ 0.222437] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256191machine # [ 0.224234] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64192machine # [ 0.225233] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512193machine # [ 0.226221] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024194machine # [ 0.227218] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8195machine # [ 0.228219] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.196machine # [ 0.262476] Freeing SMP alternatives memory: 44K197machine # [ 0.263308] pid_max: default: 32768 minimum: 301198machine # [ 0.264105] LSM: initializing lsm=capability,landlock,yama,bpf,ima199machine # [ 0.264530] landlock: Up and running.200machine # [ 0.265922] Yama: becoming mindful.201machine # [ 0.266658] LSM support for eBPF active202machine # [ 0.267542] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)203machine # [ 0.268456] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)204machine # [ 0.271173] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)205machine # [ 0.271932] Performance Events: Fam17h+ core perfctr, AMD PMU driver.206machine # [ 0.272442] ... version: 2207machine # [ 0.273131] ... bit width: 48208machine # [ 0.273439] ... generic counters: 6209machine # [ 0.274185] ... generic bitmap: 000000000000003f210machine # [ 0.274486] ... fixed-purpose counters: 0211machine # [ 0.275225] ... fixed-purpose bitmap: 0000000000000000212machine # [ 0.276167] ... value mask: 0000ffffffffffff213machine # [ 0.276439] ... max period: 00007fffffffffff214machine # [ 0.277382] ... global_ctrl mask: 000000000000003f215machine # [ 0.278299] signal: max sigframe size: 3376216machine # [ 0.279099] rcu: Hierarchical SRCU implementation.217machine # [ 0.279443] rcu: Max phase no-delay instances is 400.218machine # [ 0.284812] smp: Bringing up secondary CPUs ...219machine # [ 0.285454] smp: Brought up 1 node, 1 CPU220machine # [ 0.286161] smpboot: Total of 1 processors activated (4800.02 BogoMIPS)221machine # [ 0.286644] Memory: 941796K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 98840K reserved, 0K cma-reserved)222machine # [ 0.287675] devtmpfs: initialized223machine # [ 0.288510] x86/mm: Memory block size: 128MB224machine # [ 0.290285] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)225machine # [ 0.291385] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).226machine # [ 0.292516] pinctrl core: initialized pinctrl subsystem227machine # [ 0.293657] PM: RTC time: 02:41:32, date: 2026-09-03228machine # [ 0.297014] NET: Registered PF_NETLINK/PF_ROUTE protocol family229machine # [ 0.297791] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations230machine # [ 0.298455] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations231machine # [ 0.299578] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations232machine # [ 0.300449] audit: initializing netlink subsys (disabled)233machine # [ 0.301619] thermal_sys: Registered thermal governor 'fair_share'234machine # [ 0.301621] thermal_sys: Registered thermal governor 'bang_bang'235machine # [ 0.302442] audit: type=2000 audit(1788403293.302:1): state=initialized audit_enabled=0 res=1236machine # [ 0.304440] thermal_sys: Registered thermal governor 'step_wise'237machine # [ 0.304442] thermal_sys: Registered thermal governor 'user_space'238machine # [ 0.305439] thermal_sys: Registered thermal governor 'power_allocator'239machine # [ 0.306454] cpuidle: using governor menu240machine # [ 0.308710] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5241machine # [ 0.309735] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]242machine # [ 0.310443] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry243machine # [ 0.311451] PCI: Using configuration type 1 for base access244machine # [ 0.312618] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.245machine # [ 0.319472] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages246machine # [ 0.320440] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page247machine # [ 0.325440] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages248machine # [ 0.326441] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page249machine # [ 0.337676] ACPI: Added _OSI(Module Device)250machine # [ 0.338419] ACPI: Added _OSI(Processor Device)251machine # [ 0.339008] ACPI: Added _OSI(Processor Aggregator Device)252machine # [ 0.345221] ACPI: 1 ACPI AML tables successfully acquired and loaded253machine # [ 0.351695] ACPI: Interpreter enabled254machine # [ 0.352394] ACPI: PM: (supports S0 S3 S4 S5)255machine # [ 0.352993] ACPI: Using IOAPIC for interrupt routing256machine # [ 0.353502] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug257machine # [ 0.354440] PCI: Using E820 reservations for host bridge windows258machine # [ 0.357577] ACPI: Enabled 2 GPEs in block 00 to 3F259machine # [ 0.365270] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])260machine # [ 0.366261] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]261machine # [ 0.367518] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]262machine # [ 0.368562] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]263machine # [ 0.369945] PCI host bridge to bus 0000:00264machine # [ 0.370445] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]265machine # [ 0.371439] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]266machine # [ 0.372439] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]267machine # [ 0.373439] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]268machine # [ 0.374439] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]269machine # [ 0.375439] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]270machine # [ 0.376440] pci_bus 0000:00: root bus resource [bus 00-ff]271machine # [ 0.377452] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint272machine # [ 0.378913] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint273machine # [ 0.381476] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]274machine # [ 0.382453] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]275machine # [ 0.383461] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]276machine # [ 0.384760] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]277machine # [ 0.386195] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint278machine # [ 0.388464] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]279machine # [ 0.389361] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]280machine # [ 0.390232] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]281machine # [ 0.391351] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]282machine # [ 0.392816] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint283machine # [ 0.395447] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]284machine # [ 0.396336] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]285machine # [ 0.397237] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]286machine # [ 0.398937] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint287machine # [ 0.400467] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]288machine # [ 0.401357] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]289machine # [ 0.402242] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]290machine # [ 0.404029] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint291machine # [ 0.405446] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]292machine # [ 0.406344] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]293machine # [ 0.407231] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]294machine # [ 0.408906] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint295machine # [ 0.411396] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]296machine # [ 0.412122] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]297machine # [ 0.412462] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]298machine # [ 0.414013] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint299machine # [ 0.415469] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]300machine # [ 0.416370] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]301machine # [ 0.417232] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]302machine # [ 0.419041] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint303machine # [ 0.420467] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]304machine # [ 0.421375] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]305machine # [ 0.422248] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]306machine # [ 0.423373] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]307machine # [ 0.424917] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint308machine # [ 0.427034] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]309machine # [ 0.427463] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]310machine # [ 0.428996] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint311machine # [ 0.430473] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]312machine # [ 0.431405] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]313machine # [ 0.432320] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]314machine # [ 0.433917] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint315machine # [ 0.436470] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]316machine # [ 0.437386] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]317machine # [ 0.438241] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]318machine # [ 0.439908] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint319machine # [ 0.441085] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]320machine # [ 0.441659] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint321machine # [ 0.443178] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]322machine # [ 0.443659] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint323machine # [ 0.446151] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]324machine # [ 0.446690] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint325machine # [ 0.448044] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]326machine # [ 0.448708] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint327machine # [ 0.450737] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO328machine # [ 0.451700] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint329machine # [ 0.453467] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]330machine # [ 0.454347] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]331machine # [ 0.455539] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint332machine # [ 0.457074] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]333machine # [ 0.461155] ACPI: PCI: Interrupt link LNKA configured for IRQ 10334machine # [ 0.461543] ACPI: PCI: Interrupt link LNKB configured for IRQ 10335machine # [ 0.462552] ACPI: PCI: Interrupt link LNKC configured for IRQ 11336machine # [ 0.463544] ACPI: PCI: Interrupt link LNKD configured for IRQ 11337machine # [ 0.464537] ACPI: PCI: Interrupt link LNKE configured for IRQ 10338machine # [ 0.465560] ACPI: PCI: Interrupt link LNKF configured for IRQ 10339machine # [ 0.466548] ACPI: PCI: Interrupt link LNKG configured for IRQ 11340machine # [ 0.467551] ACPI: PCI: Interrupt link LNKH configured for IRQ 11341machine # [ 0.468480] ACPI: PCI: Interrupt link GSIA configured for IRQ 16342machine # [ 0.469468] ACPI: PCI: Interrupt link GSIB configured for IRQ 17343machine # [ 0.470455] ACPI: PCI: Interrupt link GSIC configured for IRQ 18344machine # [ 0.471452] ACPI: PCI: Interrupt link GSID configured for IRQ 19345machine # [ 0.472454] ACPI: PCI: Interrupt link GSIE configured for IRQ 20346machine # [ 0.473451] ACPI: PCI: Interrupt link GSIF configured for IRQ 21347machine # [ 0.474450] ACPI: PCI: Interrupt link GSIG configured for IRQ 22348machine # [ 0.475451] ACPI: PCI: Interrupt link GSIH configured for IRQ 23349machine # [ 0.477517] iommu: Default domain type: Translated350machine # [ 0.478343] iommu: DMA domain TLB invalidation policy: lazy mode351machine # [ 0.479527] ACPI: bus type USB registered352machine # [ 0.480287] usbcore: registered new interface driver usbfs353machine # [ 0.481176] usbcore: registered new interface driver hub354machine # [ 0.481456] usbcore: registered new device driver usb355machine # [ 0.483300] NetLabel: Initializing356machine # [ 0.483901] NetLabel: domain hash size = 128357machine # [ 0.484439] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO358machine # [ 0.485457] NetLabel: unlabeled traffic allowed by default359machine # [ 0.486378] PCI: Using ACPI for IRQ routing360machine # [ 0.531148] pci 0000:00:01.0: vgaarb: setting as boot VGA device361machine # [ 0.531435] pci 0000:00:01.0: vgaarb: bridge control possible362machine # [ 0.531435] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none363machine # [ 0.531444] vgaarb: loaded364machine # [ 0.532207] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0365machine # [ 0.532440] hpet0: 3 comparators, 64-bit 100.000000 MHz counter366machine # [ 0.537530] clocksource: Switched to clocksource kvm-clock367machine # [ 0.539294] VFS: Disk quotas dquot_6.6.0368machine # [ 0.541840] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)369machine # [ 0.543180] pnp: PnP ACPI init370machine # [ 0.543979] ACPI: IRQ 4 override to edge(!), high(!)371machine # [ 0.544999] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved372machine # [ 0.546586] pnp: PnP ACPI: found 6 devices373machine # [ 0.554140] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns374machine # [ 0.555654] clocksource: Switched to clocksource acpi_pm375machine # [ 0.556694] NET: Registered PF_INET protocol family376machine # [ 0.557754] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)377machine # [ 0.574613] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)378machine # [ 0.576090] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)379machine # [ 0.577451] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)380machine # [ 0.578821] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)381machine # [ 0.580088] TCP: Hash tables configured (established 8192 bind 8192)382machine # [ 0.581276] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)383machine # [ 0.582650] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)384machine # [ 0.583805] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)385machine # [ 0.585024] NET: Registered PF_UNIX/PF_LOCAL protocol family386machine # [ 0.586005] NET: Registered PF_XDP protocol family387machine # [ 0.586859] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]388machine # [ 0.587911] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]389machine # [ 0.588927] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]390machine # [ 0.590066] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]391machine # [ 0.591224] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]392machine # [ 0.592357] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]393machine # [ 0.594194] ACPI: \_SB_.GSIA: Enabled at IRQ 16394machine # [ 0.596512] ACPI: \_SB_.GSIB: Enabled at IRQ 17395machine # [ 0.598850] ACPI: \_SB_.GSIC: Enabled at IRQ 18396machine # [ 0.600890] ACPI: \_SB_.GSID: Enabled at IRQ 19397machine # [ 0.602616] PCI: CLS 0 bytes, default 64398machine # [ 0.603631] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229840d1729, max_idle_ns: 440795276167 ns399machine # [ 0.605443] Trying to unpack rootfs image as initramfs...400machine # [ 0.649231] Initialise system trusted keyrings401machine # [ 0.650210] workingset: timestamp_bits=40 max_order=18 bucket_order=0402machine # [ 0.673605] Key type asymmetric registered403machine # [ 0.674332] Asymmetric key parser 'x509' registered404machine # [ 0.675234] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)405machine # [ 0.680649] io scheduler mq-deadline registered406machine # [ 0.681461] io scheduler kyber registered407machine # [ 0.685134] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled408machine # [ 0.686445] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A409machine # [ 0.690241] Linux agpgart interface v0.103410machine # [ 0.691205] ACPI: bus type drm_connector registered411machine # [ 0.693965] usbcore: registered new interface driver usbserial_generic412machine # [ 0.695119] usbserial: USB Serial support registered for generic413machine # [ 0.698500] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.414machine # [ 0.698500] Please enable it if your BIOS has the CPPC option.415machine # [ 0.700811] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled416machine # [ 0.704630] drop_monitor: Initializing network drop monitor service417machine # [ 0.705839] NET: Registered PF_INET6 protocol family418machine # [ 0.708934] Segment Routing with IPv6419machine # [ 0.711523] In-situ OAM (IOAM) with IPv6420machine # [ 0.712603] IPI shorthand broadcast: enabled421machine # [ 0.720866] sched_clock: Marking stable (577013755, 143470312)->(790377456, -69893389)422machine # [ 0.725747] registered taskstats version 1423machine # [ 0.726757] Loading compiled-in X.509 certificates424machine # [ 0.744501] Demotion targets for Node 0: null425machine # [ 0.745410] Key type .fscrypt registered426machine # [ 0.747504] Key type fscrypt-provisioning registered427machine # [ 0.748490] ima: No TPM chip found, activating TPM-bypass!428machine # [ 0.749427] ima: Allocated hash algorithm: sha1429machine # [ 0.753531] ima: No architecture policies found430machine # [ 0.754528] PM: Magic number: 10:584:661431machine # [ 0.756104] RAS: Correctable Errors collector initialized.432machine # [ 0.766120] clk: Disabling unused clocks433machine # [ 0.768506] PM: genpd: Disabling unused power domains434machine # [ 0.915203] Freeing initrd memory: 28316K435machine # [ 0.918288] Freeing unused decrypted memory: 2028K436machine # [ 0.920909] Freeing unused kernel image (initmem) memory: 3644K437machine # [ 0.921988] Write protecting the kernel read-only data: 32768k438machine # [ 0.923892] Freeing unused kernel image (text/rodata gap) memory: 1216K439machine # [ 0.925381] Freeing unused kernel image (rodata/data gap) memory: 756K440machine # [ 0.976667] x86/mm: Checked W+X mappings: passed, no W+X pages found.441machine # [ 0.977768] Run /init as init process442machine # [ 0.987626] systemd[1]: Inserted module 'autofs4'443machine # [ 1.003683] fuse: init (API version 7.45)444machine # [ 1.009541] ACPI: \_SB_.GSIG: Enabled at IRQ 22445machine # [ 1.011843] ACPI: \_SB_.GSIH: Enabled at IRQ 23446machine # [ 1.014776] ACPI: \_SB_.GSIE: Enabled at IRQ 20447machine # [ 1.016895] ACPI: \_SB_.GSIF: Enabled at IRQ 21448machine # [ 1.043636] systemd[1]: Successfully made /usr/ read-only.449machine # [ 1.379349] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)450machine # [ 1.384549] systemd[1]: Detected virtualization kvm.451machine # [ 1.385447] systemd[1]: Detected architecture x86-64.452machine # [ 1.386361] systemd[1]: Running in initrd.453machine # [ 1.387600] systemd[1]: Initializing machine ID from random generator.454machine # [ 1.388859] systemd[1]: Hostname set to <machine>.455machine # [ 1.462322] systemd[1]: bpf-restrict-fs: LSM BPF program attached456machine # [ 1.500510] systemd[1]: Queued start job for default target Initrd Default Target.457machine # [ 1.503822] systemd[1]: Created slice Slice /system/modprobe.458machine # [ 1.504999] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.459machine # [ 1.506452] systemd[1]: Expecting device /dev/disk/by-label/nixos...460machine # [ 1.507612] systemd[1]: Reached target Path Units.461machine # [ 1.508532] systemd[1]: Reached target Slice Units.462machine # [ 1.509450] systemd[1]: Reached target Swaps.463machine # [ 1.510356] systemd[1]: Reached target Timer Units.464machine # [ 1.511412] systemd[1]: Listening on D-Bus System Message Bus Socket.465machine # [ 1.512697] systemd[1]: Listening on Journal Socket (/dev/log).466machine # [ 1.513940] systemd[1]: Listening on Journal Sockets.467machine # [ 1.514934] systemd[1]: Listening on udev Kernel Socket.468machine # [ 1.515899] systemd[1]: Reached target Socket Units.469machine # [ 1.517746] systemd[1]: Starting Create List of Static Device Nodes...470machine # [ 1.521565] systemd[1]: Starting Load Kernel Module 9pnet_virtio...471machine # [ 1.530674] systemd[1]: Starting Load Kernel Module configfs...472machine # [ 1.546567] systemd[1]: Starting Journal Service...473machine # [ 1.557325] systemd[1]: Starting Load Kernel Modules...474machine # [ 1.566588] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os475machine # [ 1.582023] netfs: FS-Cache loaded476machine # [ 1.586918] 9pnet: Installing 9P2000 support477machine # [ 1.596397] systemd[1]: Starting Coldplug All udev Devices...478machine # [ 1.613787] systemd[1]: Finished Create List of Static Device Nodes.479machine # [ 1.620211] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.480machine # [ 1.628975] systemd[1]: Finished Load Kernel Module 9pnet_virtio.481machine # [ 1.632994] systemd-journald[67]: Collecting audit messages is disabled.482machine # [ 1.635986] systemd[1]: modprobe@configfs.service: Deactivated successfully.483machine # [ 1.641889] systemd[1]: Finished Load Kernel Module configfs.484machine # [ 1.646445] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.485machine # [ 1.648994] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config486machine # [ 1.657335] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev487machine # [ 1.660560] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...488machine # [ 1.688206] systemd[1]: Finished Load Kernel Modules.489machine # [ 1.697714] systemd[1]: Starting Apply Kernel Variables...490machine # [ 1.712589] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.491machine # [ 1.722703] systemd[1]: Starting Create Static Device Nodes in /dev...492machine # [ 1.743846] systemd[1]: Finished Apply Kernel Variables.493machine # [ 1.756976] systemd[1]: Started Journal Service.494machine # [ 1.614615] systemd-modules-load[68]: Inserted module 'dm_mod'495machine # [ 1.618129] systemd-modules-load[68]: Inserted module 'virtio_balloon'496machine # [ 1.619418] systemd-modules-load[68]: Inserted module 'virtio_gpu'497machine # [ 1.626842] systemd[1]: Finished Create Static Device Nodes in /dev.498machine # [ 1.633071] systemd[1]: Reached target Preparation for Local File Systems.499machine # [ 1.634892] systemd[1]: Reached target Local File Systems.500machine # [ 1.636215] systemd[1]: Starting Create System Files and Directories...501machine # [ 1.644073] systemd[1]: Starting Rule-based Manager for Device Events and Files...502machine # [ 1.673496] systemd[1]: Finished Create System Files and Directories.503machine # [ 1.693702] systemd-udevd[83]: Using default interface naming scheme 'v261'.504machine # [ 1.719122] systemd[1]: Started Rule-based Manager for Device Events and Files.505machine # [ 1.757706] systemd[1]: Finished Coldplug All udev Devices.506machine # [ 1.760609] systemd[1]: Reached target System Initialization.507machine # [ 1.761529] systemd[1]: Reached target Basic System.508machine # [ 2.052042] virtio_blk virtio5: 1/0/0 default/read/poll queues509machine # [ 2.078507] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)510machine # [ 2.107315] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12511machine # [ 2.116803] serio: i8042 KBD port at 0x60,0x64 irq 1512machine # [ 2.129495] serio: i8042 AUX port at 0x60,0x64 irq 12513machine # [ 2.149273] ehci-pci 0000:00:1d.7: EHCI Host Controller514machine # [ 2.150219] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 1515machine # [ 2.152104] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000516machine # [ 2.159521] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00517machine # [ 2.161789] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18518machine # [ 2.162933] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1519machine # [ 2.166442] usb usb1: Product: EHCI Host Controller520machine # [ 2.167419] usb usb1: Manufacturer: Linux 6.18.48 ehci_hcd521machine # [ 2.168498] usb usb1: SerialNumber: 0000:00:1d.7522machine # [ 2.170619] hub 1-0:1.0: USB hub found523machine # [ 2.172357] hub 1-0:1.0: 6 ports detected524machine # [ 2.175945] uhci_hcd 0000:00:1d.0: UHCI Host Controller525machine # [ 2.176708] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2526machine # [ 2.190071] uhci_hcd 0000:00:1d.0: detected 2 ports527machine # [ 2.196083] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200528machine # [ 2.205285] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18529machine # [ 2.209491] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1530machine # [ 2.070995] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.531machine # [ 2.220171] usb usb2: Product: UHCI Host Controller532machine # [ 2.222408] SCSI subsystem initialized533machine # [ 2.080775] systemd[1]: Starting Virtual Console Setup...534machine # [ 2.233897] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0535machine # [ 2.239511] usb usb2: Manufacturer: Linux 6.18.48 uhci_hcd536machine # [ 2.240262] usb usb2: SerialNumber: 0000:00:1d.0537machine # [ 2.104981] (udev-worker)[90]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.538machine # [ 2.107114] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.539machine # [ 2.256863] hub 2-0:1.0: USB hub found540machine # [ 2.264499] hub 2-0:1.0: 2 ports detected541machine # [ 2.121943] systemd-vconsole-setup[99]: Configuration of first virtual console was skipped, ignoring remaining ones.542machine # [ 2.126212] systemd[1]: Finished Virtual Console Setup.543machine # [ 2.290739] uhci_hcd 0000:00:1d.1: UHCI Host Controller544machine # [ 2.291732] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3545machine # [ 2.301087] uhci_hcd 0000:00:1d.1: detected 2 ports546machine # [ 2.160669] systemd[1]: Found device /dev/disk/by-label/nixos.547machine # [ 2.162062] systemd[1]: Reached target Initrd Root Device.548machine # [ 2.306448] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220549machine # [ 2.308281] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18550machine # [ 2.166439] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...551machine # [ 2.314496] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1552machine # [ 2.316602] usb usb3: Product: UHCI Host Controller553machine # [ 2.317281] usb usb3: Manufacturer: Linux 6.18.48 uhci_hcd554machine # [ 2.319546] usb usb3: SerialNumber: 0000:00:1d.1555machine # [ 2.320969] hub 3-0:1.0: USB hub found556machine # [ 2.325632] hub 3-0:1.0: 2 ports detected557machine # [ 2.332930] uhci_hcd 0000:00:1d.2: UHCI Host Controller558machine # [ 2.337544] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4559machine # [ 2.340566] uhci_hcd 0000:00:1d.2: detected 2 ports560machine # [ 2.341347] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240561machine # [ 2.344454] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18562machine # [ 2.207625] systemd-fsck[107]: nixos: clean, 12/65536 files, 13019/262144 blocks563machine # [ 2.212584] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.564machine # [ 2.360082] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1565machine # [ 2.361821] usb usb4: Product: UHCI Host Controller566machine # [ 2.363591] usb usb4: Manufacturer: Linux 6.18.48 uhci_hcd567machine # [ 2.364376] usb usb4: SerialNumber: 0000:00:1d.2568machine # [ 2.367873] hub 4-0:1.0: USB hub found569machine # [ 2.369175] hub 4-0:1.0: 2 ports detected570machine # [ 2.370342] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode571machine # [ 2.383034] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)572machine # [ 2.383889] ahci 0000:00:1f.2: flags: 64bit ncq only573machine # [ 2.400343] scsi host0: ahci574machine # [ 2.403656] scsi host1: ahci575machine # [ 2.405590] scsi host2: ahci576machine # [ 2.410186] scsi host3: ahci577machine # [ 2.410690] usb 1-1: new high-speed USB device number 2 using ehci-pci578machine # [ 2.414460] scsi host4: ahci579machine # [ 2.417542] scsi host5: ahci580machine # [ 2.418183] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1581machine # [ 2.421610] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1582machine # [ 2.422814] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1583machine # [ 2.423955] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1584machine # [ 2.425194] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1585machine # [ 2.426352] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1586machine # [ 2.540539] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00587machine # [ 2.543367] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10588machine # [ 2.546526] usb 1-1: Product: QEMU USB Tablet589machine # [ 2.548264] usb 1-1: Manufacturer: QEMU590machine # [ 2.549902] usb 1-1: SerialNumber: 28754-0000:00:1d.7-1591machine # [ 2.578961] hid: raw HID events driver (C) Jiri Kosina592machine # [ 2.466309] systemd[1]: Mounting /sysroot...593machine # [ 2.738307] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)594machine # [ 2.740859] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100595machine # [ 2.743250] ata3.00: applying bridge limits596machine # [ 2.745203] ata4: SATA link down (SStatus 0 SControl 300)597machine # [ 2.747684] ata1: SATA link down (SStatus 0 SControl 300)598machine # [ 2.749814] ata2: SATA link down (SStatus 0 SControl 300)599machine # [ 2.752312] ata5: SATA link down (SStatus 0 SControl 300)600machine # [ 2.754791] ata6: SATA link down (SStatus 0 SControl 300)601machine # [ 2.757110] ata3.00: configured for UDMA/100602machine # [ 2.759644] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5603machine # [ 2.836658] usbcore: registered new interface driver usbhid604machine # [ 2.837501] usbhid: USB HID core driver605machine # [ 2.859141] 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.862579] 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.868652] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray608machine # [ 2.878602] cdrom: Uniform CD-ROM driver Revision: 3.20609machine # [ 2.883853] EXT4-fs (vda): mounted filesystem 57a3eab9-0c44-4042-a129-b65fa839d642 r/w with ordered data mode. Quota mode: none.610machine # [ 2.747732] systemd[1]: Mounted /sysroot.611machine # [ 2.749154] systemd[1]: Reached target Initrd Root File System.612machine # [ 2.754069] systemd[1]: Starting Mountpoints Configured in the Real Root...613machine # [ 2.770307] systemd-sysroot-fstab-check[139]: /sysroot should be mounted in the initrd, will request daemon-reload.614machine # [ 2.774061] systemd[1]: Reload requested from client PID 139 ('systemd-sysroot') (unit initrd-parse-etc.service)...615machine # [ 2.775464] systemd[1]: Reloading...616machine # [ 2.852833] systemd[1]: Reloading finished in 79 ms.617machine # [ 2.861389] systemd-sysroot-fstab-check[139]: Requesting initrd-fs.target/start/replace...618machine # [ 2.865132] systemd-sysroot-fstab-check[139]: Requesting swap.target/start/replace...619machine # [ 2.869128] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio620machine # [ 2.871184] systemd[1]: initrd-parse-etc.service: Deactivated successfully.621machine # [ 2.873066] systemd[1]: Finished Mountpoints Configured in the Real Root.622machine # [ 2.873971] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.623machine # [ 3.469191] systemd[1]: Mounting /sysroot/nix/.ro-store...624machine # [ 3.475158] systemd[1]: Mounting /sysroot/nix/.rw-store...625machine # [ 3.482166] systemd[1]: Mounting /sysroot/run...626machine # [ 3.495193] systemd[1]: Mounting /sysroot/tmp/shared...627machine # [ 3.504611] systemd[1]: Mounting /sysroot/tmp/xchg...628machine # [ 3.545973] systemd[1]: Mounted /sysroot/nix/.rw-store.629machine # [ 3.696224] 9p: Installing v9fs 9p2000 file system support630machine # [ 3.556063] systemd[1]: Mounted /sysroot/run.631machine # [ 3.565616] systemd[1]: Starting rw-sysroot-nix-store.service...632machine # [ 3.571421] systemd[1]: Mounted /sysroot/nix/.ro-store.633machine # [ 3.572862] systemd[1]: Mounted /sysroot/tmp/shared.634machine # [ 3.575249] systemd[1]: Mounted /sysroot/tmp/xchg.635machine # [ 3.585917] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.636machine # [ 3.587482] systemd[1]: Finished rw-sysroot-nix-store.service.637machine # [ 3.589845] systemd[1]: Mounting /sysroot/nix/store...638machine # [ 3.610348] systemd[1]: Mounted /sysroot/nix/store.639machine # [ 3.611446] systemd[1]: Reached target Initrd File Systems.640machine # [ 3.613143] systemd[1]: Starting Find NixOS closure...641machine # [ 3.615740] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...642machine # [ 3.634498] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.643machine # [ 3.642937] systemd[1]: Finished Find NixOS closure.644machine # [ 3.644401] systemd[1]: Reached target Initrd Default Target.645machine # [ 3.646563] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...646machine # [ 3.661775] systemd[1]: Stopped target Initrd Default Target.647machine # [ 3.663105] systemd[1]: Stopped target Basic System.648machine # [ 3.665208] systemd[1]: Stopped target Initrd Root Device.649machine # [ 3.666466] systemd[1]: Stopped target Path Units.650machine # [ 3.667455] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.651machine # [ 3.670112] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.652machine # [ 3.671169] systemd[1]: Stopped target Slice Units.653machine # [ 3.671890] systemd[1]: Stopped target Socket Units.654machine # [ 3.672935] systemd[1]: Stopped target System Initialization.655machine # [ 3.673799] systemd[1]: Stopped target Swaps.656machine # [ 3.674446] systemd[1]: Stopped target Timer Units.657machine # [ 3.675221] systemd[1]: dbus.socket: Deactivated successfully.658machine # [ 3.676033] systemd[1]: Closed D-Bus System Message Bus Socket.659machine # [ 3.676846] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.660machine # [ 3.678111] systemd[1]: Stopped Find NixOS closure.661machine # [ 3.679197] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio662machine # [ 3.682463] systemd[1]: Starting rw-sysroot-nix-store.service...663machine # [ 3.684152] systemd[1]: systemd-sysctl.service: Deactivated successfully.664machine # [ 3.685225] systemd[1]: Stopped Apply Kernel Variables.665machine # [ 3.686334] systemd[1]: systemd-modules-load.service: Deactivated successfully.666machine # [ 3.687513] systemd[1]: Stopped Load Kernel Modules.667machine # [ 3.689041] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.668machine # [ 3.690903] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.669machine # [ 3.692948] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.670machine # [ 3.693973] systemd[1]: Stopped Create System Files and Directories.671machine # [ 3.696126] systemd[1]: Stopped target Local File Systems.672machine # [ 3.696887] systemd[1]: Stopped target Preparation for Local File Systems.673machine # [ 3.697827] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.674machine # [ 3.699701] systemd[1]: Stopped Coldplug All udev Devices.675machine # [ 3.702213] systemd[1]: Stopping Rule-based Manager for Device Events and Files...676machine # [ 3.703599] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.677machine # [ 3.704653] systemd[1]: Stopped Virtual Console Setup.678machine # [ 3.713779] systemd[1]: systemd-udevd.service: Deactivated successfully.679machine # [ 3.716166] systemd[1]: Stopped Rule-based Manager for Device Events and Files.680machine # [ 3.719067] systemd[1]: initrd-cleanup.service: Deactivated successfully.681machine # [ 3.720236] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.682machine # [ 3.727079] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.683machine # [ 3.728467] systemd[1]: Finished rw-sysroot-nix-store.service.684machine # [ 3.730505] systemd[1]: Starting Cleanup udev Database...685machine # [ 3.731776] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.686machine # [ 3.732835] systemd[1]: Stopped Create Static Device Nodes in /dev.687machine # [ 3.733700] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.688machine # [ 3.735123] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.689machine # [ 3.736094] systemd[1]: kmod-static-nodes.service: Deactivated successfully.690machine # [ 3.738119] systemd[1]: Stopped Create List of Static Device Nodes.691machine # [ 3.753158] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.692machine # [ 3.755151] systemd[1]: Finished Cleanup udev Database.693machine # [ 3.756401] systemd[1]: Reached target Switch Root.694machine # [ 3.758112] systemd[1]: Starting NixOS Activation...695machine # [ 3.905349] initrd-nixos-activation-start[194]: booting system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test696machine # [ 3.964339] initrd-nixos-activation-start[194]: running activation script...697machine # [ 4.312804] initrd-nixos-activation-start[217]: setting up /etc...698machine # [ 4.538423] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.699machine # [ 4.540062] systemd[1]: Finished NixOS Activation.700machine # [ 4.541975] systemd[1]: Starting Switch Root...701machine # [ 4.554392] systemd[1]: Switching root.702machine # [ 4.835014] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).703machine # [ 4.982353] NET: Registered PF_VSOCK protocol family704machine # [ 5.367574] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)705machine # [ 5.377416] systemd[1]: Detected virtualization kvm.706machine # [ 5.379326] systemd[1]: Detected architecture x86-64.707machine # [ 5.381312] systemd[1]: Detected first boot.708machine # [ 5.388896] systemd[1]: Initializing machine ID from random generator.709machine # [ 5.517408] systemd[1]: bpf-restrict-fs: LSM BPF program attached710machine # [ 5.637786] systemd[1]: Applying preset policy.711machine # [ 6.092976] systemd[1]: Populated /etc with preset unit settings.712machine # [ 6.548529] systemd[1]: initrd-switch-root.service: Deactivated successfully.713machine # [ 6.550013] systemd[1]: Stopped initrd-switch-root.service.714machine # [ 6.552569] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.715machine # [ 6.554751] systemd[1]: Created slice Slice /system/getty.716machine # [ 6.556071] systemd[1]: Created slice User and Session Slice.717machine # [ 6.557159] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.718machine # [ 6.558383] systemd[1]: Started Forward Password Requests to Wall Directory Watch.719machine # [ 6.559525] systemd[1]: Expecting device /dev/hvc0...720machine # [ 6.560219] systemd[1]: Expecting device /dev/ttyS0...721machine # [ 6.560956] systemd[1]: Reached target Local Encrypted Volumes.722machine # [ 6.561802] systemd[1]: Stopped target initrd-fs.target.723machine # [ 6.562544] systemd[1]: Stopped target initrd-root-fs.target.724machine # [ 6.563324] systemd[1]: Stopped target initrd-switch-root.target.725machine # [ 6.564176] systemd[1]: Reached target Virtual Machines and Containers.726machine # [ 6.565091] systemd[1]: Reached target Path Units.727machine # [ 6.565831] systemd[1]: Reached target Remote File Systems.728machine # [ 6.566626] systemd[1]: Reached target Slice Units.729machine # [ 6.567356] systemd[1]: Reached target Swaps.730machine # [ 6.570280] systemd[1]: Listening on Query the User Interactively for a Password.731machine # [ 6.585197] systemd[1]: Listening on Process Core Dump Socket.732machine # [ 6.589106] systemd[1]: Listening on Credential Encryption/Decryption.733machine # [ 6.591752] systemd[1]: Listening on Factory Reset Management.734machine # [ 6.592672] systemd[1]: Listening on Hostname Service Socket.735machine # [ 6.596751] systemd[1]: Starting Journal Log Access Socket...736machine # [ 6.598507] systemd[1]: Listening on Journal Audit Socket.737machine # [ 6.601285] systemd[1]: Listening on Console Output Muting Service Socket.738machine # [ 6.602434] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.739machine # [ 6.603976] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os740machine # [ 6.605288] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki741machine # [ 6.614697] systemd[1]: Listening on Disk Repartitioning Service Socket.742machine # [ 6.615818] systemd[1]: Listening on udev Varlink Socket.743machine # [ 6.620417] systemd[1]: Mounting Huge Pages File System...744machine # [ 6.623550] systemd[1]: Mounting POSIX Message Queue File System...745machine # [ 6.630243] systemd[1]: Mounting Kernel Debug File System...746machine # [ 6.635777] systemd[1]: Mounting Kernel Trace File System...747machine # [ 6.641810] systemd[1]: Starting Create List of Static Device Nodes...748machine # [ 6.643853] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio749machine # [ 6.654035] systemd[1]: Starting Load Kernel Module configfs...750machine # [ 6.655606] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm751machine # [ 6.657156] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore752machine # [ 6.659050] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse753machine # [ 6.666540] systemd[1]: Mounting FUSE Control File System...754machine # [ 6.667352] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67755machine # [ 6.703935] systemd[1]: Starting Journal Service...756machine # [ 6.727617] systemd[1]: Starting Load Kernel Modules...757machine # [ 6.747022] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...758machine # [ 6.760270] systemd[1]: Starting Remount Root and Kernel File Systems...759machine # [ 6.766310] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os760machine # [ 6.778227] systemd[1]: Starting Coldplug All udev Devices...761machine # [ 6.789234] systemd-journald[288]: Collecting audit messages is enabled.762machine # [ 6.802127] systemd[1]: Listening on Journal Log Access Socket.763machine # [ 6.810997] systemd[1]: Mounted Huge Pages File System.764machine # [ 6.813854] systemd[1]: Mounted POSIX Message Queue File System.765machine # [ 6.675601] systemd[1]: Queued start job for default target Multi-User System.[ 6.820792] systemd[1]: Started Journal Service.766machine # 767machine # [ 6.680744] systemd[1]: systemd-journald.service: Deactivated successfully.768machine # [ 6.683785] systemd[1]: Mounted Kernel Debug File System.769machine # [ 6.694198] systemd[1]: Mounted Kernel Trace File System.770machine # [ 6.695685] systemd[1]: Finished Create List of Static Device Nodes.771machine # [ 6.841079] loop: module loaded772machine # [ 6.699343] systemd[1]: modprobe@configfs.service: Deactivated successfully.773machine # [ 6.701197] systemd[1]: Finished Load Kernel Module configfs.774machine # [ 6.702825] systemd[1]: Mounted FUSE Control File System.775machine # [ 6.706386] systemd-modules-load[289]: Inserted module 'loop'776machine # [ 6.857531] EXT4-fs (vda): re-mounted 57a3eab9-0c44-4042-a129-b65fa839d642.777machine # [ 6.717127] systemd[1]: Finished Load Kernel Modules.778machine # [ 6.723505] systemd[1]: Finished Remount Root and Kernel File Systems.779machine # [ 6.732135] systemd[1]: Listening on Disk Image Download Service Socket.780machine # [ 6.739404] systemd[1]: Mounting Kernel Configuration File System...781machine # [ 6.745069] systemd[1]: Starting Firewall...782machine # [ 6.754904] systemd[1]: Starting Flush Journal to Persistent Storage...783machine # [ 6.755969] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore784machine # [ 6.767118] systemd[1]: Starting Load/Save OS Random Seed...785machine # [ 6.769134] systemd-oomd[291]: No swap; memory pressure usage will be degraded786machine # [ 6.783251] systemd[1]: Starting Apply Kernel Variables...787machine # [ 6.796363] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...788machine # [ 6.797990] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os789machine # [ 6.801964] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.790machine # [ 6.978778] systemd-journald[288]: Received client request to flush runtime journal.791machine # [ 6.977134] systemd[1]: Finished Load/Save OS Random Seed.792machine # [ 6.978047] systemd[1]: Reached target First Boot Complete.793machine # [ 6.982234] systemd[1]: Mounted Kernel Configuration File System.794machine # [ 6.983794] systemd[1]: Finished Apply Kernel Variables.795machine # [ 6.988212] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.796machine # [ 6.989303] systemd[1]: Starting Create Static Device Nodes in /dev...797machine # [ 6.991284] systemd[1]: Finished Flush Journal to Persistent Storage.798machine # [ 7.051141] systemd[1]: Finished Create Static Device Nodes in /dev.799machine # [ 7.053400] systemd[1]: Reached target Preparation for Local File Systems.800machine # [ 7.058680] systemd[1]: Starting Rule-based Manager for Device Events and Files...801machine # [ 7.128619] systemd[1]: Finished Coldplug All udev Devices.802machine # [ 7.149426] systemd-udevd[328]: Using default interface naming scheme 'v261'.803machine # [ 7.261205] systemd[1]: Started Rule-based Manager for Device Events and Files.804machine # [ 7.391403] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse805machine # [ 7.410862] systemd[1]: Mounting /run/wrappers...806machine # [ 7.448102] systemd[1]: Mounted /run/wrappers.807machine # [ 7.451399] systemd[1]: Reached target Local File Systems.808machine # [ 7.455253] systemd[1]: Listening on Boot Loader Control Service Socket.809machine # [ 7.459261] systemd[1]: Starting register-nix-paths.service...810machine # [ 7.466755] systemd[1]: Starting Create SUID/SGID Wrappers...811machine # [ 7.467585] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.812machine # [ 7.475356] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 7.493641] systemd[1]: Starting Create System Files and Directories...814machine # [ 7.529933] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.815machine # [ 7.577266] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.816machine # [ 7.587708] systemd[1]: Finished Save Transient machine-id to Disk.817machine # [ 7.648711] systemd[1]: Finished Create System Files and Directories.818machine # [ 7.661046] systemd[1]: Starting Rebuild Journal Catalog...819machine # [ 7.668801] systemd[1]: Starting Record System Boot/Shutdown in UTMP...820machine # [ 7.674117] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.821machine # [ 7.710358] (udev-worker)[367]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.822machine # [ 7.714600] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line.823machine # [ 7.725542] (udev-worker)[367]: Network interface NamePolicy= disabled on kernel command line.824machine # [ 7.757563] systemd[1]: Finished Record System Boot/Shutdown in UTMP.825machine # [ 7.810294] systemd[1]: Finished Rebuild Journal Catalog.826machine # [ 7.818753] systemd[1]: Starting Update is Completed...827machine # [ 7.877334] systemd[1]: Finished Update is Completed.828machine # [ 7.957258] systemd[1]: Condition check resulted in Virtio network device being skipped.829machine # [ 7.959489] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore830machine # [ 7.960933] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.831machine # [ 7.963337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67832machine # [ 7.966120] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore833machine # [ 7.968667] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os834machine # [ 7.970298] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os835machine # [ 8.052315] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.836machine # [ 8.055694] systemd[1]: Finished Create SUID/SGID Wrappers.837machine # [ 8.275343] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3838machine # [ 8.141819] systemd[1]: Finished Firewall.839machine # [ 8.306866] ACPI: button: Power Button [PWRF]840machine # [ 8.349908] mousedev: PS/2 mouse device common for all mice841machine # [ 8.366633] rtc_cmos 00:04: RTC can wake from S4842machine # [ 8.385951] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console843machine # [ 8.368092] systemd[1]: Finished register-nix-paths.service.844machine # [ 8.369097] systemd[1]: Reached target System Initialization.845machine # [ 8.371335] systemd[1]: Started Discard unused filesystem blocks once a week.846machine # [ 8.372505] systemd[1]: Started Daily Cleanup of Temporary Directories.847machine # [ 8.374200] systemd[1]: Reached target Timer Units.848machine # [ 8.374911] systemd[1]: Listening on D-Bus System Message Bus Socket.849machine # [ 8.376189] systemd[1]: Listening on Nix Daemon Socket.850machine # [ 8.378134] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.851machine # [ 8.379286] systemd[1]: Reached target Socket Units.852machine # [ 8.380027] systemd[1]: Reached target Basic System.853machine # [ 8.383229] systemd[1]: Started backdoor.service.854machine # [ 8.388130] systemd[1]: Starting Import lastlog data into lastlog2 database...855machine # [ 8.396090] systemd[1]: Starting Name Service Cache Daemon (nsncd)...856machine # [ 8.406848] systemd[1]: Starting Post-Boot Actions...857machine # [ 8.421079] systemd[1]: Started Reset console on configuration changes.858machine # [ 8.402803] parport_pc 00:02: reported by Plug and Play ACPI859machine # [ 8.438642] systemd[1]: Starting resolvconf update...860machine # [ 8.402882] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]861machine # [ 8.410864] rtc_cmos 00:04: registered as rtc0862machine # [ 8.410931] rtc_cmos 00:04: setting system clock to 2026-09-03T02:41:40 UTC (1788403300)863machine # [ 8.475287] systemd[1]: Starting D-Bus System Message Bus...864machine # connecting to host...865machine # [ 8.507405] systemd[1]: Finished Post-Boot Actions.866machine # [ 8.514965] nsncd[505]: Sep 03 02:41:40.745 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"867machine # [ 8.520298] systemd[1]: Started Name Service Cache Daemon (nsncd).868machine # [ 8.534685] systemd[1]: Reached target Host and Network Name Lookups.869machine # [ 8.538119] systemd[1]: Reached target User and Group Name Lookups.870machine # [ 8.411004] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs871machine # [ 8.412148] systemd-journald[288]: Time jumped backwards, rotating.872machine: Guest shell says: b'Spawning backdoor root shell...\n'873machine: connected to guest root shell874machine # [ 8.552214] systemd[1]: Starting User Login Management...875machine: (connecting took 9.22 seconds)876machine: (finished: waiting for the VM to finish booting, in 9.50 seconds)877machine # [ 8.416135] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4878machine # [ 8.482247] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized879machine # [ 8.569082] Console: switching to colour dummy device 80x25880machine # [ 8.584394] systemd[1]: Finished Import lastlog data into lastlog2 database.881machine # [ 8.633226] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt882machine # [ 8.633338] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD883machine # [ 8.813085] [drm] Found bochs VGA, ID 0xb0c5.884machine # [ 8.813088] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.885machine # [ 8.674612] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'...886machine # [ 8.822512] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6887machine # [ 8.833934] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5888machine # [ 8.845654] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic889machine # [ 8.846331] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0890machine # [ 8.717194] systemd-logind[531]: New seat seat0.891machine # [ 8.735632] systemd[1]: Started User Login Management.892machine # [ 8.748230] systemd[1]: Stopped target Host and Network Name Lookups.893machine # [ 8.749669] systemd[1]: Stopping Host and Network Name Lookups...894machine # [ 8.750956] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync'895machine # [ 8.752607] dbus-broker-launch[512]: Invalid user-name in /nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"896machine # [ 8.755157] systemd[1]: Stopped target User and Group Name Lookups.897machine # [ 8.757105] systemd[1]: Stopping User and Group Name Lookups...898machine # [ 8.762276] systemd[1]: Starting linger-users.service...899machine # [ 8.764142] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...900machine # [ 8.768862] systemd[1]: nscd.service: Deactivated successfully.901machine # [ 8.774183] systemd[1]: Stopped Name Service Cache Daemon (nsncd).902machine # [ 8.801310] systemd[1]: Started D-Bus System Message Bus.903machine # [ 8.837448] systemd[1]: Starting Name Service Cache Daemon (nsncd)...904machine # [ 8.843163] systemd[1]: Starting Virtual Console Setup...905machine # [ 8.852159] dbus-broker-launch[512]: Ready906machine # [ 8.871150] systemd-logind[531]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)907machine # [ 8.913369] systemd-logind[531]: Watching system buttons on /dev/input/event2 (Power Button)908machine # [ 9.088231] Console: switching to colour frame buffer device 160x50909machine # [ 9.118643] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device910machine # [ 9.132763] ppdev: user-space parallel port driver911machine # [ 8.929826] systemd[1]: Created slice Slice /user/1001.912machine # [ 8.999241] systemd[1]: Starting User Runtime Directory /run/user/1001...913machine # [ 9.006027] nsncd[595]: Sep 03 02:41:41.189 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"914machine # [ 9.024241] systemd[1]: linger-users.service: Deactivated successfully.915machine # [ 9.029454] systemd[1]: Finished linger-users.service.916machine # [ 9.044133] systemd[1]: Started Name Service Cache Daemon (nsncd).917machine # [ 9.044997] systemd[1]: Reached target Host and Network Name Lookups.918machine # [ 9.045839] systemd[1]: Reached target User and Group Name Lookups.919machine # [ 9.049132] systemd[1]: Finished resolvconf update.920machine # [ 9.049847] systemd[1]: Reached target Preparation for Network.921machine # [ 9.055915] systemd[1]: Starting DHCP Client...922machine # [ 9.059078] systemd[1]: Starting Address configuration of eth1...923machine # [ 9.059947] systemd[1]: Starting Extra networking commands....924machine # [ 9.205471] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)925machine # [ 9.063438] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.926machine # [ 9.067532] systemd[1]: Stopped Virtual Console Setup.927machine # [ 9.077934] systemd[1]: Starting Virtual Console Setup...928machine # [ 9.081937] systemd-logind[531]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)929machine # [ 9.233961] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)930machine # [ 9.147495] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.931machine # [ 9.149303] systemd[1]: Stopped Virtual Console Setup.932machine # [ 9.155381] systemd[1]: Starting Virtual Console Setup...933machine # [ 9.160295] systemd[1]: Finished User Runtime Directory /run/user/1001.934machine # [ 9.166527] systemd[1]: Starting User Manager for UID 1001...935machine # [ 9.258607] (systemd)[633]: pam_unix(systemd-user:session): session opened for user usertest(uid=1001) by (uid=0)936machine # [ 9.284305] systemd-logind[531]: New session '1' of user 'usertest' with class 'manager' and type 'unspecified'.937machine # [ 9.323780] network-addresses-eth1-start[622]: adding address 192.168.1.1/24... done938machine # [ 9.334337] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy939machine # [ 9.540211] kvm_amd: TSC scaling supported940machine # [ 9.549619] kvm_amd: Nested Virtualization enabled941machine # [ 9.550177] kvm_amd: Nested Paging enabled942machine # [ 9.554606] kvm_amd: LBR virtualization supported943machine # [ 9.555139] kvm_amd: Virtual VMLOAD VMSAVE supported944machine # [ 9.560425] kvm_amd: Virtual GIF supported945machine # [ 9.562644] kvm_amd: Virtual NMI enabled946machine # [ 9.420387] systemd[1]: Finished Address configuration of eth1.947machine # [ 9.421870] network-addresses-eth1-start[622]: adding address 2001:db8:1::1/64... done948machine # [ 9.498800] systemd[1]: Finished Extra networking commands..949machine # [ 9.500220] systemd[1]: Reached target Network.950machine # [ 9.503678] systemd[1]: Starting Permit User Sessions...951machine # [ 9.658275] EDAC MC: Ver: 3.0.0952machine # [ 9.528664] dhcpcd[639]: dhcpcd-10.3.2 starting953machine # [ 9.540740] dhcpcd[704]: dev: loaded udev954machine # [ 9.557171] systemd[1]: Finished Permit User Sessions.955machine # [ 9.563520] systemd[1]: Started Getty on tty1.956machine # [ 9.565367] systemd[1]: Reached target Login Prompts.957machine # [ 9.714259] 8021q: 802.1Q VLAN Support v1.8958machine # [ 9.716308] 8021q: adding VLAN 0 to HW filter on device eth1959machine # [ 9.577899] systemd[633]: Queued start job for default target Main User Target.960machine # [ 9.581321] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy961machine # [ 9.584245] systemd[633]: Created slice User Application Slice.962machine # [ 9.585351] systemd[633]: Started Daily Cleanup of User's Temporary Directories.963machine # [ 9.586588] systemd[633]: Reached target Paths.964machine # [ 9.587562] systemd[633]: Reached target Timers.965machine # [ 9.590800] systemd[633]: Starting D-Bus User Message Bus Socket...966machine # [ 9.594367] systemd[633]: Starting Create User Files and Directories...967machine # [ 9.615300] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.968machine # [ 9.657210] systemd[633]: Finished Create User Files and Directories.969machine # [ 9.839307] cfg80211: Loading compiled-in X.509 certificates for regulatory database970machine # [ 9.727511] systemd[633]: Listening on D-Bus User Message Bus Socket.971machine # [ 9.728485] systemd[633]: Reached target Sockets.972machine # [ 9.729172] systemd[633]: Reached target Basic System.973machine # [ 9.729867] systemd[1]: Started User Manager for UID 1001.974machine # [ 9.874596] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'975machine # [ 9.875272] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'976machine # [ 9.735592] systemd[633]: Starting Run user-specific NixOS activation...977machine # [ 9.880542] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2978machine # [ 9.881399] cfg80211: failed to load regulatory.db979machine # [ 9.780602] systemd[633]: Finished Run user-specific NixOS activation.980machine # [ 9.782628] systemd[633]: Reached target Main User Target.981machine # [ 9.783574] systemd[633]: Startup finished in 467ms.982machine # [ 9.948767] 8021q: adding VLAN 0 to HW filter on device eth0983machine # [ 9.806725] dhcpcd[704]: eth0: waiting for carrier984machine # [ 9.807506] dhcpcd[704]: eth0: carrier acquired985machine # [ 9.817502] dhcpcd[704]: DUID 00:01:00:01:32:2b:9a:e6:52:54:00:12:34:56986machine # [ 9.818654] dhcpcd[704]: eth0: IAID 00:12:34:56987machine # [ 9.819372] dhcpcd[704]: eth0: adding address fe80::5054:ff:fe12:3456988machine # [ 9.911463] systemd-vconsole-setup[631]: Configuration of first virtual console was skipped, ignoring remaining ones.989machine # [ 9.916383] systemd[1]: Finished Virtual Console Setup.990machine # [ 9.937239] dhcpcd[704]: eth0: soliciting a DHCP lease991machine # [ 10.097319] NET: Registered PF_PACKET protocol family992machine # [ 9.957504] dhcpcd[704]: eth0: offered 10.0.2.15 from 10.0.2.2993machine # [ 9.959151] dhcpcd[704]: eth0: probing address 10.0.2.15/24994machine # [ 12.004972] dhcpcd[704]: eth0: soliciting an IPv6 router995machine # [ 12.009465] dhcpcd[704]: eth0: Router Advertisement from fe80::2996machine # [ 12.012804] dhcpcd[704]: eth0: adding address fec0::5054:ff:fe12:3456/64997machine # [ 12.015983] dhcpcd[704]: eth0: adding route to fec0::/64998machine # [ 12.018891] dhcpcd[704]: eth0: adding default route via fe80::2999machine # [ 15.435909] dhcpcd[704]: eth0: leased 10.0.2.15 for 86400 seconds1000machine # [ 15.438790] dhcpcd[704]: eth0: adding route to 10.0.2.0/241001machine # [ 15.440944] dhcpcd[704]: eth0: adding default route via 10.0.2.21002machine # [ 15.559195] systemd[1]: Started DHCP Client.1003machine # [ 15.561260] systemd[1]: Reached target Multi-User System.1004machine # [ 15.562187] systemd[1]: Startup finished in 837ms (kernel) + 3.943s (initrd) + 10.780s (userspace) = 15.561s.1005machine: (finished: waiting for unit multi-user.target, in 17.35 seconds)1006machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test1007machine # Checking switch inhibitors... done1008machine # [ 17.064736] nixos[852]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1009machine # [ 17.067165] systemd[1]: Stopped target Local File Systems.1010machine # [ 17.068788] systemd[1]: Stopped target Remote File Systems.1011machine # activating the configuration...1012machine # setting up /etc...1013machine # [ 17.484689] systemd[1]: Reload requested from client PID 852 ('.switch-to-conf') (unit backdoor.service)...1014machine # [ 17.486358] systemd[1]: Reloading...1015machine # [ 18.052936] systemd[1]: Reloading finished in 563 ms.1016machine # reloading user units for usertest...1017machine # [ 18.084848] systemd[633]: Created slice User Core Session Slice.1018machine # [ 18.088530] systemd[633]: Starting D-Bus User Message Bus...1019machine # [ 18.153815] dbus-broker-launch[922]: Ignoring duplicate name 'org.freedesktop.import1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.import1.service'1020machine # [ 18.156508] dbus-broker-launch[922]: Ignoring duplicate name 'org.freedesktop.machine1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.machine1.service'1021machine # [ 18.159412] dbus-broker-launch[922]: Ignoring duplicate name 'org.freedesktop.portable1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.portable1.service'1022machine # [ 18.162775] dbus-broker-launch[922]: Ignoring duplicate name 'org.freedesktop.systemd1' in service file '/nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/services/org.freedesktop.systemd1.service'1023machine # [ 18.166506] systemd[633]: Started D-Bus User Message Bus.1024machine # [ 18.167934] dbus-broker-launch[922]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +27: Eavesdropping is deprecated and ignored1025machine # [ 18.169434] dbus-broker-launch[922]: Policy to allow eavesdropping in /etc/dbus-1/session.conf +29: Eavesdropping is deprecated and ignored1026machine # [ 18.179457] dbus-broker-launch[922]: Ready1027machine # [ 18.289935] systemd[633]: Reexecution requested from client PID 921 ('switch-to-confi')...1028machine # [ 18.291271] systemd[633]: Reexecuting.1029machine # [ 18.320373] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1030machine # [ 18.475270] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1031machine # [ 18.480725] systemd[633]: Reload requested from client PID 921 ('switch-to-confi')...1032machine # [ 18.482566] systemd[633]: Reloading...1033machine # [ 18.637543] systemd[633]: Reloading finished in 153 ms.1034machine # [ 18.642810] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1035machine # restarting the following user units: nixos-activation.service1036machine # [ 18.650062] systemd[633]: Stopped Run user-specific NixOS activation.1037machine # [ 18.650944] systemd[633]: Stopping Run user-specific NixOS activation...1038machine # [ 18.654678] systemd[633]: Starting Run user-specific NixOS activation...1039machine # [ 18.695653] systemd[633]: Finished Run user-specific NixOS activation.1040machine # restarting sysinit-reactivation.target1041machine # [ 18.711200] systemd[1]: Starting Re-setup tmpfiles on a system that is already running....1042machine # [ 18.815082] systemd[1]: Finished Re-setup tmpfiles on a system that is already running..1043machine # [ 18.817863] systemd[1]: Reached target Reactivate sysinit units.1044machine # [ 18.822747] systemd[1]: Reached target Local File Systems.1045machine # [ 18.825069] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1046machine # [ 18.828823] systemd[1]: Starting Create SUID/SGID Wrappers...1047machine # [ 18.829839] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1048machine # [ 18.832103] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671049machine # [ 18.834490] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1050machine # [ 18.836610] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1051machine # [ 18.838213] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1052machine # [ 18.840499] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1053machine # [ 18.843114] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1054machine # [ 18.850640] systemd[1]: Reached target Remote File Systems.1055machine # [ 19.158647] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1056machine # [ 19.160311] systemd[1]: Finished Create SUID/SGID Wrappers.1057machine # [ 19.165479] systemd[1]: Starting linger-users.service...1058machine # [ 19.221809] systemd[1]: linger-users.service: Deactivated successfully.1059machine # [ 19.223379] systemd[1]: Finished linger-users.service.1060machine # the following new units were started: sysinit-reactivation.target, systemd-tmpfiles-resetup.service1061machine # [ 19.484566] nixos[852]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1062machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test, in 3.09 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/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration test1066machine # this should succeed (config: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test, action: test)1067machine # Checking switch inhibitors... done1068machine # [ 20.162751] nixos[1000]: switching to system configuration /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test1069machine # activating the configuration...1070machine # [ 20.166634] systemd[1]: Stopped target Local File Systems.1071machine # [ 20.167522] systemd[1]: Stopped target Remote File Systems.1072machine # removing user ‘usertest’1073machine # setting up /etc...1074machine # [ 20.569452] systemd[1]: Reload requested from client PID 1000 ('.switch-to-conf') (unit backdoor.service)...1075machine # [ 20.571157] systemd[1]: Reloading...1076machine # [ 21.099794] systemd[1]: Reloading finished in 526 ms.1077machine # reloading user units for usertest...1078machine # [ 21.227544] systemd[633]: Reexecution requested from client PID 1071 ('switch-to-confi')...1079machine # [ 21.228915] systemd[633]: Reexecuting.1080machine # [ 21.255826] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1081machine # [ 21.402737] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1082machine # [ 21.407741] systemd[633]: Reload requested from client PID 1071 ('switch-to-confi')...1083machine # [ 21.408953] systemd[633]: Reloading...1084machine # [ 21.543930] systemd[633]: Reloading finished in 133 ms.1085machine # [ 21.548832] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1086machine # restarting the following user units: nixos-activation.service1087machine # [ 21.556428] systemd[633]: Stopped Run user-specific NixOS activation.1088machine # [ 21.558061] systemd[633]: Stopping Run user-specific NixOS activation...1089machine # [ 21.560561] systemd[633]: Starting Run user-specific NixOS activation...1090machine # [ 21.595310] systemd[633]: Finished Run user-specific NixOS activation.1091machine # restarting sysinit-reactivation.target1092machine # [ 21.599354] systemd[1]: Stopped target Reactivate sysinit units.1093machine # reloading the following units: dbus-broker.service1094machine # [ 21.601712] systemd[1]: Stopping Reactivate sysinit units...1095machine # [ 21.602691] systemd[1]: Reached target Reactivate sysinit units.1096machine # [ 21.604613] dbus-broker-launch[512]: Caught SIGHUP, trigger reload.1097machine # [ 21.606112] systemd[1]: Reloading D-Bus System Message Bus...1098machine # [ 21.626700] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'...1099machine # [ 21.628677] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync'1100machine # [ 21.629771] dbus-broker-launch[512]: Invalid user-name in /nix/store/h586j6zx3nwqd354pg3jzsx05yvfqlr4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1101machine # [ 21.652791] systemd[1]: Reloaded D-Bus System Message Bus.1102machine # restarting the following units: network-addresses-eth1.service1103machine # [ 21.658695] systemd[1]: Stopping Address configuration of eth1...1104machine # [ 21.699645] network-addresses-eth1-pre-stop[1083]: deleting address 192.168.1.1/24... done1105machine # [ 21.710626] network-addresses-eth1-pre-stop[1083]: deleting address 2001:db8:1::1/64... done1106machine # [ 21.719379] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1107machine # [ 21.721069] systemd[1]: Stopped Address configuration of eth1.1108machine # [ 21.725645] systemd[1]: Starting Address configuration of eth1...1109machine # [ 21.787829] network-addresses-eth1-start[1088]: adding address 192.168.1.2/24... done1110machine # [ 21.799689] network-addresses-eth1-start[1088]: adding address 2001:db8:1::2/64... done1111machine # [ 21.813212] systemd[1]: Finished Address configuration of eth1.1112machine # [ 21.817368] systemd[1]: Reached target Remote File Systems.1113machine # [ 21.821882] systemd[1]: Reached target Local File Systems.1114machine # [ 21.823124] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1115machine # [ 21.828120] systemd[1]: Starting Create SUID/SGID Wrappers...1116machine # [ 21.829671] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1117machine # [ 21.831230] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671118machine # [ 21.833830] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1119machine # [ 21.836131] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1120machine # [ 21.837618] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1121machine # [ 21.839749] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1122machine # [ 21.842290] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1123machine # [ 22.177101] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1124machine # [ 22.180340] systemd[1]: Finished Create SUID/SGID Wrappers.1125machine # [ 22.183333] systemd[1]: Starting linger-users.service...1126machine # [ 22.218525] linger-users-start[1160]: id: ‘usertest’: no such user1127machine # [ 22.220463] linger-users-start[1158]: Removing linger for missing user usertest1128machine # [ 22.227902] systemd[1]: linger-users.service: Deactivated successfully.1129machine # [ 22.229384] systemd[1]: Finished linger-users.service.1130machine # [ 22.484065] nixos[1000]: finished switching to system configuration /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test1131machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration test, in 2.96 seconds)1132subtest: pre-switch checks1133machine: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration check1134machine # this should succeed (config: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test, action: check)1135machine # Checking switch inhibitors... done1136machine: (finished: must succeed: /nix/store/w1psanxc52jqfm0knzrj6gw0pz8my68n-stderr-runner /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/bin/switch-to-configuration check, in 0.07 seconds)1137machine: must fail: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&11138machine: (finished: must fail: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/specialisation/failingCheck/bin/switch-to-configuration check 2>&1, in 0.04 seconds)1139machine: must fail: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-nixos-system-other-test/specialisation/failingMidCheck/bin/switch-to-configuration check 2>&11140machine: (finished: must fail: /nix/store/9w14g6ph6iqv67ndrh96m8j6md1xhxm9-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.15 seconds)1142subtest: switch inhibitors1143machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11144machine # [ 23.173255] nixos[1189]: switching to system configuration /nix/store/4353f7r28ws4ym5c7lin33vw4jcqlz21-nixos-system-machine-test1145machine # [ 23.175843] systemd[1]: Stopped target Remote File Systems.1146machine # [ 23.177271] systemd[1]: Stopped target Local File Systems.1147machine # [ 23.566390] systemd[1]: Reload requested from client PID 1189 ('.switch-to-conf') (unit backdoor.service)...1148machine # [ 23.568053] systemd[1]: Reloading...1149machine # [ 24.075082] systemd[1]: Reloading finished in 505 ms.1150machine # [ 24.198301] systemd[633]: Reexecution requested from client PID 1259 ('switch-to-confi')...1151machine # [ 24.200481] systemd[633]: Reexecuting.1152machine # [ 24.227041] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1153machine # [ 24.373310] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1154machine # [ 24.378144] systemd[633]: Reload requested from client PID 1259 ('switch-to-confi')...1155machine # [ 24.379717] systemd[633]: Reloading...1156machine # [ 24.514875] systemd[633]: Reloading finished in 133 ms.1157machine # [ 24.520818] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1158machine # [ 24.527296] systemd[633]: Stopped Run user-specific NixOS activation.1159machine # [ 24.529061] systemd[633]: Stopping Run user-specific NixOS activation...1160machine # [ 24.531283] systemd[633]: Starting Run user-specific NixOS activation...1161machine # [ 24.565442] systemd[633]: Finished Run user-specific NixOS activation.1162machine # [ 24.569040] systemd[1]: Stopped target Reactivate sysinit units.1163machine # [ 24.570676] systemd[1]: Stopping Reactivate sysinit units...1164machine # [ 24.572363] systemd[1]: Reached target Reactivate sysinit units.1165machine # [ 24.574441] dbus-broker-launch[512]: Caught SIGHUP, trigger reload.1166machine # [ 24.575467] systemd[1]: Reloading D-Bus System Message Bus...1167machine # [ 24.587178] dbus-broker-launch[512]: Looking up NSS user entry for 'systemd-timesync'...1168machine # [ 24.589025] dbus-broker-launch[512]: NSS returned no entry for 'systemd-timesync'1169machine # [ 24.590047] dbus-broker-launch[512]: Invalid user-name in /nix/store/cbyfllapzm5ln1bq2va5ghalqcswmygw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1170machine # [ 24.608117] systemd[1]: Reloaded D-Bus System Message Bus.1171machine # [ 24.613103] systemd[1]: Stopping Address configuration of eth1...1172machine # [ 24.650242] network-addresses-eth1-pre-stop[1271]: deleting address 192.168.1.2/24... done1173machine # [ 24.660667] network-addresses-eth1-pre-stop[1271]: deleting address 2001:db8:1::2/64... done1174machine # [ 24.668737] systemd[1]: network-addresses-eth1.service: Deactivated successfully.1175machine # [ 24.670313] systemd[1]: Stopped Address configuration of eth1.1176machine # [ 24.674212] systemd[1]: Starting Address configuration of eth1...1177machine # [ 24.735178] network-addresses-eth1-start[1276]: adding address 192.168.1.1/24... done1178machine # [ 24.746531] network-addresses-eth1-start[1276]: adding address 2001:db8:1::1/64... done1179machine # [ 24.760106] systemd[1]: Finished Address configuration of eth1.1180machine # [ 24.763074] systemd[1]: Reached target Remote File Systems.1181machine # [ 24.765698] systemd[1]: Reached target Local File Systems.1182machine # [ 24.767950] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1183machine # [ 24.771217] systemd[1]: Starting Create SUID/SGID Wrappers...1184machine # [ 24.772287] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1185machine # [ 24.773431] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671186machine # [ 24.775362] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1187machine # [ 24.776822] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1188machine # [ 24.779762] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1189machine # [ 24.792760] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1190machine # [ 24.794349] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1191machine # [ 25.073843] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1192machine # [ 25.075467] systemd[1]: Finished Create SUID/SGID Wrappers.1193machine # [ 25.080413] systemd[1]: Starting linger-users.service...1194machine # [ 25.117393] systemd[1]: linger-users.service: Deactivated successfully.1195machine # [ 25.118976] systemd[1]: Finished linger-users.service.1196machine # [ 25.376781] nixos[1189]: finished switching to system configuration /nix/store/4353f7r28ws4ym5c7lin33vw4jcqlz21-nixos-system-machine-test1197machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 2.74 seconds)1198machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&11199machine # [ 25.905084] nixos[1345]: switching to system configuration /nix/store/q27vqi1y4651l6bhx5f75gf50j0c9k19-nixos-system-machine-test1200machine # [ 25.907416] systemd[1]: Stopped target Local File Systems.1201machine # [ 25.909275] systemd[1]: Stopped target Remote File Systems.1202machine # [ 26.309364] systemd[1]: Reload requested from client PID 1345 ('.switch-to-conf') (unit backdoor.service)...1203machine # [ 26.311182] systemd[1]: Reloading...1204machine # [ 26.767465] systemd[1]: Reloading finished in 454 ms.1205machine # [ 26.868912] systemd[633]: Reexecution requested from client PID 1416 ('switch-to-confi')...1206machine # [ 26.871503] systemd[633]: Reexecuting.1207machine # [ 26.896044] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1208machine # [ 27.016082] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1209machine # [ 27.021857] systemd[633]: Reload requested from client PID 1416 ('switch-to-confi')...1210machine # [ 27.023072] systemd[633]: Reloading...1211machine # [ 27.149235] systemd[633]: Reloading finished in 124 ms.1212machine # [ 27.154111] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1213machine # [ 27.161536] systemd[633]: Stopped Run user-specific NixOS activation.1214machine # [ 27.162504] systemd[633]: Stopping Run user-specific NixOS activation...1215machine # [ 27.165734] systemd[633]: Starting Run user-specific NixOS activation...1216machine # [ 27.201730] systemd[633]: Finished Run user-specific NixOS activation.1217machine # [ 27.205286] systemd[1]: Stopped target Reactivate sysinit units.1218machine # [ 27.206974] systemd[1]: Stopping Reactivate sysinit units...1219machine # [ 27.208047] systemd[1]: Reached target Reactivate sysinit units.1220machine # [ 27.209680] systemd[1]: Reached target Remote File Systems.1221machine # [ 27.213280] systemd[1]: Starting linger-users.service...1222machine # [ 27.216474] systemd[1]: Reached target Local File Systems.1223machine # [ 27.218062] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1224machine # [ 27.223752] systemd[1]: Starting Create SUID/SGID Wrappers...1225machine # [ 27.225058] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1226machine # [ 27.226250] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671227machine # [ 27.228180] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1228machine # [ 27.229631] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1229machine # [ 27.230759] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1230machine # [ 27.234972] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1231machine # [ 27.236403] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1232machine # [ 27.287092] systemd[1]: linger-users.service: Deactivated successfully.1233machine # [ 27.288251] systemd[1]: Finished linger-users.service.1234machine # [ 27.499600] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1235machine # [ 27.501254] systemd[1]: Finished Create SUID/SGID Wrappers.1236machine # [ 27.759225] nixos[1345]: finished switching to system configuration /nix/store/q27vqi1y4651l6bhx5f75gf50j0c9k19-nixos-system-machine-test1237machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors/bin/switch-to-configuration switch 2>&1, in 2.38 seconds)1238machine: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&11239machine: (finished: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration switch 2>&1, in 0.07 seconds)1240machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&11241machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration boot 2>&1, in 0.04 seconds)1242machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&11243machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_changed/bin/switch-to-configuration dry-activate 2>&1, in 0.52 seconds)1244machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&11245machine # [ 28.901425] nixos[1511]: switching to system configuration /nix/store/rjv6iwyydvv7gwsyrqz8wjmzmcqrzrbw-nixos-system-machine-test1246machine # [ 28.904080] systemd[1]: Stopped target Remote File Systems.1247machine # [ 28.906427] systemd[1]: Stopped target Local File Systems.1248machine # [ 29.307655] systemd[1]: Reload requested from client PID 1511 ('.switch-to-conf') (unit backdoor.service)...1249machine # [ 29.309369] systemd[1]: Reloading...1250machine # [ 29.823093] systemd[1]: Reloading finished in 511 ms.1251machine # [ 29.947281] systemd[633]: Reexecution requested from client PID 1582 ('switch-to-confi')...1252machine # [ 29.950692] systemd[633]: Reexecuting.1253machine # [ 29.980462] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1254machine # [ 30.137991] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1255machine # [ 30.143721] systemd[633]: Reload requested from client PID 1582 ('switch-to-confi')...1256machine # [ 30.145060] systemd[633]: Reloading...1257machine # [ 30.308036] systemd[633]: Reloading finished in 161 ms.1258machine # [ 30.313074] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1259machine # [ 30.325075] systemd[633]: Stopped Run user-specific NixOS activation.1260machine # [ 30.325965] systemd[633]: Stopping Run user-specific NixOS activation...1261machine # [ 30.328495] systemd[633]: Starting Run user-specific NixOS activation...1262machine # [ 30.361076] systemd[633]: Finished Run user-specific NixOS activation.1263machine # [ 30.364613] systemd[1]: Stopped target Reactivate sysinit units.1264machine # [ 30.366159] systemd[1]: Stopping Reactivate sysinit units...1265machine # [ 30.366889] systemd[1]: Reached target Reactivate sysinit units.1266machine # [ 30.368315] systemd[1]: Reached target Local File Systems.1267machine # [ 30.371259] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1268machine # [ 30.376275] systemd[1]: Starting Create SUID/SGID Wrappers...1269machine # [ 30.377700] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1270machine # [ 30.379177] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671271machine # [ 30.381882] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1272machine # [ 30.383879] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1273machine # [ 30.386159] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1274machine # [ 30.387949] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1275machine # [ 30.389127] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1276machine # [ 30.398452] systemd[1]: Reached target Remote File Systems.1277machine # [ 30.678337] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1278machine # [ 30.680212] systemd[1]: Finished Create SUID/SGID Wrappers.1279machine # [ 30.684990] systemd[1]: Starting linger-users.service...1280machine # [ 30.732910] systemd[1]: linger-users.service: Deactivated successfully.1281machine # [ 30.734443] systemd[1]: Finished linger-users.service.1282machine # [ 30.991655] nixos[1511]: finished switching to system configuration /nix/store/rjv6iwyydvv7gwsyrqz8wjmzmcqrzrbw-nixos-system-machine-test1283machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/inhibitors_new/bin/switch-to-configuration switch 2>&1, in 2.61 seconds)1284machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&11285machine # [ 31.591280] nixos[1653]: switching to system configuration /nix/store/4353f7r28ws4ym5c7lin33vw4jcqlz21-nixos-system-machine-test1286machine # [ 31.594220] systemd[1]: Stopped target Remote File Systems.1287machine # [ 31.595504] systemd[1]: Stopped target Local File Systems.1288machine # [ 31.991746] systemd[1]: Reload requested from client PID 1653 ('.switch-to-conf') (unit backdoor.service)...1289machine # [ 31.993445] systemd[1]: Reloading...1290machine # [ 32.491973] systemd[1]: Reloading finished in 496 ms.1291machine # [ 32.628862] systemd[633]: Reexecution requested from client PID 1723 ('switch-to-confi')...1292machine # [ 32.630161] systemd[633]: Reexecuting.1293machine # [ 32.657425] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1294machine # [ 32.790459] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1295machine # [ 32.795831] systemd[633]: Reload requested from client PID 1723 ('switch-to-confi')...1296machine # [ 32.797459] systemd[633]: Reloading...1297machine # [ 32.923575] systemd[633]: Reloading finished in 124 ms.1298machine # [ 32.927818] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1299machine # [ 32.934135] systemd[633]: Stopped Run user-specific NixOS activation.1300machine # [ 32.935146] systemd[633]: Stopping Run user-specific NixOS activation...1301machine # [ 32.938341] systemd[633]: Starting Run user-specific NixOS activation...1302machine # [ 32.971530] systemd[633]: Finished Run user-specific NixOS activation.1303machine # [ 32.974918] systemd[1]: Stopped target Reactivate sysinit units.1304machine # [ 32.976734] systemd[1]: Stopping Reactivate sysinit units...1305machine # [ 32.977815] systemd[1]: Reached target Reactivate sysinit units.1306machine # [ 32.980316] systemd[1]: Reached target Local File Systems.1307machine # [ 32.982402] systemd[1]: Reached target Remote File Systems.1308machine # [ 32.983186] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1309machine # [ 32.986848] systemd[1]: Starting Create SUID/SGID Wrappers...1310machine # [ 32.987810] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1311machine # [ 32.988991] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671312machine # [ 32.992429] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1313machine # [ 32.993932] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1314machine # [ 32.996979] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1315machine # [ 33.006323] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1316machine # [ 33.008357] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1317machine # [ 33.292644] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1318machine # [ 33.294311] systemd[1]: Finished Create SUID/SGID Wrappers.1319machine # [ 33.298970] systemd[1]: Starting linger-users.service...1320machine # [ 33.346499] systemd[1]: linger-users.service: Deactivated successfully.1321machine # [ 33.348075] systemd[1]: Finished linger-users.service.1322machine # [ 33.604596] nixos[1653]: finished switching to system configuration /nix/store/4353f7r28ws4ym5c7lin33vw4jcqlz21-nixos-system-machine-test1323machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/no_inhibitors/bin/switch-to-configuration switch 2>&1, in 2.61 seconds)1324(finished: subtest: switch inhibitors, in 10.97 seconds)1325subtest: actions1326machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&11327machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration boot 2>&1, in 0.07 seconds)1328machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration switch 2>&11329machine # [ 34.219716] nixos[1802]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1330machine # [ 34.222170] systemd[1]: Stopped target Local File Systems.1331machine # [ 34.223852] systemd[1]: Stopped target Remote File Systems.1332machine # [ 34.585977] systemd[1]: Reload requested from client PID 1802 ('.switch-to-conf') (unit backdoor.service)...1333machine # [ 34.587694] systemd[1]: Reloading...1334machine # [ 35.020953] systemd[1]: Reloading finished in 431 ms.1335machine # [ 35.121136] systemd[633]: Reexecution requested from client PID 1872 ('switch-to-confi')...1336machine # [ 35.122391] systemd[633]: Reexecuting.1337machine # [ 35.145917] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1338machine # [ 35.266932] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1339machine # [ 35.272885] systemd[633]: Reload requested from client PID 1872 ('switch-to-confi')...1340machine # [ 35.274676] systemd[633]: Reloading...1341machine # [ 35.417494] systemd[633]: Reloading finished in 141 ms.1342machine # [ 35.422858] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1343machine # [ 35.429061] systemd[633]: Stopped Run user-specific NixOS activation.1344machine # [ 35.429943] systemd[633]: Stopping Run user-specific NixOS activation...1345machine # [ 35.432940] systemd[633]: Starting Run user-specific NixOS activation...1346machine # [ 35.463613] systemd[633]: Finished Run user-specific NixOS activation.1347machine # [ 35.466743] systemd[1]: Stopped target Reactivate sysinit units.1348machine # [ 35.468406] systemd[1]: Stopping Reactivate sysinit units...1349machine # [ 35.469555] systemd[1]: Reached target Reactivate sysinit units.1350machine # [ 35.472442] systemd[1]: Reached target Local File Systems.1351machine # [ 35.474522] systemd[1]: Reached target Remote File Systems.1352machine # [ 35.478088] systemd[1]: Starting linger-users.service...1353machine # [ 35.486748] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1354machine # [ 35.488104] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1355machine # [ 35.490056] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1356machine # [ 35.495502] systemd[1]: Starting Create SUID/SGID Wrappers...1357machine # [ 35.496268] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1358machine # [ 35.497347] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671359machine # [ 35.500281] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1360machine # [ 35.502571] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1361machine # [ 35.504468] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1362machine # [ 35.549589] systemd[1]: linger-users.service: Deactivated successfully.1363machine # [ 35.550965] systemd[1]: Finished linger-users.service.1364machine # [ 35.784648] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1365machine # [ 35.786521] systemd[1]: Finished Create SUID/SGID Wrappers.1366machine # [ 36.044460] nixos[1802]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1367machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration switch 2>&1, in 2.37 seconds)1368machine: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&11369machine: (finished: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration broken-action 2>&1, in 0.05 seconds)1370machine: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration 2>&11371machine: (finished: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration 2>&1, in 0.03 seconds)1372(finished: subtest: actions, in 2.52 seconds)1373subtest: init interface version1374machine: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/brokenInitInterface/bin/switch-to-configuration test 2>&11375machine: (finished: must fail: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-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/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11379machine # [ 36.714547] nixos[1959]: switching to system configuration /nix/store/r373qpnsr43ydgw01pfg30a6jswwlf4h-nixos-system-machine-test1380machine # [ 36.718062] systemd[1]: Stopped target Remote File Systems.1381machine # [ 36.719153] systemd[1]: Stopped target Local File Systems.1382machine # [ 37.173555] systemd[1]: Reexecution requested from client PID 1959 ('.switch-to-conf') (unit backdoor.service)...1383machine # [ 37.177371] systemd[1]: Reexecuting.1384machine # [ 37.475300] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1385machine # [ 37.483705] systemd[1]: Detected virtualization kvm.1386machine # [ 37.485235] systemd[1]: Detected architecture x86-64.1387machine # [ 37.582582] systemd[1]: bpf-restrict-fs: LSM BPF program attached1388machine # [ 37.895112] systemd[1]: Reload requested from client PID 1959 ('.switch-to-conf') (unit backdoor.service)...1389machine # [ 37.896630] systemd[1]: Reloading...1390machine # [ 38.375853] systemd[1]: Reloading finished in 476 ms.1391machine # [ 38.474653] systemd[633]: Reexecution requested from client PID 2062 ('switch-to-confi')...1392machine # [ 38.477139] systemd[633]: Reexecuting.1393machine # [ 38.508576] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1394machine # [ 38.656268] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1395machine # [ 38.661762] systemd[633]: Reload requested from client PID 2062 ('switch-to-confi')...1396machine # [ 38.663245] systemd[633]: Reloading...1397machine # [ 38.781896] systemd[633]: Reloading finished in 116 ms.1398machine # [ 38.787827] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1399machine # [ 38.794258] systemd[633]: Stopped Run user-specific NixOS activation.1400machine # [ 38.795301] systemd[633]: Stopping Run user-specific NixOS activation...1401machine # [ 38.798477] systemd[633]: Starting Run user-specific NixOS activation...1402machine # [ 38.830466] systemd[633]: Finished Run user-specific NixOS activation.1403machine # [ 38.833479] systemd[1]: Stopped target Reactivate sysinit units.1404machine # [ 38.834888] systemd[1]: Stopping Reactivate sysinit units...1405machine # [ 38.836139] systemd[1]: Reached target Reactivate sysinit units.1406machine # [ 38.840694] systemd[1]: Reached target Remote File Systems.1407machine # [ 38.845164] systemd[1]: Starting linger-users.service...1408machine # [ 38.848236] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1409machine # [ 38.849786] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1410machine # [ 38.853161] systemd[1]: Reached target Local File Systems.1411machine # [ 38.853953] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1412machine # [ 38.859112] systemd[1]: Starting Create SUID/SGID Wrappers...1413machine # [ 38.859975] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1414machine # [ 38.862274] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671415machine # [ 38.864332] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1416machine # [ 38.866992] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1417machine # [ 38.871269] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1418machine # [ 38.921399] systemd[1]: linger-users.service: Deactivated successfully.1419machine # [ 38.923608] systemd[1]: Finished linger-users.service.1420machine # [ 39.111824] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1421machine # [ 39.113074] systemd[1]: Finished Create SUID/SGID Wrappers.1422machine # [ 39.371441] nixos[1959]: finished switching to system configuration /nix/store/r373qpnsr43ydgw01pfg30a6jswwlf4h-nixos-system-machine-test1423machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 3.19 seconds)1424(finished: subtest: systemd restarts, in 3.19 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/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&11429machine # [ 39.883662] nixos[2137]: switching to system configuration /nix/store/r373qpnsr43ydgw01pfg30a6jswwlf4h-nixos-system-machine-test1430machine # [ 39.887282] systemd[1]: Stopped target Remote File Systems.1431machine # [ 39.888366] systemd[1]: Stopped target Local File Systems.1432machine # [ 40.279596] systemd[1]: Reload requested from client PID 2137 ('.switch-to-conf') (unit backdoor.service)...1433machine # [ 40.281305] systemd[1]: Reloading...1434machine # [ 40.712275] systemd[1]: Reloading finished in 429 ms.1435machine # [ 40.828140] systemd[633]: Reexecution requested from client PID 2206 ('switch-to-confi')...1436machine # [ 40.830131] systemd[633]: Reexecuting.1437machine # [ 40.856602] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1438machine # [ 40.991463] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1439machine # [ 40.996822] systemd[633]: Reload requested from client PID 2206 ('switch-to-confi')...1440machine # [ 40.998658] systemd[633]: Reloading...1441machine # [ 41.133033] systemd[633]: Reloading finished in 133 ms.1442machine # [ 41.138835] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1443machine # [ 41.145301] systemd[633]: Stopped Run user-specific NixOS activation.1444machine # [ 41.147065] systemd[633]: Stopping Run user-specific NixOS activation...1445machine # [ 41.149183] systemd[633]: Starting Run user-specific NixOS activation...1446machine # [ 41.184310] systemd[633]: Finished Run user-specific NixOS activation.1447machine # [ 41.187327] systemd[1]: Stopped target Reactivate sysinit units.1448machine # [ 41.188692] systemd[1]: Stopping Reactivate sysinit units...1449machine # [ 41.189618] systemd[1]: Reached target Reactivate sysinit units.1450machine # [ 41.191871] systemd[1]: Reached target Remote File Systems.1451machine # [ 41.195526] systemd[1]: Starting linger-users.service...1452machine # [ 41.201184] systemd[1]: Reached target Local File Systems.1453machine # [ 41.201958] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1454machine # [ 41.206496] systemd[1]: Starting Create SUID/SGID Wrappers...1455machine # [ 41.208450] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1456machine # [ 41.210112] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671457machine # [ 41.212057] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1458machine # [ 41.213455] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1459machine # [ 41.214672] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1460machine # [ 41.226149] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1461machine # [ 41.228599] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1462machine # [ 41.277097] systemd[1]: linger-users.service: Deactivated successfully.1463machine # [ 41.278141] systemd[1]: Finished linger-users.service.1464machine # [ 41.466917] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1465machine # [ 41.469281] systemd[1]: Finished Create SUID/SGID Wrappers.1466machine # [ 41.732170] nixos[2137]: finished switching to system configuration /nix/store/r373qpnsr43ydgw01pfg30a6jswwlf4h-nixos-system-machine-test1467machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/modifiedSystemConf/bin/switch-to-configuration test 2>&1, in 2.34 seconds)1468(finished: subtest: continuing from an aborted switch, in 2.36 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/n2idrk0jvf991mc9cwbdlyb60018wbhz-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.06 seconds)1474subtest: fstab mounts1475machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&11476machine # [ 42.217311] nixos[2283]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1477machine # [ 42.219597] systemd[1]: Stopped target Remote File Systems.1478machine # [ 42.221271] systemd[1]: Stopped target Local File Systems.1479machine # [ 42.545478] systemd[1]: Reexecution requested from client PID 2283 ('.switch-to-conf') (unit backdoor.service)...1480machine # [ 42.549260] systemd[1]: Reexecuting.1481machine # [ 42.844254] systemd[1]: systemd 262-2451b1a running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1482machine # [ 42.847741] systemd[1]: Detected virtualization kvm.1483machine # [ 42.848575] systemd[1]: Detected architecture x86-64.1484machine # [ 42.935169] systemd[1]: bpf-restrict-fs: LSM BPF program attached1485machine # [ 43.232408] systemd[1]: Reload requested from client PID 2283 ('.switch-to-conf') (unit backdoor.service)...1486machine # [ 43.234057] systemd[1]: Reloading...1487machine # [ 43.663239] systemd[1]: Reloading finished in 426 ms.1488machine # [ 43.777776] systemd[633]: Reexecution requested from client PID 2386 ('switch-to-confi')...1489machine # [ 43.780064] systemd[633]: Reexecuting.1490machine # [ 43.806399] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1491machine # [ 43.924420] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1492machine # [ 43.929763] systemd[633]: Reload requested from client PID 2386 ('switch-to-confi')...1493machine # [ 43.931118] systemd[633]: Reloading...1494machine # [ 44.083139] systemd[633]: Reloading finished in 149 ms.1495machine # [ 44.087853] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1496machine # [ 44.095066] systemd[633]: Stopped Run user-specific NixOS activation.1497machine # [ 44.095952] systemd[633]: Stopping Run user-specific NixOS activation...1498machine # [ 44.098956] systemd[633]: Starting Run user-specific NixOS activation...1499machine # [ 44.130727] systemd[633]: Finished Run user-specific NixOS activation.1500machine # [ 44.133913] systemd[1]: Stopped target Reactivate sysinit units.1501machine # [ 44.135329] systemd[1]: Stopping Reactivate sysinit units...1502machine # [ 44.136275] systemd[1]: Reached target Reactivate sysinit units.1503machine # [ 44.139380] systemd[1]: Reached target Remote File Systems.1504machine # [ 44.143093] systemd[1]: Starting linger-users.service...1505machine # [ 44.145059] systemd[1]: Reached target Local File Systems.1506machine # [ 44.147422] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1507machine # [ 44.150229] systemd[1]: Starting Create SUID/SGID Wrappers...1508machine # [ 44.152897] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1509machine # [ 44.155458] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671510machine # [ 44.157390] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1511machine # [ 44.158829] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1512machine # [ 44.160995] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1513machine # [ 44.165130] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1514machine # [ 44.166376] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1515machine # [ 44.222914] systemd[1]: linger-users.service: Deactivated successfully.1516machine # [ 44.224546] systemd[1]: Finished linger-users.service.1517machine # [ 44.468708] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1518machine # [ 44.471596] systemd[1]: Finished Create SUID/SGID Wrappers.1519machine # [ 44.727392] nixos[2283]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1520machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.94 seconds)1521machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11522machine # [ 45.187264] nixos[2457]: switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1523machine # [ 45.189560] systemd[1]: Stopped target Local File Systems.1524machine # [ 45.194581] systemd[1]: Stopped target Remote File Systems.1525machine # [ 45.637760] systemd[1]: Reload requested from client PID 2457 ('.switch-to-conf') (unit backdoor.service)...1526machine # [ 45.639505] systemd[1]: Reloading...1527machine # [ 46.091462] systemd[1]: Reloading finished in 450 ms.1528machine # [ 46.189078] systemd[633]: Reexecution requested from client PID 2526 ('switch-to-confi')...1529machine # [ 46.190402] systemd[633]: Reexecuting.1530machine # [ 46.219881] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1531machine # [ 46.362844] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1532machine # [ 46.368578] systemd[633]: Reload requested from client PID 2526 ('switch-to-confi')...1533machine # [ 46.369767] systemd[633]: Reloading...1534machine # [ 46.504729] systemd[633]: Reloading finished in 133 ms.1535machine # [ 46.509828] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1536machine # [ 46.516838] systemd[633]: Stopped Run user-specific NixOS activation.1537machine # [ 46.517763] systemd[633]: Stopping Run user-specific NixOS activation...1538machine # [ 46.520216] systemd[633]: Starting Run user-specific NixOS activation...1539machine # [ 46.553764] systemd[633]: Finished Run user-specific NixOS activation.1540machine # [ 46.556982] systemd[1]: Stopped target Reactivate sysinit units.1541machine # [ 46.558466] systemd[1]: Stopping Reactivate sysinit units...1542machine # [ 46.559873] systemd[1]: Reached target Reactivate sysinit units.1543machine # [ 46.560979] systemd[1]: Reached target Remote File Systems.1544machine # [ 46.565909] systemd[1]: Mounting /test...1545machine # [ 46.573278] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1546machine # [ 46.578272] systemd[1]: Starting Create SUID/SGID Wrappers...1547machine # [ 46.579219] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671548machine # [ 46.581155] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1549machine # [ 46.583989] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1550machine # [ 46.586493] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1551machine # [ 46.592407] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1552machine # [ 46.594070] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1553machine # [ 46.618127] systemd[1]: Mounted /test.1554machine # [ 46.620071] systemd[1]: Reached target Local File Systems.1555machine # [ 46.620933] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1556machine # [ 46.869682] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1557machine # [ 46.871427] systemd[1]: Finished Create SUID/SGID Wrappers.1558machine # [ 46.876276] systemd[1]: Starting linger-users.service...1559machine # [ 46.921764] systemd[1]: linger-users.service: Deactivated successfully.1560machine # [ 46.922826] systemd[1]: Finished linger-users.service.1561machine # [ 47.180462] nixos[2457]: finished switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1562machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.45 seconds)1563machine: must succeed: systemctl stop test.mount1564machine # [ 47.228744] systemd[1]: Stopped target Local File Systems.1565machine # [ 47.232598] systemd[1]: Unmounting /test...1566machine # [ 47.269129] systemd[1]: test.mount: Deactivated successfully.1567machine # [ 47.270461] systemd[1]: Unmounted /test.1568machine: (finished: must succeed: systemctl stop test.mount, in 0.09 seconds)1569machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11570machine # [ 47.699817] nixos[2605]: switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1571machine # [ 47.702626] systemd[1]: Stopped target Remote File Systems.1572machine # [ 48.062594] systemd[1]: Reload requested from client PID 2605 ('.switch-to-conf') (unit backdoor.service)...1573machine # [ 48.064272] systemd[1]: Reloading...1574machine # [ 48.495362] systemd[1]: Reloading finished in 429 ms.1575machine # [ 48.602903] systemd[633]: Reexecution requested from client PID 2674 ('switch-to-confi')...1576machine # [ 48.604919] systemd[633]: Reexecuting.1577machine # [ 48.630129] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1578machine # [ 48.748636] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1579machine # [ 48.753878] systemd[633]: Reload requested from client PID 2674 ('switch-to-confi')...1580machine # [ 48.755297] systemd[633]: Reloading...1581machine # [ 48.885576] systemd[633]: Reloading finished in 128 ms.1582machine # [ 48.890825] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1583machine # [ 48.897173] systemd[633]: Stopped Run user-specific NixOS activation.1584machine # [ 48.899046] systemd[633]: Stopping Run user-specific NixOS activation...1585machine # [ 48.901120] systemd[633]: Starting Run user-specific NixOS activation...1586machine # [ 48.931121] systemd[633]: Finished Run user-specific NixOS activation.1587machine # [ 48.934400] systemd[1]: Stopped target Reactivate sysinit units.1588machine # [ 48.936072] systemd[1]: Stopping Reactivate sysinit units...1589machine # [ 48.936830] systemd[1]: Reached target Reactivate sysinit units.1590machine # [ 48.940471] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1591machine # [ 48.942108] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1592machine # [ 48.949339] systemd[1]: Mounting /test...1593machine # [ 48.950070] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1594machine # [ 48.953632] systemd[1]: Starting Create SUID/SGID Wrappers...1595machine # [ 48.955584] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671596machine # [ 48.958291] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1597machine # [ 48.959825] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1598machine # [ 48.960962] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1599machine # [ 48.964230] systemd[1]: Reached target Remote File Systems.1600machine # [ 48.997324] systemd[1]: Mounted /test.1601machine # [ 48.999372] systemd[1]: Reached target Local File Systems.1602machine # [ 49.001904] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1603machine # [ 49.211487] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1604machine # [ 49.214597] systemd[1]: Finished Create SUID/SGID Wrappers.1605machine # [ 49.219643] systemd[1]: Starting linger-users.service...1606machine # [ 49.269526] systemd[1]: linger-users.service: Deactivated successfully.1607machine # [ 49.271218] systemd[1]: Finished linger-users.service.1608machine # [ 49.529215] nixos[2605]: finished switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1609machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.26 seconds)1610machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&11611machine # [ 49.986442] nixos[2747]: switching to system configuration /nix/store/cz5ll8056rgfkjrifvq70nxsbc91k3cx-nixos-system-machine-test1612machine # [ 49.988955] systemd[1]: Stopped target Remote File Systems.1613machine # [ 49.990754] systemd[1]: Stopped target Local File Systems.1614machine # [ 50.415897] systemd[1]: Reload requested from client PID 2747 ('.switch-to-conf') (unit backdoor.service)...1615machine # [ 50.417588] systemd[1]: Reloading...1616machine # [ 50.818855] systemd[1]: Reloading finished in 399 ms.1617machine # [ 50.923567] systemd[633]: Reexecution requested from client PID 2816 ('switch-to-confi')...1618machine # [ 50.925270] systemd[633]: Reexecuting.1619machine # [ 50.948885] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1620machine # [ 51.080712] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1621machine # [ 51.086723] systemd[633]: Reload requested from client PID 2816 ('switch-to-confi')...1622machine # [ 51.088648] systemd[633]: Reloading...1623machine # [ 51.239603] systemd[633]: Reloading finished in 149 ms.1624machine # [ 51.244871] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1625machine # [ 51.251612] systemd[633]: Stopped Run user-specific NixOS activation.1626machine # [ 51.253096] systemd[633]: Stopping Run user-specific NixOS activation...1627machine # [ 51.256067] systemd[633]: Starting Run user-specific NixOS activation...1628machine # [ 51.298112] systemd[633]: Finished Run user-specific NixOS activation.1629machine # [ 51.303784] systemd[1]: Stopped target Reactivate sysinit units.1630machine # [ 51.305390] systemd[1]: Stopping Reactivate sysinit units...1631machine # [ 51.307228] systemd[1]: Reached target Reactivate sysinit units.1632machine # [ 51.309956] systemd[1]: Reloading /test...1633machine # [ 51.342715] systemd[1]: Reloaded /test.1634machine # [ 51.347669] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1635machine # [ 51.349682] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1636machine # [ 51.352414] systemd[1]: Reached target Remote File Systems.1637machine # [ 51.358074] systemd[1]: Starting linger-users.service...1638machine # [ 51.363208] systemd[1]: Reached target Local File Systems.1639machine # [ 51.364311] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1640machine # [ 51.370055] systemd[1]: Starting Create SUID/SGID Wrappers...1641machine # [ 51.370910] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1642machine # [ 51.373197] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671643machine # [ 51.377652] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1644machine # [ 51.380126] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1645machine # [ 51.382323] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1646machine # [ 51.433883] systemd[1]: linger-users.service: Deactivated successfully.1647machine # [ 51.435750] systemd[1]: Finished linger-users.service.1648machine # [ 51.648521] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1649machine # [ 51.650338] systemd[1]: Finished Create SUID/SGID Wrappers.1650machine # [ 51.906067] nixos[2747]: finished switching to system configuration /nix/store/cz5ll8056rgfkjrifvq70nxsbc91k3cx-nixos-system-machine-test1651machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMountOptsModified/bin/switch-to-configuration test 2>&1, in 2.38 seconds)1652machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&11653machine # [ 52.340791] nixos[2889]: switching to system configuration /nix/store/xdkk7ynrihqg4qg1n0jrd9x1r4ld429c-nixos-system-machine-test1654machine # [ 52.343396] systemd[1]: Stopped target Local File Systems.1655machine # [ 52.345234] systemd[1]: Stopped target Remote File Systems.1656machine # [ 52.765382] systemd[1]: Reload requested from client PID 2889 ('.switch-to-conf') (unit backdoor.service)...1657machine # [ 52.767163] systemd[1]: Reloading...1658machine # [ 53.262969] systemd[1]: Reloading finished in 493 ms.1659machine # [ 53.374427] systemd[633]: Reexecution requested from client PID 2958 ('switch-to-confi')...1660machine # [ 53.377374] systemd[633]: Reexecuting.1661machine # [ 53.404755] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1662machine # [ 53.545530] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1663machine # [ 53.551748] systemd[633]: Reload requested from client PID 2958 ('switch-to-confi')...1664machine # [ 53.552961] systemd[633]: Reloading...1665machine # [ 53.698283] systemd[633]: Reloading finished in 142 ms.1666machine # [ 53.701824] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1667machine # [ 53.708372] systemd[633]: Stopped Run user-specific NixOS activation.1668machine # [ 53.709390] systemd[633]: Stopping Run user-specific NixOS activation...1669machine # [ 53.712879] systemd[633]: Starting Run user-specific NixOS activation...1670machine # [ 53.749269] systemd[633]: Finished Run user-specific NixOS activation.1671machine # [ 53.752790] systemd[1]: Stopped target Reactivate sysinit units.1672machine # [ 53.754489] systemd[1]: Stopping Reactivate sysinit units...1673machine # [ 53.755822] systemd[1]: Reached target Reactivate sysinit units.1674machine # [ 53.757962] systemd[1]: Unmounting /test...1675machine # [ 53.787626] systemd[1]: test.mount: Deactivated successfully.1676machine # [ 53.789073] systemd[1]: Unmounted /test.1677machine # [ 53.793474] systemd[1]: Mounting /test...1678machine # [ 53.828116] systemd[1]: Mounted /test.1679machine # [ 53.832544] systemd[1]: Reached target Local File Systems.1680machine # [ 53.835064] systemd[1]: Reached target Remote File Systems.1681machine # [ 53.837601] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1682machine # [ 53.839600] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1683machine # [ 53.841849] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1684machine # [ 53.847528] systemd[1]: Starting Create SUID/SGID Wrappers...1685machine # [ 53.848548] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1686machine # [ 53.849750] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671687machine # [ 53.851774] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1688machine # [ 53.853210] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1689machine # [ 53.854355] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1690machine # [ 54.125154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1691machine # [ 54.128305] systemd[1]: Finished Create SUID/SGID Wrappers.1692machine # [ 54.131096] systemd[1]: Starting linger-users.service...1693machine # [ 54.178382] systemd[1]: linger-users.service: Deactivated successfully.1694machine # [ 54.179970] systemd[1]: Finished linger-users.service.1695machine # [ 54.437440] nixos[2889]: finished switching to system configuration /nix/store/xdkk7ynrihqg4qg1n0jrd9x1r4ld429c-nixos-system-machine-test1696machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMountDevModified/bin/switch-to-configuration test 2>&1, in 2.53 seconds)1697machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&11698machine # [ 54.937964] nixos[3033]: switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1699machine # [ 54.940661] systemd[1]: Stopped target Remote File Systems.1700machine # [ 54.942475] systemd[1]: Stopped target Local File Systems.1701machine # [ 55.291312] systemd[1]: Reload requested from client PID 3033 ('.switch-to-conf') (unit backdoor.service)...1702machine # [ 55.292961] systemd[1]: Reloading...1703machine # [ 55.716104] systemd[1]: Reloading finished in 421 ms.1704machine # [ 55.817599] systemd[633]: Reexecution requested from client PID 3102 ('switch-to-confi')...1705machine # [ 55.819371] systemd[633]: Reexecuting.1706machine # [ 55.842808] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1707machine # [ 55.957428] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1708machine # [ 55.961888] systemd[633]: Reload requested from client PID 3102 ('switch-to-confi')...1709machine # [ 55.963646] systemd[633]: Reloading...1710machine # [ 56.102533] systemd[633]: Reloading finished in 137 ms.1711machine # [ 56.107818] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1712machine # [ 56.115070] systemd[633]: Stopped Run user-specific NixOS activation.1713machine # [ 56.115943] systemd[633]: Stopping Run user-specific NixOS activation...1714machine # [ 56.118567] systemd[633]: Starting Run user-specific NixOS activation...1715machine # [ 56.147419] systemd[633]: Finished Run user-specific NixOS activation.1716machine # [ 56.150608] systemd[1]: Stopped target Reactivate sysinit units.1717machine # [ 56.152183] systemd[1]: Stopping Reactivate sysinit units...1718machine # [ 56.152939] systemd[1]: Reached target Reactivate sysinit units.1719machine # [ 56.155733] systemd[1]: Unmounting /test...1720machine # [ 56.182170] systemd[1]: test.mount: Deactivated successfully.1721machine # [ 56.183551] systemd[1]: Unmounted /test.1722machine # [ 56.187485] systemd[1]: Mounting /test...1723machine # [ 56.212401] systemd[1]: Mounted /test.1724machine # [ 56.218217] systemd[1]: Reached target Remote File Systems.1725machine # [ 56.221640] systemd[1]: Starting linger-users.service...1726machine # [ 56.223890] systemd[1]: Reached target Local File Systems.1727machine # [ 56.232237] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1728machine # [ 56.238490] systemd[1]: Starting Create SUID/SGID Wrappers...1729machine # [ 56.239501] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1730machine # [ 56.242072] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671731machine # [ 56.244821] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1732machine # [ 56.247120] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1733machine # [ 56.250364] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1734machine # [ 56.251664] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1735machine # [ 56.253172] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1736machine # [ 56.298749] systemd[1]: linger-users.service: Deactivated successfully.1737machine # [ 56.299939] systemd[1]: Finished linger-users.service.1738machine # [ 56.548319] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1739machine # [ 56.549991] systemd[1]: Finished Create SUID/SGID Wrappers.1740machine # [ 56.808261] nixos[3033]: finished switching to system configuration /nix/store/nr40jkbrmbq3q6mmssmph04dcbw38zxb-nixos-system-machine-test1741machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/addedMount/bin/switch-to-configuration test 2>&1, in 2.37 seconds)1742machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&11743machine # [ 57.293832] nixos[3177]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1744machine # [ 57.297080] systemd[1]: Stopped target Local File Systems.1745machine # [ 57.301282] systemd[1]: Unmounting /test...1746machine # [ 57.302083] systemd[1]: Stopped target Remote File Systems.1747machine # [ 57.332113] systemd[1]: test.mount: Deactivated successfully.1748machine # [ 57.334189] systemd[1]: Unmounted /test.1749machine # [ 57.723054] systemd[1]: Reload requested from client PID 3177 ('.switch-to-conf') (unit backdoor.service)...1750machine # [ 57.724697] systemd[1]: Reloading...1751machine # [ 58.168100] systemd[1]: Reloading finished in 441 ms.1752machine # [ 58.266304] systemd[633]: Reexecution requested from client PID 3248 ('switch-to-confi')...1753machine # [ 58.268342] systemd[633]: Reexecuting.1754machine # [ 58.292156] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1755machine # [ 58.424830] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1756machine # [ 58.430431] systemd[633]: Reload requested from client PID 3248 ('switch-to-confi')...1757machine # [ 58.432038] systemd[633]: Reloading...1758machine # [ 58.566196] systemd[633]: Reloading finished in 131 ms.1759machine # [ 58.571814] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1760machine # [ 58.578240] systemd[633]: Stopped Run user-specific NixOS activation.1761machine # [ 58.580103] systemd[633]: Stopping Run user-specific NixOS activation...1762machine # [ 58.582881] systemd[633]: Starting Run user-specific NixOS activation...1763machine # [ 58.616477] systemd[633]: Finished Run user-specific NixOS activation.1764machine # [ 58.619884] systemd[1]: Stopped target Reactivate sysinit units.1765machine # [ 58.621606] systemd[1]: Stopping Reactivate sysinit units...1766machine # [ 58.622736] systemd[1]: Reached target Reactivate sysinit units.1767machine # [ 58.624309] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1768machine # [ 58.625603] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1769machine # [ 58.629308] systemd[1]: Reached target Remote File Systems.1770machine # [ 58.632329] systemd[1]: Starting linger-users.service...1771machine # [ 58.639815] systemd[1]: Reached target Local File Systems.1772machine # [ 58.645324] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1773machine # [ 58.650101] systemd[1]: Starting Create SUID/SGID Wrappers...1774machine # [ 58.650889] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1775machine # [ 58.653182] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671776machine # [ 58.655191] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1777machine # [ 58.656738] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1778machine # [ 58.658072] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1779machine # [ 58.703638] systemd[1]: linger-users.service: Deactivated successfully.1780machine # [ 58.705505] systemd[1]: Finished linger-users.service.1781machine # [ 58.950504] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1782machine # [ 58.952288] systemd[1]: Finished Create SUID/SGID Wrappers.1783machine # [ 59.210262] nixos[3177]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1784machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.40 seconds)1785machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&11786machine # [ 59.714344] nixos[3319]: switching to system configuration /nix/store/mg07w1ks62iw2pkl32l6y1f3vjyshnf7-nixos-system-machine-test1787machine # [ 59.716818] systemd[1]: Stopped target Remote File Systems.1788machine # [ 59.718613] systemd[1]: Stopped target Local File Systems.1789machine # [ 60.164783] systemd[1]: Reload requested from client PID 3319 ('.switch-to-conf') (unit backdoor.service)...1790machine # [ 60.166462] systemd[1]: Reloading...1791machine # [ 60.638919] systemd[1]: Reloading finished in 470 ms.1792machine # [ 60.754324] systemd[633]: Reexecution requested from client PID 3388 ('switch-to-confi')...1793machine # [ 60.755595] systemd[633]: Reexecuting.1794machine # [ 60.782423] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1795machine # [ 60.914956] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1796machine # [ 60.920588] systemd[633]: Reload requested from client PID 3388 ('switch-to-confi')...1797machine # [ 60.922334] systemd[633]: Reloading...1798machine # [ 61.040082] systemd[633]: Reloading finished in 116 ms.1799machine # [ 61.045814] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1800machine # [ 61.052272] systemd[633]: Stopped Run user-specific NixOS activation.1801machine # [ 61.054111] systemd[633]: Stopping Run user-specific NixOS activation...1802machine # [ 61.056483] systemd[633]: Starting Run user-specific NixOS activation...1803machine # [ 61.091445] systemd[633]: Finished Run user-specific NixOS activation.1804machine # [ 61.094679] systemd[1]: Stopped target Reactivate sysinit units.1805machine # [ 61.096352] systemd[1]: Stopping Reactivate sysinit units...1806machine # [ 61.097337] systemd[1]: Reached target Reactivate sysinit units.1807machine # [ 61.100067] systemd[1]: Reached target Local File Systems.1808machine # [ 61.101057] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1809machine # [ 61.105836] systemd[1]: Starting Create SUID/SGID Wrappers...1810machine # [ 61.106681] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1811machine # [ 61.107790] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671812machine # [ 61.109737] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1813machine # [ 61.112574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1814machine # [ 61.116183] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1815machine # [ 61.118781] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1816machine # [ 61.120584] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1817machine # [ 61.126299] systemd[1]: Reached target Remote File Systems.1818machine # [ 61.401471] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1819machine # [ 61.403272] systemd[1]: Finished Create SUID/SGID Wrappers.1820machine # [ 61.407474] systemd[1]: Starting linger-users.service...1821machine # [ 61.452976] systemd[1]: linger-users.service: Deactivated successfully.1822machine # [ 61.454481] systemd[1]: Finished linger-users.service.1823machine # [ 61.712762] nixos[3319]: finished switching to system configuration /nix/store/mg07w1ks62iw2pkl32l6y1f3vjyshnf7-nixos-system-machine-test1824machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/storeMountModified/bin/switch-to-configuration test 2>&1, in 2.50 seconds)1825machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&11826machine # [ 62.205728] nixos[3459]: switching to system configuration /nix/store/74vk28czcgf3xrjmhfk3ipqh1w3zyfz9-nixos-system-machine-test1827machine # [ 62.208342] systemd[1]: Stopped target Remote File Systems.1828machine # [ 62.209881] systemd[1]: Stopped target Local File Systems.1829machine # [ 62.584030] systemd[1]: Reload requested from client PID 3459 ('.switch-to-conf') (unit backdoor.service)...1830machine # [ 62.585613] systemd[1]: Reloading...1831machine # [ 63.012910] systemd[1]: Reloading finished in 425 ms.1832machine # [ 63.127295] systemd[633]: Reexecution requested from client PID 3528 ('switch-to-confi')...1833machine # [ 63.129548] systemd[633]: Reexecuting.1834machine # [ 63.154331] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1835machine # [ 63.268510] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1836machine # [ 63.273724] systemd[633]: Reload requested from client PID 3528 ('switch-to-confi')...1837machine # [ 63.275296] systemd[633]: Reloading...1838machine # [ 63.414510] systemd[633]: Reloading finished in 137 ms.1839machine # [ 63.419064] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1840machine # [ 63.426125] systemd[633]: Stopped Run user-specific NixOS activation.1841machine # [ 63.427301] systemd[633]: Stopping Run user-specific NixOS activation...1842machine # [ 63.430359] systemd[633]: Starting Run user-specific NixOS activation...1843machine # [ 63.460954] systemd[633]: Finished Run user-specific NixOS activation.1844machine # [ 63.464597] systemd[1]: Stopped target Reactivate sysinit units.1845machine # [ 63.465837] systemd[1]: Stopping Reactivate sysinit units...1846machine # [ 63.467174] systemd[1]: Reached target Reactivate sysinit units.1847machine # [ 63.469028] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1848machine # [ 63.470802] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1849machine # [ 63.472706] systemd[1]: Reached target Remote File Systems.1850machine # [ 63.477407] systemd[1]: Set up automount testauto.automount.1851machine # [ 63.478231] systemd[1]: Reached target Local File Systems.1852machine # [ 63.478955] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1853machine # [ 63.484224] systemd[1]: Starting Create SUID/SGID Wrappers...1854machine # [ 63.485114] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1855machine # [ 63.486225] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671856machine # [ 63.489702] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1857machine # [ 63.491644] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1858machine # [ 63.494618] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1859machine # [ 63.735437] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1860machine # [ 63.737082] systemd[1]: Finished Create SUID/SGID Wrappers.1861machine # [ 63.741766] systemd[1]: Starting linger-users.service...1862machine # [ 63.786913] systemd[1]: linger-users.service: Deactivated successfully.1863machine # [ 63.788454] systemd[1]: Finished linger-users.service.1864machine # [ 64.046185] nixos[3459]: finished switching to system configuration /nix/store/74vk28czcgf3xrjmhfk3ipqh1w3zyfz9-nixos-system-machine-test1865machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/automount/bin/switch-to-configuration test 2>&1, in 2.33 seconds)1866machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&11867machine # [ 64.494403] nixos[3599]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1868machine # [ 64.496935] systemd[1]: Stopped target Local File Systems.1869machine # [ 64.500128] systemd[1]: testauto.automount: Deactivated successfully.1870machine # [ 64.501094] systemd[1]: Unset automount testauto.automount.1871machine # [ 64.502906] systemd[1]: Stopped target Remote File Systems.1872machine # [ 64.839513] systemd[1]: Reload requested from client PID 3599 ('.switch-to-conf') (unit backdoor.service)...1873machine # [ 64.841513] systemd[1]: Reloading...1874machine # [ 65.283073] systemd[1]: Reloading finished in 438 ms.1875machine # [ 65.390175] systemd[633]: Reexecution requested from client PID 3668 ('switch-to-confi')...1876machine # [ 65.392942] systemd[633]: Reexecuting.1877machine # [ 65.416651] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1878machine # [ 65.554617] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1879machine # [ 65.560691] systemd[633]: Reload requested from client PID 3668 ('switch-to-confi')...1880machine # [ 65.562159] systemd[633]: Reloading...1881machine # [ 65.683790] systemd[633]: Reloading finished in 119 ms.1882machine # [ 65.687828] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1883machine # [ 65.694064] systemd[633]: Stopped Run user-specific NixOS activation.1884machine # [ 65.695989] systemd[633]: Stopping Run user-specific NixOS activation...1885machine # [ 65.698362] systemd[633]: Starting Run user-specific NixOS activation...1886machine # [ 65.734234] systemd[633]: Finished Run user-specific NixOS activation.1887machine # [ 65.737545] systemd[1]: Stopped target Reactivate sysinit units.1888machine # [ 65.738919] systemd[1]: Stopping Reactivate sysinit units...1889machine # [ 65.740287] systemd[1]: Reached target Reactivate sysinit units.1890machine # [ 65.743173] systemd[1]: Reached target Remote File Systems.1891machine # [ 65.749139] systemd[1]: Reached target Local File Systems.1892machine # [ 65.749917] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1893machine # [ 65.752374] systemd[1]: Starting Create SUID/SGID Wrappers...1894machine # [ 65.754217] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1895machine # [ 65.756261] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671896machine # [ 65.758672] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1897machine # [ 65.760586] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1898machine # [ 65.762915] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1899machine # [ 65.769476] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1900machine # [ 65.771213] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1901machine # [ 65.988874] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1902machine # [ 65.990301] systemd[1]: Finished Create SUID/SGID Wrappers.1903machine # [ 65.994598] systemd[1]: Starting linger-users.service...1904machine # [ 66.033780] systemd[1]: linger-users.service: Deactivated successfully.1905machine # [ 66.035240] systemd[1]: Finished linger-users.service.1906machine # [ 66.290435] nixos[3599]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1907machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.24 seconds)1908(finished: subtest: fstab mounts, in 24.50 seconds)1909subtest: swaps1910machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&11911machine # [ 66.773045] nixos[3739]: switching to system configuration /nix/store/wbjnr76h1yc5di3b6dwyvkzfyw0whnpj-nixos-system-machine-test1912machine # [ 66.776553] systemd[1]: Stopped target Local File Systems.1913machine # [ 66.777421] systemd[1]: Stopped target Remote File Systems.1914machine # [ 67.163383] systemd[1]: Reload requested from client PID 3739 ('.switch-to-conf') (unit backdoor.service)...1915machine # [ 67.165118] systemd[1]: Reloading...1916machine # [ 67.951899] systemd[1]: Reloading finished in 784 ms.1917machine # [ 68.065245] systemd[633]: Reexecution requested from client PID 3808 ('switch-to-confi')...1918machine # [ 68.066494] systemd[633]: Reexecuting.1919machine # [ 68.090475] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1920machine # [ 68.225058] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1921machine # [ 68.231051] systemd[633]: Reload requested from client PID 3808 ('switch-to-confi')...1922machine # [ 68.232275] systemd[633]: Reloading...1923machine # [ 68.373413] systemd[633]: Reloading finished in 138 ms.1924machine # [ 68.378854] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1925machine # [ 68.385641] systemd[633]: Stopped Run user-specific NixOS activation.1926machine # [ 68.386617] systemd[633]: Stopping Run user-specific NixOS activation...1927machine # [ 68.389775] systemd[633]: Starting Run user-specific NixOS activation...1928machine # [ 68.422979] systemd[633]: Finished Run user-specific NixOS activation.1929machine # [ 68.426119] systemd[1]: Stopped target Reactivate sysinit units.1930machine # [ 68.427717] systemd[1]: Stopping Reactivate sysinit units...1931machine # [ 68.428841] systemd[1]: Reached target Reactivate sysinit units.1932machine # [ 68.432754] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1933machine # [ 68.434497] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1934machine # [ 68.440119] systemd[1]: Reached target Remote File Systems.1935machine # [ 68.443110] systemd[1]: Starting linger-users.service...1936machine # [ 68.444662] systemd[1]: Reached target Local File Systems.1937machine # [ 68.452787] systemd[1]: Starting Initialisation of swap device /swapfile...1938machine # [ 68.454761] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1939machine # [ 68.464394] systemd[1]: Starting Create SUID/SGID Wrappers...1940machine # [ 68.467072] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1941machine # [ 68.469381] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671942machine # [ 68.472299] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1943machine # [ 68.474788] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1944machine # [ 68.476400] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1945machine # [ 68.537159] systemd[1]: linger-users.service: Deactivated successfully.1946machine # [ 68.539166] systemd[1]: Finished linger-users.service.1947machine # [ 68.563551] mkswap-swapfile-start[3821]: Creating swap file using dd and mkswap.1948machine # [ 68.590599] mkswap-swapfile-start[3844]: 1+0 records in1949machine # [ 68.591703] mkswap-swapfile-start[3844]: 1+0 records out1950machine # [ 68.592690] mkswap-swapfile-start[3844]: 1048576 bytes (1.0 MB, 1.0 MiB) copied, 0.00267995 s, 391 MB/s1951machine # [ 68.796615] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1952machine # [ 68.798508] systemd[1]: Finished Create SUID/SGID Wrappers.1953machine # [ 69.144079] mkswap-swapfile-start[3847]: Setting up swapspace version 1, size = 1020 KiB (1044480 bytes)1954machine # [ 69.145281] mkswap-swapfile-start[3847]: no label, UUID=067ff26d-3926-4293-840b-7e06ed2609081955machine # [ 69.149080] systemd[1]: mkswap-swapfile.service: Deactivated successfully.1956machine # [ 69.150313] systemd[1]: Finished Initialisation of swap device /swapfile.1957machine # [ 69.152311] systemd[1]: mkswap-swapfile.service: Consumed 31ms CPU time over 696ms wall clock time, 3.2M memory peak, 1M written to disk.1958machine # [ 69.156500] systemd[1]: Activating swap /swapfile...1959machine # [ 69.337322] Adding 1020k swap on /swapfile. Priority:-2 extents:1 across:1020k1960machine # [ 69.196505] systemd[1]: Activated swap /swapfile.1961machine # [ 69.456852] nixos[3739]: finished switching to system configuration /nix/store/wbjnr76h1yc5di3b6dwyvkzfyw0whnpj-nixos-system-machine-test1962machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/specialisation/swap/bin/switch-to-configuration test 2>&1, in 3.17 seconds)1963machine: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&11964machine # [ 69.906491] systemd[1]: swapfile.swap: Deactivated successfully.1965machine # [ 69.908639] nixos[3893]: switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test1966machine # [ 69.910570] systemd[1]: Stopped target Remote File Systems.1967machine # [ 69.911804] systemd[1]: Stopped target Local File Systems.1968machine # [ 70.298621] systemd[1]: Reload requested from client PID 3893 ('.switch-to-conf') (unit backdoor.service)...1969machine # [ 70.300490] systemd[1]: Reloading...1970machine # [ 70.764842] systemd[1]: Reloading finished in 462 ms.1971machine # [ 70.868121] systemd[633]: Reexecution requested from client PID 3962 ('switch-to-confi')...1972machine # [ 70.870845] systemd[633]: Reexecuting.1973machine # [ 70.896096] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1974machine # [ 71.030489] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1975machine # [ 71.034826] systemd[633]: Reload requested from client PID 3962 ('switch-to-confi')...1976machine # [ 71.036481] systemd[633]: Reloading...1977machine # [ 71.173059] systemd[633]: Reloading finished in 135 ms.1978machine # [ 71.178805] systemd[633]: Failed to adjust io pressure threshold, ignoring: Device or resource busy1979machine # [ 71.185245] systemd[633]: Stopped Run user-specific NixOS activation.1980machine # [ 71.187063] systemd[633]: Stopping Run user-specific NixOS activation...1981machine # [ 71.189191] systemd[633]: Starting Run user-specific NixOS activation...1982machine # [ 71.222683] systemd[633]: Finished Run user-specific NixOS activation.1983machine # [ 71.225915] systemd[1]: Stopped target Reactivate sysinit units.1984machine # [ 71.227254] systemd[1]: Stopping Reactivate sysinit units...1985machine # [ 71.228276] systemd[1]: Reached target Reactivate sysinit units.1986machine # [ 71.231353] systemd[1]: Reached target Local File Systems.1987machine # [ 71.233347] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1988machine # [ 71.237383] systemd[1]: Starting Create SUID/SGID Wrappers...1989machine # [ 71.238232] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1990machine # [ 71.239394] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671991machine # [ 71.241346] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1992machine # [ 71.242766] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1993machine # [ 71.243903] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1994machine # [ 71.247511] systemd[1]: Reached target Remote File Systems.1995machine # [ 71.255124] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1996machine # [ 71.256838] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1997machine # [ 71.528765] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1998machine # [ 71.530087] systemd[1]: Finished Create SUID/SGID Wrappers.1999machine # [ 71.535422] systemd[1]: Starting linger-users.service...2000machine # [ 71.579798] systemd[1]: linger-users.service: Deactivated successfully.2001machine # [ 71.580789] systemd[1]: Finished linger-users.service.2002machine # [ 71.838551] nixos[3893]: finished switching to system configuration /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test2003machine: (finished: must succeed: /nix/store/9xj5339hhmc7pwb3kikc0kqx4lbdf2qr-nixos-system-machine-test/bin/switch-to-configuration test 2>&1, in 2.38 seconds)2004(finished: subtest: swaps, in 5.55 seconds)2005(finished: run the VM test script, in 72.80 seconds)2006test script finished in 73.00s2007cleanup2008kill 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.18 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