vm-test-run-systemd-vaultd
checks.x86_64-linux.systemd-vaultd
· build #28
· raw
1tribuchet: building on jamie2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7start all VMs8machine: starting vm9machine: QEMU running (pid 46)10machine # Disk image does not exist, creating the virtualisation disk image...11machine # Formatting '/build/vm-state-machine/tmp.e62lEMALog', fmt=raw size=107374182412(finished: start all VMs, in 0.23 seconds)13machine # mke2fs 1.47.4 (6-Mar-2025)14machine: waiting for unit vault.service15machine # Discarding device blocks: 0/262144 done16machine: waiting for the VM to finish booting17machine # Creating filesystem with 262144 4k blocks and 65536 inodes18machine # Filesystem UUID: 09db12ed-9e17-4fb5-ad83-7a5afdca327319machine # Superblock backups stored on blocks:20machine # 32768, 98304, 163840, 22937621machine # 22machine # Allocating group tables: 0/8 done23machine # Writing inode tables: 0/8 done24machine # Creating journal (8192 blocks): done25machine # Writing superblocks and filesystem accounting information: 0/8 done26machine # 27machine # Virtualisation disk image created.28machine # Starting virtiofs daemons...29machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31machine # [2026-09-15T20:06:42Z INFO virtiofsd] Waiting for vhost-user socket connection...32machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34machine # [2026-09-15T20:06:42Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)36machine # [2026-09-15T20:06:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether37machine # [2026-09-15T20:06:42Z INFO virtiofsd] Waiting for vhost-user socket connection...38machine # [2026-09-15T20:06:42Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-09-15T20:06:42Z INFO virtiofsd] Client connected, servicing requests40machine # [2026-09-15T20:06:42Z INFO virtiofsd] Client connected, servicing requests41machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)42machine # 43machine # 44machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0045machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...46machine # 47machine # 48machine # 49machine # 50machine # iPXE (http://ipxe.org) 00:05.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0051machine # Press Ctrl-B to configure iPXE (PCI 00:05.0)...52machine # 53machine # 54machine # Booting from ROM...55machine # Probing EDD (edd=off to disable)... ok[ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Fri Sep 11 09:49:46 UTC 202656machine # [ 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/x2xjw51wh4rcckidvj571z1xnxawj42j-nixos-system-machine-test/init regInfo=/nix/store/5f7jck25n4338a7gc7pnn1ic4f808p3h-closure-info/registration console=ttyS0,115200n8 console=tty057machine # [ 0.000000] BIOS-provided physical RAM map:58machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable59machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved60machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved61machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable62machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved63machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved64machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved65machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved66machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved67machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved68machine # [ 0.000000] NX (Execute Disable) protection: active69machine # [ 0.000000] APIC: Static calls initialized70machine # [ 0.000000] SMBIOS 2.8 present.71machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201472machine # [ 0.000000] DMI: Memory slots populated: 1/173machine # [ 0.000000] Hypervisor detected: KVM74machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000075machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0076machine # [ 0.000000] kvm-clock: using sched offset of 467175706 cycles77machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns78machine # [ 0.000004] tsc: Detected 2400.012 MHz processor79machine # [ 0.000809] last_pfn = 0x3ffd8 max_arch_pfn = 0x1000000000080machine # [ 0.000835] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs81machine # [ 0.000838] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT82machine # [ 0.002723] found SMP MP-table at [mem 0x000f5450-0x000f545f]83machine # [ 0.002734] Using GB pages for direct mapping84machine # [ 0.002833] RAMDISK: [mem 0x3e36b000-0x3ffcffff]85machine # [ 0.002840] ACPI: Early table checksum verification disabled86machine # [ 0.002843] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )87machine # [ 0.002847] ACPI: RSDT 0x000000003FFE2539 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)88machine # [ 0.002851] ACPI: FACP 0x000000003FFE2319 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)89machine # [ 0.002858] ACPI: DSDT 0x000000003FFE0040 0022D9 (v01 BOCHS BXPC 00000001 BXPC 00000001)90machine # [ 0.002860] ACPI: FACS 0x000000003FFE0000 00004091machine # [ 0.002861] ACPI: APIC 0x000000003FFE240D 000090 (v03 BOCHS BXPC 00000001 BXPC 00000001)92machine # [ 0.002863] ACPI: HPET 0x000000003FFE249D 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)93machine # [ 0.002864] ACPI: MCFG 0x000000003FFE24D5 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)94machine # [ 0.002866] ACPI: WAET 0x000000003FFE2511 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)95machine # [ 0.002867] ACPI: Reserving FACP table memory at [mem 0x3ffe2319-0x3ffe240c]96machine # [ 0.002868] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2318]97machine # [ 0.002869] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]98machine # [ 0.002869] ACPI: Reserving APIC table memory at [mem 0x3ffe240d-0x3ffe249c]99machine # [ 0.002870] ACPI: Reserving HPET table memory at [mem 0x3ffe249d-0x3ffe24d4]100machine # [ 0.002870] ACPI: Reserving MCFG table memory at [mem 0x3ffe24d5-0x3ffe2510]101machine # [ 0.002871] ACPI: Reserving WAET table memory at [mem 0x3ffe2511-0x3ffe2538]102machine # [ 0.003091] No NUMA configuration found103machine # [ 0.003092] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]104machine # [ 0.003095] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]105machine # [ 0.005245] Zone ranges:106machine # [ 0.005245] DMA [mem 0x0000000000001000-0x0000000000ffffff]107machine # [ 0.005247] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]108machine # [ 0.005248] Normal empty109machine # [ 0.005248] Device empty110machine # [ 0.005249] Movable zone start for each node111machine # [ 0.005250] Early memory node ranges112machine # [ 0.005250] node 0: [mem 0x0000000000001000-0x000000000009efff]113machine # [ 0.005251] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]114machine # [ 0.005252] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]115machine # [ 0.005270] On node 0, zone DMA: 1 pages in unavailable ranges116machine # [ 0.005522] On node 0, zone DMA: 97 pages in unavailable ranges117machine # [ 0.022678] On node 0, zone DMA32: 40 pages in unavailable ranges118machine # [ 0.023126] ACPI: PM-Timer IO Port: 0x608119machine # [ 0.023135] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])120machine # [ 0.023165] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23121machine # [ 0.023168] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)122machine # [ 0.023169] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)123machine # [ 0.023170] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)124machine # [ 0.023171] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)125machine # [ 0.023172] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)126machine # [ 0.023174] ACPI: Using ACPI (MADT) for SMP configuration information127machine # [ 0.023175] ACPI: HPET id: 0x8086a201 base: 0xfed00000128machine # [ 0.023178] TSC deadline timer available129machine # [ 0.023182] CPU topo: Max. logical packages: 1130machine # [ 0.023183] CPU topo: Max. logical dies: 1131machine # [ 0.023183] CPU topo: Max. dies per package: 1132machine # [ 0.023187] CPU topo: Max. threads per core: 1133machine # [ 0.023187] CPU topo: Num. cores per package: 4134machine # [ 0.023187] CPU topo: Num. threads per package: 4135machine # [ 0.023188] CPU topo: Allowing 4 present CPUs plus 0 hotplug CPUs136machine # [ 0.023204] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()137machine # [ 0.023218] kvm-guest: KVM setup pv remote TLB flush138machine # [ 0.023220] kvm-guest: setup PV sched yield139machine # [ 0.023233] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]140machine # [ 0.023235] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]141machine # [ 0.023236] [mem 0x40000000-0xafffffff] available for PCI devices142machine # [ 0.023238] Booting paravirtualized kernel on KVM143machine # [ 0.023241] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns144machine # [ 0.027665] setup_percpu: NR_CPUS:384 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1145machine # [ 0.029792] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u524288146machine # [ 0.029835] kvm-guest: PV spinlocks enabled147machine # [ 0.029836] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear)148machine # [ 0.029839] 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/x2xjw51wh4rcckidvj571z1xnxawj42j-nixos-system-machine-test/init regInfo=/nix/store/5f7jck25n4338a7gc7pnn1ic4f808p3h-closure-info/registration console=ttyS0,115200n8 console=tty0149machine # [ 0.029927] Unknown kernel command line parameters "regInfo=/nix/store/5f7jck25n4338a7gc7pnn1ic4f808p3h-closure-info/registration", will be passed to user space.150machine # [ 0.029940] random: crng init done151machine # [ 0.029940] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes152machine # [ 0.030980] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)153machine # [ 0.031505] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)154machine # [ 0.031570] Fallback order for Node 0: 0155machine # [ 0.031573] Built 1 zonelists, mobility grouping on. Total pages: 262006156machine # [ 0.031574] Policy zone: DMA32157machine # [ 0.034085] mem auto-init: stack:all(zero), heap alloc:on, heap free:off158machine # [ 0.036450] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1159machine # [ 0.038632] allocated 2097152 bytes of page_ext160machine # [ 0.047910] ftrace: allocating 48736 entries in 192 pages161machine # [ 0.047912] ftrace: allocated 192 pages with 2 groups162machine # [ 0.048702] Dynamic Preempt: lazy163machine # [ 0.048862] rcu: Preemptible hierarchical RCU implementation.164machine # [ 0.048863] rcu: RCU event tracing is enabled.165machine # [ 0.048863] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=4.166machine # [ 0.048864] Trampoline variant of Tasks RCU enabled.167machine # [ 0.048865] Rude variant of Tasks RCU enabled.168machine # [ 0.048865] Tracing variant of Tasks RCU enabled.169machine # [ 0.048866] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.170machine # [ 0.048867] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4171machine # [ 0.048885] RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.172machine # [ 0.048887] RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.173machine # [ 0.048888] RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.174machine # [ 0.053253] NR_IRQS: 24832, nr_irqs: 456, preallocated irqs: 16175machine # [ 0.053557] rcu: srcu_init: Setting srcu_struct sizes based on contention.176machine # [ 0.053563] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns177machine # [ 0.053671] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)178machine # [ 0.057248] Console: colour VGA+ 80x25179machine # [ 0.057251] printk: legacy console [tty0] enabled180machine # [ 0.087878] printk: legacy console [ttyS0] enabled181machine # [ 0.195321] ACPI: Core revision 20250807182machine # [ 0.196225] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns183machine # [ 0.197822] APIC: Switch to symmetric I/O mode setup184machine # [ 0.198890] x2apic enabled185machine # [ 0.199650] APIC: Switched APIC routing to: physical x2apic186machine # [ 0.200629] kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask()187machine # [ 0.201929] kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself()188machine # [ 0.203455] kvm-guest: setup PV IPIs189machine # [ 0.205062] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1190machine # [ 0.206130] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns191machine # [ 0.207933] Calibrating delay loop (skipped) preset value.. 4800.02 BogoMIPS (lpj=2400012)192machine # [ 0.209016] x86/cpu: User Mode Instruction Prevention (UMIP) activated193machine # [ 0.210054] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127194machine # [ 0.211688] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0195machine # [ 0.212934] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto196machine # [ 0.213931] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl197machine # [ 0.214931] Transient Scheduler Attacks: Vulnerable: No microcode198machine # [ 0.216730] Spectre V2 : Mitigation: Enhanced / Automatic IBRS199machine # [ 0.217693] Speculative Return Stack Overflow: Mitigation: Safe RET200machine # [ 0.218744] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization201machine # [ 0.219938] Spectre V2 : Enabling IBPB for BPF202machine # [ 0.220931] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier203machine # [ 0.221931] active return thunk: srso_alias_return_thunk204machine # [ 0.222952] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'205machine # [ 0.223931] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'206machine # [ 0.224930] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'207machine # [ 0.225929] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'208machine # [ 0.226931] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'209machine # [ 0.227930] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'210machine # [ 0.228930] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'211machine # [ 0.229931] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256212machine # [ 0.231732] x86/fpu: xstate_offset[5]: 832, xstate_sizes[5]: 64213machine # [ 0.232726] x86/fpu: xstate_offset[6]: 896, xstate_sizes[6]: 512214machine # [ 0.233930] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024215machine # [ 0.234929] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]: 8216machine # [ 0.235930] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.217machine # [ 0.265176] Freeing SMP alternatives memory: 44K218machine # [ 0.265933] pid_max: default: 32768 minimum: 301219machine # [ 0.266941] LSM: initializing lsm=capability,landlock,yama,bpf,ima220machine # [ 0.268023] landlock: Up and running.221machine # [ 0.268677] Yama: becoming mindful.222machine # [ 0.269145] LSM support for eBPF active223machine # [ 0.270049] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)224machine # [ 0.270950] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)225machine # [ 0.274357] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)226machine # [ 0.275534] Performance Events: Fam17h+ core perfctr, AMD PMU driver.227machine # [ 0.275940] ... version: 2228machine # [ 0.276727] ... bit width: 48229machine # [ 0.276933] ... generic counters: 6230machine # [ 0.277701] ... generic bitmap: 000000000000003f231machine # [ 0.277933] ... fixed-purpose counters: 0232machine # [ 0.278705] ... fixed-purpose bitmap: 0000000000000000233machine # [ 0.278933] ... value mask: 0000ffffffffffff234machine # [ 0.279867] ... max period: 00007fffffffffff235machine # [ 0.280663] ... global_ctrl mask: 000000000000003f236machine # [ 0.281034] signal: max sigframe size: 3376237machine # [ 0.281853] rcu: Hierarchical SRCU implementation.238machine # [ 0.282597] rcu: Max phase no-delay instances is 400.239machine # [ 0.283146] Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level240machine # [ 0.288429] smp: Bringing up secondary CPUs ...241machine # [ 0.289328] smpboot: x86: Booting SMP configuration:242machine # [ 0.289936] .... node #0, CPUs: #1 #2 #3243machine # [ 0.293064] smp: Brought up 1 node, 4 CPUs244machine # [ 0.294648] smpboot: Total of 4 processors activated (19200.09 BogoMIPS)245machine # [ 0.295279] Memory: 938172K/1048024K available (17231K kernel code, 2726K rwdata, 13600K rodata, 3644K init, 2988K bss, 100804K reserved, 0K cma-reserved)246machine # [ 0.296934] devtmpfs: initialized247machine # [ 0.298053] x86/mm: Memory block size: 128MB248machine # [ 0.300084] posixtimers hash table entries: 2048 (order: 3, 32768 bytes, linear)249machine # [ 0.301019] futex hash table entries: 1024 (65536 bytes on 1 NUMA nodes, total 64 KiB, linear).250machine # [ 0.302025] pinctrl core: initialized pinctrl subsystem251machine # [ 0.303181] PM: RTC time: 20:06:42, date: 2026-09-15252machine # [ 0.306687] NET: Registered PF_NETLINK/PF_ROUTE protocol family253machine # [ 0.307279] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations254machine # [ 0.307950] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations255machine # [ 0.309072] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations256machine # [ 0.309943] audit: initializing netlink subsys (disabled)257machine # [ 0.310992] audit: type=2000 audit(1789502802.960:1): state=initialized audit_enabled=0 res=1258machine # [ 0.311267] thermal_sys: Registered thermal governor 'fair_share'259machine # [ 0.312933] thermal_sys: Registered thermal governor 'bang_bang'260machine # [ 0.313933] thermal_sys: Registered thermal governor 'step_wise'261machine # [ 0.314933] thermal_sys: Registered thermal governor 'user_space'262machine # [ 0.315933] thermal_sys: Registered thermal governor 'power_allocator'263machine # [ 0.316946] cpuidle: using governor menu264machine # [ 0.319130] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5265machine # [ 0.320201] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]266machine # [ 0.320936] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry267machine # [ 0.321946] PCI: Using configuration type 1 for base access268machine # [ 0.323084] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.269machine # [ 0.325361] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages270machine # [ 0.326872] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page271machine # [ 0.327791] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages272machine # [ 0.328843] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page273machine # [ 0.333916] ACPI: Added _OSI(Module Device)274machine # [ 0.335940] ACPI: Added _OSI(Processor Device)275machine # [ 0.337939] ACPI: Added _OSI(Processor Aggregator Device)276machine # [ 0.346551] ACPI: 1 ACPI AML tables successfully acquired and loaded277machine # [ 0.355536] ACPI: Interpreter enabled278machine # [ 0.357991] ACPI: PM: (supports S0 S3 S4 S5)279machine # [ 0.359940] ACPI: Using IOAPIC for interrupt routing280machine # [ 0.362162] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug281machine # [ 0.365939] PCI: Using E820 reservations for host bridge windows282machine # [ 0.368349] ACPI: Enabled 2 GPEs in block 00 to 3F283machine # [ 0.381669] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])284machine # [ 0.382946] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]285machine # [ 0.386092] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]286machine # [ 0.389198] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]287machine # [ 0.391723] PCI host bridge to bus 0000:00288machine # [ 0.393964] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]289machine # [ 0.395938] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]290machine # [ 0.397947] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]291machine # [ 0.399937] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]292machine # [ 0.402937] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]293machine # [ 0.404934] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]294machine # [ 0.405934] pci_bus 0000:00: root bus resource [bus 00-ff]295machine # [ 0.407038] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint296machine # [ 0.409401] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint297machine # [ 0.417028] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]298machine # [ 0.417945] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]299machine # [ 0.418954] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]300machine # [ 0.420107] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]301machine # [ 0.424370] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint302machine # [ 0.434974] pci 0000:00:02.0: BAR 0 [io 0xc100-0xc11f]303machine # [ 0.436955] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]304machine # [ 0.439994] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]305machine # [ 0.442954] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]306machine # [ 0.446318] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint307machine # [ 0.455064] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]308machine # [ 0.457956] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]309machine # [ 0.459993] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]310machine # [ 0.464318] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint311machine # [ 0.473979] pci 0000:00:04.0: BAR 0 [io 0xc000-0xc07f]312machine # [ 0.475949] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]313machine # [ 0.477981] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]314machine # [ 0.482357] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint315machine # [ 0.490121] pci 0000:00:05.0: BAR 0 [io 0xc140-0xc15f]316machine # [ 0.492957] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]317machine # [ 0.494995] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]318machine # [ 0.497955] pci 0000:00:05.0: ROM [mem 0xfeb80000-0xfebbffff pref]319machine # [ 0.503173] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint320machine # [ 0.511008] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]321machine # [ 0.513995] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]322machine # [ 0.518447] pci 0000:00:07.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint323machine # [ 0.524988] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]324machine # [ 0.526994] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]325machine # [ 0.531298] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint326machine # [ 0.538022] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]327machine # [ 0.539980] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]328machine # [ 0.543009] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint329machine # [ 0.547793] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]330machine # [ 0.550000] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]331machine # [ 0.552716] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint332machine # [ 0.556982] pci 0000:00:0a.0: BAR 0 [io 0xc080-0xc0bf]333machine # [ 0.557880] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]334machine # [ 0.559713] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]335machine # [ 0.561362] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint336machine # [ 0.575973] pci 0000:00:0b.0: BAR 0 [io 0xc160-0xc17f]337machine # [ 0.576939] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]338machine # [ 0.577955] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]339machine # [ 0.580523] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint340machine # [ 0.582961] pci 0000:00:1d.0: BAR 4 [io 0xc180-0xc19f]341machine # [ 0.584386] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint342machine # [ 0.586951] pci 0000:00:1d.1: BAR 4 [io 0xc1a0-0xc1bf]343machine # [ 0.588044] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint344machine # [ 0.589798] pci 0000:00:1d.2: BAR 4 [io 0xc1c0-0xc1df]345machine # [ 0.590884] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint346machine # [ 0.593731] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]347machine # [ 0.595232] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint348machine # [ 0.596329] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO349machine # [ 0.598208] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint350machine # [ 0.600961] pci 0000:00:1f.2: BAR 4 [io 0xc1e0-0xc1ff]351machine # [ 0.601939] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]352machine # [ 0.603254] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint353machine # [ 0.605656] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]354machine # [ 0.609979] ACPI: PCI: Interrupt link LNKA configured for IRQ 10355machine # [ 0.611042] ACPI: PCI: Interrupt link LNKB configured for IRQ 10356machine # [ 0.612036] ACPI: PCI: Interrupt link LNKC configured for IRQ 11357machine # [ 0.613035] ACPI: PCI: Interrupt link LNKD configured for IRQ 11358machine # [ 0.614051] ACPI: PCI: Interrupt link LNKE configured for IRQ 10359machine # [ 0.615040] ACPI: PCI: Interrupt link LNKF configured for IRQ 10360machine # [ 0.617032] ACPI: PCI: Interrupt link LNKG configured for IRQ 11361machine # [ 0.618036] ACPI: PCI: Interrupt link LNKH configured for IRQ 11362machine # [ 0.618968] ACPI: PCI: Interrupt link GSIA configured for IRQ 16363machine # [ 0.619946] ACPI: PCI: Interrupt link GSIB configured for IRQ 17364machine # [ 0.620950] ACPI: PCI: Interrupt link GSIC configured for IRQ 18365machine # [ 0.622240] ACPI: PCI: Interrupt link GSID configured for IRQ 19366machine # [ 0.624980] ACPI: PCI: Interrupt link GSIE configured for IRQ 20367machine # [ 0.626972] ACPI: PCI: Interrupt link GSIF configured for IRQ 21368machine # [ 0.629970] ACPI: PCI: Interrupt link GSIG configured for IRQ 22369machine # [ 0.631968] ACPI: PCI: Interrupt link GSIH configured for IRQ 23370machine # [ 0.639138] iommu: Default domain type: Translated371machine # [ 0.640939] iommu: DMA domain TLB invalidation policy: lazy mode372machine # [ 0.645138] ACPI: bus type USB registered373machine # [ 0.647065] usbcore: registered new interface driver usbfs374machine # [ 0.648967] usbcore: registered new interface driver hub375machine # [ 0.650961] usbcore: registered new device driver usb376machine # [ 0.655885] NetLabel: Initializing377machine # [ 0.657938] NetLabel: domain hash size = 128378machine # [ 0.659938] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO379machine # [ 0.662094] NetLabel: unlabeled traffic allowed by default380machine # [ 0.663963] PCI: Using ACPI for IRQ routing381machine # [ 0.724218] pci 0000:00:01.0: vgaarb: setting as boot VGA device382machine # [ 0.724929] pci 0000:00:01.0: vgaarb: bridge control possible383machine # [ 0.724929] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none384machine # [ 0.727940] vgaarb: loaded385machine # [ 0.728653] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0386machine # [ 0.728933] hpet0: 3 comparators, 64-bit 100.000000 MHz counter387machine # [ 0.733021] clocksource: Switched to clocksource kvm-clock388machine # [ 0.737446] VFS: Disk quotas dquot_6.6.0389machine # [ 0.738182] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)390machine # [ 0.739697] pnp: PnP ACPI init391machine # [ 0.740513] ACPI: IRQ 4 override to edge(!), high(!)392machine # [ 0.741505] system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved393machine # [ 0.743128] pnp: PnP ACPI: found 5 devices394machine # [ 0.752646] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns395machine # [ 0.754247] clocksource: Switched to clocksource acpi_pm396machine # [ 0.755275] NET: Registered PF_INET protocol family397machine # [ 0.756400] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)398machine # [ 0.773172] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)399machine # [ 0.774690] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)400machine # [ 0.776066] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)401machine # [ 0.777455] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)402machine # [ 0.778732] TCP: Hash tables configured (established 8192 bind 8192)403machine # [ 0.779908] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)404machine # [ 0.781221] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)405machine # [ 0.782323] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)406machine # [ 0.783569] NET: Registered PF_UNIX/PF_LOCAL protocol family407machine # [ 0.784601] NET: Registered PF_XDP protocol family408machine # [ 0.785483] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]409machine # [ 0.786517] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]410machine # [ 0.787548] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]411machine # [ 0.788673] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]412machine # [ 0.789798] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]413machine # [ 0.790888] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]414machine # [ 0.792698] ACPI: \_SB_.GSIA: Enabled at IRQ 16415machine # [ 0.795154] ACPI: \_SB_.GSIB: Enabled at IRQ 17416machine # [ 0.797187] ACPI: \_SB_.GSIC: Enabled at IRQ 18417machine # [ 0.799191] ACPI: \_SB_.GSID: Enabled at IRQ 19418machine # [ 0.800970] PCI: CLS 0 bytes, default 64419machine # [ 0.801845] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x229842dd0bd, max_idle_ns: 440795319571 ns420machine # [ 0.802169] Trying to unpack rootfs image as initramfs...421machine # [ 0.821138] Initialise system trusted keyrings422machine # [ 0.822400] workingset: timestamp_bits=40 max_order=18 bucket_order=0423machine # [ 0.833707] Key type asymmetric registered424machine # [ 0.834468] Asymmetric key parser 'x509' registered425machine # [ 0.835397] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)426machine # [ 0.837000] io scheduler mq-deadline registered427machine # [ 0.837777] io scheduler kyber registered428machine # [ 0.841080] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled429machine # [ 0.842448] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A430machine # [ 0.844786] Linux agpgart interface v0.103431machine # [ 0.845554] ACPI: bus type drm_connector registered432machine # [ 0.848246] usbcore: registered new interface driver usbserial_generic433machine # [ 0.849347] usbserial: USB Serial support registered for generic434machine # [ 0.850351] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.435machine # [ 0.850351] Please enable it if your BIOS has the CPPC option.436machine # [ 0.852695] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled437machine # [ 0.854048] drop_monitor: Initializing network drop monitor service438machine # [ 0.855254] NET: Registered PF_INET6 protocol family439machine # [ 0.857079] Segment Routing with IPv6440machine # [ 0.857773] In-situ OAM (IOAM) with IPv6441machine # [ 0.859932] IPI shorthand broadcast: enabled442machine # [ 0.864231] sched_clock: Marking stable (717014319, 146366589)->(892267449, -28886541)443machine # [ 0.865968] registered taskstats version 1444machine # [ 0.866959] Loading compiled-in X.509 certificates445machine # [ 0.876082] Demotion targets for Node 0: null446machine # [ 0.877148] Key type .fscrypt registered447machine # [ 0.877842] Key type fscrypt-provisioning registered448machine # [ 0.878778] ima: No TPM chip found, activating TPM-bypass!449machine # [ 0.879678] ima: Allocated hash algorithm: sha1450machine # [ 0.880507] ima: No architecture policies found451machine # [ 0.881602] PM: Magic number: 10:333:144452machine # [ 0.883148] RAS: Correctable Errors collector initialized.453machine # [ 0.887627] clk: Disabling unused clocks454machine # [ 0.888347] PM: genpd: Disabling unused power domains455machine # [ 1.068476] Freeing initrd memory: 29076K456machine # [ 1.072024] Freeing unused decrypted memory: 2028K457machine # [ 1.074758] Freeing unused kernel image (initmem) memory: 3644K458machine # [ 1.075840] Write protecting the kernel read-only data: 32768k459machine # [ 1.077980] Freeing unused kernel image (text/rodata gap) memory: 1200K460machine # [ 1.079700] Freeing unused kernel image (rodata/data gap) memory: 736K461machine # [ 1.146164] x86/mm: Checked W+X mappings: passed, no W+X pages found.462machine # [ 1.147312] Run /init as init process463machine # [ 1.157892] systemd[1]: Inserted module 'autofs4'464machine # [ 1.183491] fuse: init (API version 7.45)465machine # [ 1.192144] ACPI: \_SB_.GSIG: Enabled at IRQ 22466machine # [ 1.194746] ACPI: \_SB_.GSIH: Enabled at IRQ 23467machine # [ 1.197684] ACPI: \_SB_.GSIE: Enabled at IRQ 20468machine # [ 1.199858] ACPI: \_SB_.GSIF: Enabled at IRQ 21469machine # [ 1.204905] virtiofs virtio5: discovered new tag: nix-store470machine # [ 1.206516] virtiofs virtio5: virtio_fs_setup_dax: No cache capability471machine # [ 1.213660] virtiofs virtio6: discovered new tag: shared472machine # [ 1.215279] virtiofs virtio6: virtio_fs_setup_dax: No cache capability473machine # [ 1.218479] virtiofs virtio7: discovered new tag: xchg474machine # [ 1.219915] virtiofs virtio7: virtio_fs_setup_dax: No cache capability475machine # [ 1.245964] systemd[1]: Successfully made /usr/ read-only.476machine # [ 1.581660] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)477machine # [ 1.593560] systemd[1]: Detected virtualization kvm.478machine # [ 1.595726] systemd[1]: Detected architecture x86-64.479machine # [ 1.597888] systemd[1]: Running in initrd.480machine # [ 1.600449] systemd[1]: Initializing machine ID from random generator.481machine # [ 1.603431] systemd[1]: Hostname set to <machine>.482machine # [ 1.725886] systemd[1]: bpf-restrict-fs: LSM BPF program attached483machine # [ 1.759429] systemd[1]: Queued start job for default target Initrd Default Target.484machine # [ 1.767781] systemd[1]: Created slice Slice /system/modprobe.485machine # [ 1.768987] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.486machine # [ 1.770425] systemd[1]: Expecting device /dev/disk/by-label/nixos...487machine # [ 1.783130] systemd[1]: Reached target Path Units.488machine # [ 1.784025] systemd[1]: Reached target Slice Units.489machine # [ 1.784887] systemd[1]: Reached target Swaps.490machine # [ 1.785679] systemd[1]: Reached target Timer Units.491machine # [ 1.786677] systemd[1]: Listening on D-Bus System Message Bus Socket.492machine # [ 1.787891] systemd[1]: Listening on Journal Socket (/dev/log).493machine # [ 1.789045] systemd[1]: Listening on Journal Sockets.494machine # [ 1.790018] systemd[1]: Listening on udev Control Socket.495machine # [ 1.791008] systemd[1]: Listening on udev Kernel Socket.496machine # [ 1.791934] systemd[1]: Reached target Socket Units.497machine # [ 1.793744] systemd[1]: Starting Create List of Static Device Nodes...498machine # [ 1.795786] systemd[1]: Starting Load Kernel Module configfs...499machine # [ 1.798751] systemd[1]: Starting Journal Service...500machine # [ 1.801295] systemd[1]: Starting Load Kernel Modules...501machine # [ 1.802291] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os502machine # [ 1.805463] systemd[1]: Starting Coldplug All udev Devices...503machine # [ 1.808232] systemd[1]: Finished Create List of Static Device Nodes.504machine # [ 1.810673] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...505machine # [ 1.816684] systemd[1]: modprobe@configfs.service: Deactivated successfully.506machine # [ 1.820801] systemd[1]: Finished Load Kernel Module configfs.507machine # [ 1.825299] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.508machine # [ 1.827173] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config509machine # [ 1.829883] systemd[1]: Starting Create Static Device Nodes in /dev...510machine # [ 1.836194] systemd-journald[90]: Collecting audit messages is disabled.511machine # [ 1.836385] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.512machine # [ 1.839532] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev513machine # [ 1.845551] systemd[1]: Finished Create Static Device Nodes in /dev.514machine # [ 1.846814] systemd[1]: Reached target Preparation for Local File Systems.515machine # [ 1.848031] systemd[1]: Reached target Local File Systems.516machine # [ 1.850046] systemd[1]: Starting Rule-based Manager for Device Events and Files...517machine # [ 1.851941] systemd[1]: Finished Load Kernel Modules.518machine # [ 1.853712] systemd[1]: Starting Apply Kernel Variables...519machine # [ 1.867614] systemd[1]: Started Journal Service.520machine # [ 1.722937] systemd-modules-load[91]: Using 4 probe threads521machine # [ 1.724239] systemd-modules-load[91]: Inserted module 'virtio_balloon'522machine # [ 1.725276] systemd-modules-load[91]: Inserted module 'dm_mod'523machine # [ 1.726240] systemd-modules-load[91]: Inserted module 'virtio_gpu'524machine # [ 1.728212] systemd[1]: Starting Create System Files and Directories...525machine # [ 1.732737] systemd[1]: Finished Apply Kernel Variables.526machine # [ 1.741127] systemd[1]: Finished Create System Files and Directories.527machine # [ 1.745341] systemd-udevd[103]: Using default interface naming scheme 'v261'.528machine # [ 1.755405] systemd[1]: Started Rule-based Manager for Device Events and Files.529machine # [ 1.777264] systemd[1]: Finished Coldplug All udev Devices.530machine # [ 1.778098] systemd[1]: Reached target System Initialization.531machine # [ 1.778924] systemd[1]: Reached target Basic System.532machine # [ 1.990006] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12533machine # [ 1.992010] serio: i8042 KBD port at 0x60,0x64 irq 1534machine # [ 1.992736] serio: i8042 AUX port at 0x60,0x64 irq 12535machine # [ 1.999380] virtio_blk virtio2: 4/0/0 default/read/poll queues536machine # [ 2.004700] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)537machine # [ 2.008048] uhci_hcd 0000:00:1d.0: UHCI Host Controller538machine # [ 2.008865] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1539machine # [ 2.009974] uhci_hcd 0000:00:1d.0: detected 2 ports540machine # [ 2.010923] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c180541machine # [ 2.012391] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18542machine # [ 2.013625] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1543machine # [ 2.014711] usb usb1: Product: UHCI Host Controller544machine # [ 2.015471] usb usb1: Manufacturer: Linux 6.18.51 uhci_hcd545machine # [ 2.016251] usb usb1: SerialNumber: 0000:00:1d.0546machine # [ 2.017933] hub 1-0:1.0: USB hub found547machine # [ 2.017983] SCSI subsystem initialized548machine # [ 2.018618] hub 1-0:1.0: 2 ports detected549machine # [ 2.020797] ehci-pci 0000:00:1d.7: EHCI Host Controller550machine # [ 2.022048] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2551machine # [ 2.023442] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000552machine # [ 2.029409] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00553machine # [ 2.030642] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18554machine # [ 2.031799] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1555machine # [ 2.032977] usb usb2: Product: EHCI Host Controller556machine # [ 2.033759] usb usb2: Manufacturer: Linux 6.18.51 ehci_hcd557machine # [ 2.034598] usb usb2: SerialNumber: 0000:00:1d.7558machine # [ 2.035680] hub 2-0:1.0: USB hub found559machine # [ 2.036297] hub 2-0:1.0: 6 ports detected560machine # [ 1.896288] systemd[1]: Starting Virtual Console Setup...561machine # [ 1.907374] systemd[1]: Found device /dev/disk/by-label/nixos.562machine # [ 1.908277] systemd[1]: Reached target Initrd Root Device.563machine # [ 1.909278] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...564machine # [ 2.058491] hub 1-0:1.0: USB hub found565machine # [ 2.059143] hub 1-0:1.0: 2 ports detected566machine # [ 2.060466] uhci_hcd 0000:00:1d.1: UHCI Host Controller567machine # [ 2.061248] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3568machine # [ 2.062381] uhci_hcd 0000:00:1d.1: detected 2 ports569machine # [ 2.063175] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c1a0570machine # [ 1.917538] (udev-worker)[117]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.571machine # [ 1.920040] (udev-worker)[117]: Network interface NamePolicy= disabled on kernel command line.572machine # [ 1.921690] systemd-vconsole-setup[128]: Configuration of first virtual console was skipped, ignoring remaining ones.573machine # [ 2.070929] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0574machine # [ 1.926273] (udev-worker)[120]: Network interface NamePolicy= disabled on kernel command line.575machine # [ 1.927532] systemd[1]: Finished Virtual Console Setup.576machine # [ 2.074571] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18577machine # [ 2.076063] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1578machine # [ 2.077174] usb usb3: Product: UHCI Host Controller579machine # [ 2.077924] usb usb3: Manufacturer: Linux 6.18.51 uhci_hcd580machine # [ 2.078734] usb usb3: SerialNumber: 0000:00:1d.1581machine # [ 2.080143] hub 3-0:1.0: USB hub found582machine # [ 2.081092] hub 3-0:1.0: 2 ports detected583machine # [ 1.935546] systemd-fsck[136]: nixos: clean, 12/65536 files, 13019/262144 blocks584machine # [ 2.084290] uhci_hcd 0000:00:1d.2: UHCI Host Controller585machine # [ 1.939041] systemd[1]: Finis[ 2.085193] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4586machine # hed File System Check on /dev/disk/by-label/nixos.587machine # [ 2.086785] uhci_hcd 0000:00:1d.2: detected 2 ports588machine # [ 2.088269] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c1c0589machine # [ 2.089487] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18590machine # [ 2.090903] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1591machine # [ 2.092027] usb usb4: Product: UHCI Host Controller592machine # [ 2.092804] usb usb4: Manufacturer: Linux 6.18.51 uhci_hcd593machine # [ 2.093739] usb usb4: SerialNumber: 0000:00:1d.2594machine # [ 2.094984] hub 4-0:1.0: USB hub found595machine # [ 2.095758] hub 4-0:1.0: 2 ports detected596machine # [ 2.106330] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode597machine # [ 2.107523] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)598machine # [ 2.108426] ahci 0000:00:1f.2: flags: 64bit ncq only599machine # [ 2.110946] scsi host0: ahci600machine # [ 2.111709] scsi host1: ahci601machine # [ 2.112929] scsi host2: ahci602machine # [ 2.113681] scsi host3: ahci603machine # [ 2.114931] scsi host4: ahci604machine # [ 2.115752] scsi host5: ahci605machine # [ 2.116398] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 50 lpm-pol 1606machine # [ 2.117573] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 50 lpm-pol 1607machine # [ 2.118741] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 50 lpm-pol 1608machine # [ 2.119884] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 50 lpm-pol 1609machine # [ 2.121060] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 50 lpm-pol 1610machine # [ 2.122246] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 50 lpm-pol 1611machine # [ 2.272500] usb 2-1: new high-speed USB device number 2 using ehci-pci612machine # [ 2.401602] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00613machine # [ 2.402787] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10614machine # [ 2.403846] usb 2-1: Product: QEMU USB Tablet615machine # [ 2.404491] usb 2-1: Manufacturer: QEMU616machine # [ 2.405075] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1617machine # [ 2.420129] hid: raw HID events driver (C) Jiri Kosina618machine # [ 2.438546] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)619machine # [ 2.439781] ata1: SATA link down (SStatus 0 SControl 300)620machine # [ 2.442088] ata4: SATA link down (SStatus 0 SControl 300)621machine # [ 2.444525] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100622machine # [ 2.445344] ata3.00: applying bridge limits623machine # [ 2.446135] ata2: SATA link down (SStatus 0 SControl 300)624machine # [ 2.447202] ata6: SATA link down (SStatus 0 SControl 300)625machine # [ 2.449518] ata3.00: configured for UDMA/100626machine # [ 2.450474] ata5: SATA link down (SStatus 0 SControl 300)627machine # [ 2.452870] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5628machine # [ 2.481382] usbcore: registered new interface driver usbhid629machine # [ 2.482193] usbhid: USB HID core driver630machine # [ 2.493738] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:1d.7/usb2/2-1/2-1:1.0/0003:0627:0001.0001/input/input2631machine # [ 2.497987] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0632machine # [ 2.503762] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray633machine # [ 2.539616] cdrom: Uniform CD-ROM driver Revision: 3.20634machine # [ 2.662793] systemd[1]: Mounting /sysroot...635machine # [ 2.952287] EXT4-fs (vda): mounted filesystem 09db12ed-9e17-4fb5-ad83-7a5afdca3273 r/w with ordered data mode. Quota mode: none.636machine # [ 2.809077] systemd[1]: Mounted /sysroot.637machine # [ 2.809790] systemd[1]: Reached target Initrd Root File System.638machine # [ 2.811277] systemd[1]: Mounting /sysroot/nix/.ro-store...639machine # [ 2.812166] systemd[1]: Mounting /sysroot/nix/.rw-store...640machine # [ 2.812959] systemd[1]: Mounting /sysroot/run...641machine # [ 2.815777] systemd[1]: Mounting /sysroot/tmp/shared...642machine # [ 2.816749] systemd[1]: Mounting /sysroot/tmp/xchg...643machine # [ 2.830642] systemd[1]: Starting Mountpoints Configured in the Real Root...644machine # [ 2.833136] systemd[1]: Mounted /sysroot/run.645machine # [ 2.835787] systemd[1]: Mounted /sysroot/nix/.rw-store.646machine # [ 2.836649] systemd[1]: Mounted /sysroot/tmp/shared.647machine # [ 2.838968] systemd-sysroot-fstab-check[177]: /sysroot should be mounted in the initrd, will request daemon-reload.648machine # [ 2.840983] systemd[1]: Mounted /sysroot/tmp/xchg.649machine # [ 2.842219] systemd[1]: Mounted /sysroot/nix/.ro-store.650machine # [ 2.845559] systemd[1]: Starting rw-sysroot-nix-store.service...651machine # [ 2.846609] systemd[1]: Reload requested from client PID 177 ('systemd-sysroot') (unit initrd-parse-etc.service)...652machine # [ 2.848043] systemd[1]: Reloading...653machine # [ 2.900223] systemd[1]: Reloading finished in 51 ms.654machine # [ 2.924020] systemd-sysroot-fstab-check[177]: Requesting initrd-fs.target/start/replace...655machine # [ 2.925221] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.656machine # [ 2.926231] systemd[1]: Finished rw-sysroot-nix-store.service.657machine # [ 2.927056] systemd-sysroot-fstab-check[177]: Requesting swap.target/start/replace...658machine # [ 2.928139] systemd[1]: Starting rw-sysroot-nix-store.service...659machine # [ 2.928971] systemd[1]: initrd-parse-etc.service: Deactivated successfully.660machine # [ 2.929942] systemd[1]: Finished Mountpoints Configured in the Real Root.661machine # [ 2.930870] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.662machine # [ 2.947318] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.663machine # [ 2.948340] systemd[1]: Finished rw-sysroot-nix-store.service.664machine # [ 3.664691] systemd[1]: Mounting /sysroot/nix/store...665machine # [ 3.706298] systemd[1]: Mounted /sysroot/nix/store.666machine # [ 3.708275] systemd[1]: Reached target Initrd File Systems.667machine # [ 3.710368] systemd[1]: Starting Find NixOS closure...668machine # [ 3.712373] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...669machine # [ 3.732919] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.670machine # [ 3.735098] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.671machine # [ 3.742563] systemd[1]: Finished Find NixOS closure.672machine # [ 3.744357] systemd[1]: Reached target Initrd Default Target.673machine # [ 3.746321] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...674machine # [ 3.764091] systemd[1]: Stopped target Initrd Default Target.675machine # [ 3.766197] systemd[1]: Stopped target Basic System.676machine # [ 3.767879] systemd[1]: Stopped target Initrd Root Device.677machine # [ 3.769658] systemd[1]: Stopped target Path Units.678machine # [ 3.771284] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.679machine # [ 3.773702] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.680machine # [ 3.776227] systemd[1]: Stopped target Slice Units.681machine # [ 3.778340] systemd[1]: Stopped target Socket Units.682machine # [ 3.781065] systemd[1]: Stopped target System Initialization.683machine # [ 3.783264] systemd[1]: Stopped target Swaps.684machine # [ 3.785138] systemd[1]: Stopped target Timer Units.685machine # [ 3.786817] systemd[1]: dbus.socket: Deactivated successfully.686machine # [ 3.788753] systemd[1]: Closed D-Bus System Message Bus Socket.687machine # [ 3.790793] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.688machine # [ 3.793226] systemd[1]: Stopped Find NixOS closure.689machine # [ 3.794877] systemd[1]: Starting rw-sysroot-nix-store.service...690machine # [ 3.796685] systemd[1]: systemd-sysctl.service: Deactivated successfully.691machine # [ 3.798680] systemd[1]: Stopped Apply Kernel Variables.692machine # [ 3.800226] systemd[1]: systemd-modules-load.service: Deactivated successfully.693machine # [ 3.802237] systemd[1]: Stopped Load Kernel Modules.694machine # [ 3.803719] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.695machine # [ 3.805834] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.696machine # [ 3.807847] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.697machine # [ 3.810078] systemd[1]: Stopped Create System Files and Directories.698machine # [ 3.811708] systemd[1]: Stopped target Local File Systems.699machine # [ 3.813185] systemd[1]: Stopped target Preparation for Local File Systems.700machine # [ 3.814939] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.701machine # [ 3.816795] systemd[1]: Stopped Coldplug All udev Devices.702machine # [ 3.817781] systemd[1]: Stopping Rule-based Manager for Device Events and Files...703machine # [ 3.819086] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.704machine # [ 3.820332] systemd[1]: Stopped Virtual Console Setup.705machine # [ 3.821483] systemd[1]: initrd-cleanup.service: Deactivated successfully.706machine # [ 3.822629] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.707machine # [ 3.823734] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.708machine # [ 3.824879] systemd[1]: Finished rw-sysroot-nix-store.service.709machine # [ 3.825696] systemd[1]: systemd-udevd.service: Deactivated successfully.710machine # [ 3.826566] systemd[1]: Stopped Rule-based Manager for Device Events and Files.711machine # [ 3.827482] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.712machine # [ 3.828440] systemd[1]: Closed udev Control Socket.713machine # [ 3.829154] systemd[1]: Starting Cleanup udev Database...714machine # [ 3.829914] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.715machine # [ 3.830939] systemd[1]: Stopped Create Static Device Nodes in /dev.716machine # [ 3.831808] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.717machine # [ 3.832858] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.718machine # [ 3.833792] systemd[1]: kmod-static-nodes.service: Deactivated successfully.719machine # [ 3.834737] systemd[1]: Stopped Create List of Static Device Nodes.720machine # [ 3.840022] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.721machine # [ 3.841069] systemd[1]: Finished Cleanup udev Database.722machine # [ 3.841791] systemd[1]: Reached target Switch Root.723machine # [ 3.842474] systemd[1]: Starting NixOS Activation...724machine # [ 3.951965] initrd-nixos-activation-start[222]: booting system configuration /nix/store/x2xjw51wh4rcckidvj571z1xnxawj42j-nixos-system-machine-test725machine # [ 3.987586] initrd-nixos-activation-start[222]: running activation script...726machine # [ 4.229222] initrd-nixos-activation-start[245]: setting up /etc...727machine # [ 4.410431] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.728machine # [ 4.412666] systemd[1]: Finished NixOS Activation.729machine # [ 4.414129] systemd[1]: Starting Switch Root...730machine # [ 4.431808] systemd[1]: Switching root.731machine # [ 4.641828] systemd-journald[90]: Received SIGTERM from PID 1 (systemd).732machine # [ 4.760288] NET: Registered PF_VSOCK protocol family733machine # [ 5.143950] systemd[1]: systemd 261.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)734machine # [ 5.154236] systemd[1]: Detected virtualization kvm.735machine # [ 5.156177] systemd[1]: Detected architecture x86-64.736machine # [ 5.158222] systemd[1]: Detected first boot.737machine # [ 5.162585] systemd[1]: Initializing machine ID from random generator.738machine # [ 5.338216] systemd[1]: bpf-restrict-fs: LSM BPF program attached739machine # [ 5.409229] systemd[1]: Applying preset policy.740machine # [ 5.605480] systemd[1]: Populated /etc with preset unit settings.741machine # [ 5.801748] systemd[1]: initrd-switch-root.service: Deactivated successfully.742machine # [ 5.805158] systemd[1]: Stopped initrd-switch-root.service.743machine # [ 5.809972] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.744machine # [ 5.815184] systemd[1]: Created slice Slice /system/getty.745machine # [ 5.818680] systemd[1]: Created slice User and Session Slice.746machine # [ 5.849998] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.747machine # [ 5.852656] systemd[1]: Started Forward Password Requests to Wall Directory Watch.748machine # [ 5.854894] systemd[1]: Expecting device /dev/hvc0...749machine # [ 5.856473] systemd[1]: Expecting device /dev/ttyS0...750machine # [ 5.858047] systemd[1]: Reached target Local Encrypted Volumes.751machine # [ 5.859839] systemd[1]: Stopped target initrd-fs.target.752machine # [ 5.861433] systemd[1]: Stopped target initrd-root-fs.target.753machine # [ 5.863141] systemd[1]: Stopped target initrd-switch-root.target.754machine # [ 5.864992] systemd[1]: Reached target Virtual Machines and Containers.755machine # [ 5.867020] systemd[1]: Reached target Path Units.756machine # [ 5.868334] systemd[1]: Reached target Remote File Systems.757machine # [ 5.869169] systemd[1]: Reached target Slice Units.758machine # [ 5.869924] systemd[1]: Reached target Swaps.759machine # [ 5.871978] systemd[1]: Listening on Query the User Interactively for a Password.760machine # [ 5.874545] systemd[1]: Listening on Process Core Dump Socket.761machine # [ 5.876326] systemd[1]: Listening on Credential Encryption/Decryption.762machine # [ 5.878275] systemd[1]: Listening on Factory Reset Management.763machine # [ 5.879293] systemd[1]: Listening on Hostname Service Socket.764machine # [ 5.882033] systemd[1]: Starting Journal Log Access Socket...765machine # [ 5.883492] systemd[1]: Listening on Journal Audit Socket.766machine # [ 5.885475] systemd[1]: Listening on Console Output Muting Service Socket.767machine # [ 5.886646] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.768machine # [ 5.887954] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os769machine # [ 5.889417] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki770machine # [ 5.893619] systemd[1]: Listening on Disk Repartitioning Service Socket.771machine # [ 5.894786] systemd[1]: Listening on udev Control Socket.772machine # [ 5.895751] systemd[1]: Listening on udev Varlink Socket.773machine # [ 5.898253] systemd[1]: Mounting Huge Pages File System...774machine # [ 5.900248] systemd[1]: Mounting POSIX Message Queue File System...775machine # [ 5.902445] systemd[1]: Mounting Kernel Debug File System...776machine # [ 5.904689] systemd[1]: Mounting Kernel Trace File System...777machine # [ 5.911698] systemd[1]: Starting Create List of Static Device Nodes...778machine # [ 5.915501] systemd[1]: Starting Load Kernel Module configfs...779machine # [ 5.916513] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm780machine # [ 5.918090] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore781machine # [ 5.919858] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse782machine # [ 5.922551] systemd[1]: Mounting FUSE Control File System...783machine # [ 5.923544] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67784machine # [ 5.931028] systemd[1]: Starting Journal Service...785machine # [ 5.938800] systemd[1]: Starting Load Kernel Modules...786machine # [ 5.941581] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...787machine # [ 5.944004] systemd[1]: Starting Remount Root and Kernel File Systems...788machine # [ 5.945159] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os789machine # [ 5.951857] systemd[1]: Starting Coldplug All udev Devices...790machine # [ 5.955465] systemd[1]: Listening on Journal Log Access Socket.791machine # [ 5.956612] systemd[1]: Mounted Huge Pages File System.792machine # [ 5.957663] systemd[1]: Mounted POSIX Message Queue File System.793machine # [ 5.958770] systemd[1]: Mounted Kernel Debug File System.794machine # [ 5.959777] systemd[1]: Mounted Kernel Trace File System.795machine # [ 5.961081] systemd[1]: Finished Create List of Static Device Nodes.796machine # [ 5.962309] systemd[1]: Mounted FUSE Control File System.797machine # [ 5.965151] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...798machine # [ 5.973014] systemd[1]: modprobe@configfs.service: Deactivated successfully.799machine # [ 5.975885] systemd[1]: Finished Load Kernel Module configfs.800machine # [ 5.982781] systemd[1]: Mounting Kernel Configuration File System...801machine # [ 5.993867] systemd-journald[315]: Collecting audit messages is enabled.802machine # [ 6.000110] loop: module loaded803machine # [ 6.002937] systemd[1]: Finished Load Kernel Modules.804machine # [ 5.857157] systemd[1]: Queued start job for [ 6.003855] systemd[1]: Started Journal Service.805machine # default target Multi-User System.806machine # [ 5.859191] systemd[1]: systemd-journald.service: Deactivated successfully.807machine # [ 6.006600] EXT4-fs (vda): re-mounted 09db12ed-9e17-4fb5-ad83-7a5afdca3273.808machine # [ 5.861419] systemd-modules-load[316]: Using 2 probe threads809machine # [ 5.862712] systemd-modules-load[316]: Inserted module 'loop'810machine # [ 5.863862] systemd-oomd[317]: No swap; memory pressure usage will be degraded811machine # [ 5.866411] systemd[1]: Starting Firewall...812machine # [ 5.867261] systemd[1]: Starting Apply Kernel Variables...813machine # [ 5.868655] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.814machine # [ 5.885474] systemd[1]: Finished Remount Root and Kernel File Systems.815machine # [ 5.886532] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.816machine # [ 5.887545] systemd[1]: Mounted Kernel Configuration File System.817machine # [ 5.888457] systemd[1]: Listening on Disk Image Download Service Socket.818machine # [ 5.889599] systemd[1]: Starting Flush Journal to Persistent Storage...819machine # [ 5.890700] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore820machine # [ 5.892886] systemd[1]: Starting Load/Save OS Random Seed...821machine # [ 5.896372] systemd[1]: Starting Create Static Device Nodes in /dev...822machine # [ 5.897319] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os823machine # [ 6.059764] systemd-journald[315]: Received client request to flush runtime journal.824machine # [ 5.956282] systemd[1]: Finished Load/Save OS Random Seed.825machine # [ 5.957412] systemd[1]: Reached target First Boot Complete.826machine # [ 5.958388] systemd[1]: Finished Apply Kernel Variables.827machine # [ 5.959242] systemd[1]: Finished Flush Journal to Persistent Storage.828machine # [ 5.964051] systemd[1]: Finished Create Static Device Nodes in /dev.829machine # [ 5.965083] systemd[1]: Reached target Preparation for Local File Systems.830machine # [ 5.966134] systemd[1]: Starting Rule-based Manager for Device Events and Files...831machine # [ 5.978736] systemd[1]: Finished Coldplug All udev Devices.832machine # [ 6.004424] systemd-udevd[351]: Using default interface naming scheme 'v261'.833machine # [ 6.031088] systemd[1]: Started Rule-based Manager for Device Events and Files.834machine # [ 6.092583] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse835machine # [ 6.109726] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.836machine # [ 6.117903] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.837machine # [ 6.121385] (udev-worker)[384]: Network interface NamePolicy= disabled on kernel command line.838machine # [ 6.124209] (udev-worker)[386]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.839machine # [ 6.126319] (udev-worker)[386]: Network interface NamePolicy= disabled on kernel command line.840machine # [ 6.143704] systemd[1]: Condition check resulted in Virtio network device being skipped.841machine # [ 6.144908] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore842machine # [ 6.146603] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67843machine # [ 6.148921] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore844machine # [ 6.150521] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os845machine # [ 6.152860] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os846machine # [ 6.320558] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console847machine # [ 6.321001] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3848machine # [ 6.322745] mousedev: PS/2 mouse device common for all mice849machine # [ 6.330376] ACPI: button: Power Button [PWRF]850machine # [ 6.336087] Console: switching to colour dummy device 80x25851machine # [ 6.337993] [drm] Found bochs VGA, ID 0xb0c5.852machine # [ 6.337995] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.853machine # [ 6.339648] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic854machine # [ 6.340422] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0855machine # [ 6.349739] Console: switching to colour frame buffer device 160x50856machine # [ 6.349869] rtc_cmos PNP0B00:00: RTC can wake from S4857machine # [ 6.351795] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device858machine # [ 6.351934] rtc_cmos PNP0B00:00: registered as rtc0859machine # [ 6.353367] rtc_cmos PNP0B00:00: setting system clock to 2026-09-15T20:06:48 UTC (1789502808)860machine # [ 6.358854] rtc_cmos PNP0B00:00: alarms up to one day, y3k, 242 bytes nvram, hpet irqs861machine # [ 6.360665] systemd-journald[315]: Time jumped backwards, rotating.862machine # [ 6.362226] parport_pc 00:02: reported by Plug and Play ACPI863machine # [ 6.365102] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]864machine # [ 6.369658] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:06.0/virtio4/input/input4865machine # [ 6.380209] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized866machine # [ 6.394058] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6867machine # [ 6.395338] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5868machine # [ 6.398032] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt869machine # [ 6.398817] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD870machine # [ 6.293052] systemd[1]: Starting Virtual Console Setup...871machine # [ 6.310514] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.872machine # [ 6.311704] systemd[1]: Stopped Virtual Console Setup.873machine # [ 6.325120] systemd[1]: Starting Virtual Console Setup...874machine # [ 6.484408] ppdev: user-space parallel port driver875machine # [ 6.343332] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.876machine # [ 6.345088] systemd[1]: Stopped Virtual Console Setup.877machine # [ 6.493819] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)878machine # [ 6.495171] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)879machine # [ 6.348947] systemd[1]: Starting Virtual Console Setup...880machine # [ 6.517695] kvm_amd: TSC scaling supported881machine # [ 6.518207] kvm_amd: Nested Virtualization enabled882machine # [ 6.518796] kvm_amd: Nested Paging enabled883machine # [ 6.519298] kvm_amd: LBR virtualization supported884machine # [ 6.519865] kvm_amd: Virtual VMLOAD VMSAVE supported885machine # [ 6.520445] kvm_amd: Virtual GIF supported886machine # [ 6.520936] kvm_amd: Virtual NMI enabled887machine # [ 6.622900] EDAC MC: Ver: 3.0.0888machine # [ 6.518618] systemd-vconsole-setup[438]: Configuration of first virtual console was skipped, ignoring remaining ones.889machine # [ 6.521427] systemd[1]: Finished Virtual Console Setup.890machine # [ 6.523376] systemd[1]: Finished Firewall.891machine # [ 6.659031] systemd[1]: Mounting /run/wrappers...892machine # [ 6.690424] systemd[1]: Mounted /run/wrappers.893machine # [ 6.693201] systemd[1]: Reached target Local File Systems.894machine # [ 6.697103] systemd[1]: Listening on Boot Loader Control Service Socket.895machine # [ 6.701634] systemd[1]: Starting register-nix-paths.service...896machine # [ 6.705822] systemd[1]: Starting Create SUID/SGID Wrappers...897machine # [ 6.707563] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.898machine # [ 6.712705] systemd[1]: Starting Save Transient machine-id to Disk...899machine # [ 6.715501] systemd[1]: Starting Create System Files and Directories...900machine # [ 6.759210] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.901machine # [ 6.761617] systemd[1]: Finished Create System Files and Directories.902machine # [ 6.764432] systemd[1]: Finished Save Transient machine-id to Disk.903machine # [ 6.769848] systemd[1]: Starting Rebuild Journal Catalog...904machine # [ 6.774586] systemd[1]: Starting Record System Boot/Shutdown in UTMP...905machine # [ 6.800291] systemd[1]: Finished Record System Boot/Shutdown in UTMP.906machine # [ 6.810650] systemd[1]: Finished Rebuild Journal Catalog.907machine # [ 6.812880] systemd[1]: Starting Update is Completed...908machine # [ 6.831479] systemd[1]: Finished Update is Completed.909machine # [ 6.950573] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.910machine # [ 6.952295] systemd[1]: Finished Create SUID/SGID Wrappers.911machine # [ 6.978220] systemd[1]: Finished register-nix-paths.service.912machine # [ 6.979864] systemd[1]: Reached target System Initialization.913machine # [ 6.981405] systemd[1]: Started Discard unused filesystem blocks once a week.914machine # [ 6.983364] systemd[1]: Started Daily Cleanup of Temporary Directories.915machine # [ 6.985186] systemd[1]: Reached target Timer Units.916machine # [ 6.986491] systemd[1]: Listening on D-Bus System Message Bus Socket.917machine # [ 6.988233] systemd[1]: Listening on Nix Daemon Socket.918machine # [ 6.989629] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.919machine # [ 6.992039] systemd[1]: Starting systemd-vaultd socket...920machine # [ 6.994947] systemd[1]: Starting D-Bus System Message Bus...921machine # [ 6.996248] systemd[1]: Listening on systemd-vaultd socket.922machine # [ 6.997518] systemd[1]: Reached target Socket Units.923machine # [ 7.028734] dbus-broker-launch[555]: Looking up NSS user entry for 'systemd-timesync'...924machine # [ 7.033336] dbus-broker-launch[555]: NSS returned no entry for 'systemd-timesync'925machine # [ 7.035374] dbus-broker-launch[555]: Invalid user-name in /nix/store/8ijxipkchmphnd5ihjv3zhp09518rk7s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"926machine # [ 7.040794] systemd[1]: Started D-Bus System Message Bus.927machine # [ 7.042855] systemd[1]: Reached target Basic System.928machine # [ 7.044292] systemd[1]: Started backdoor.service.929machine # [ 7.045801] systemd[1]: Starting Import lastlog data into lastlog2 database...930machine # [ 7.048389] systemd[1]: Starting Name Service Cache Daemon (nsncd)...931machine # [ 7.053675] systemd[1]: Starting Post-Boot Actions...932machine # [ 7.063212] dbus-broker-launch[555]: Ready933machine # [ 7.068139] systemd[1]: Started Reset console on configuration changes.934machine # [ 7.072395] systemd[1]: Starting resolvconf update...935machine # [ 7.076472] systemd[1]: Starting service1-envfile.service...936machine # [ 7.087764] systemd[1]: Starting service2.service...937machine # [ 7.091989] nsncd[559]: Sep 15 20:06:49.383 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"938machine # [ 7.096093] systemd[1]: Starting setup-vault-agent-approle.service...939machine # [ 7.098160] systemd[1]: Started Name Service Cache Daemon (nsncd).940machine # [ 7.101840] systemd[1]: Finished Post-Boot Actions.941machine # connecting to host...942machine # [ 7.115721] systemd[1]: Reached target Host and Network Name Lookups.943machine # [ 7.116736] systemd[1]: Reached target User and Group Name Lookups.944machine: Guest shell says: b'Spawning backdoor root shell...\n'945machine # [ 7.119530] systemd[1]: Starting User Login Management...946machine: connected to guest root shell947machine # [ 7.121835] systemd[1]: Started systemd-vaultd daemon.948machine: (connecting took 7.74 seconds)949machine # [ 7.124427] setup-vault-agent-approle-start[569]: + vault status950machine: (finished: waiting for the VM to finish booting, in 7.74 seconds)951machine # [ 7.131736] systemd[1]: Finished Import lastlog data into lastlog2 database.952machine # [ 7.149188] systemd-vaultd[588]: 2026/09/15 20:06:49 Use unix socket received from systemd953machine # [ 7.149794] systemd-vaultd[588]: 2026/09/15 20:06:49 Listening on /run/systemd-vaultd/sock954machine # [ 7.150511] systemd-vaultd[588]: 2026/09/15 20:06:49 Systemd requested secret for service2.service/secret955machine # [ 7.151145] systemd-vaultd[588]: 2026/09/15 20:06:49 Systemd requested environment file for service1.service.EnvironmentFile from service1-envfile.service956machine # [ 7.151797] systemd-vaultd[588]: 2026/09/15 20:06:49 Block start until service2.service.json appears957machine # [ 7.152614] systemd-vaultd[588]: 2026/09/15 20:06:49 Block start until service1.service.EnvironmentFile appears958machine # [ 7.177147] systemd[1]: Stopped target Host and Network Name Lookups.959machine # [ 7.177849] systemd[1]: Stopping Host and Network Name Lookups...960machine # [ 7.178454] systemd[1]: Stopped target User and Group Name Lookups.961machine # [ 7.178962] systemd[1]: Stopping User and Group Name Lookups...962machine # [ 7.181613] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...963machine # [ 7.183814] systemd-logind[587]: New seat seat0.964machine # [ 7.184618] systemd[1]: nscd.service: Deactivated successfully.965machine # [ 7.185451] systemd[1]: Stopped Name Service Cache Daemon (nsncd).966machine # [ 7.186346] systemd-logind[587]: Watching system buttons on /dev/input/event2 (Power Button)967machine # [ 7.187510] systemd-logind[587]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)968machine # [ 7.189136] systemd-logind[587]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)969machine # [ 7.190652] systemd[1]: Started User Login Management.970machine # [ 7.191647] systemd[1]: Starting linger-users.service...971machine # [ 7.193786] systemd[1]: Starting Name Service Cache Daemon (nsncd)...972machine # [ 7.214313] systemd[1]: linger-users.service: Deactivated successfully.973machine # [ 7.215061] systemd[1]: Finished linger-users.service.974machine # [ 7.222619] nsncd[655]: Sep 15 20:06:49.514 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"975machine # [ 7.223297] systemd[1]: Started Name Service Cache Daemon (nsncd).976machine # [ 7.223932] systemd[1]: Reached target Host and Network Name Lookups.977machine # [ 7.224387] systemd[1]: Reached target User and Group Name Lookups.978machine # [ 7.242197] systemd[1]: Finished resolvconf update.979machine # [ 7.242689] systemd[1]: Reached target Preparation for Network.980machine # [ 7.245176] systemd[1]: Starting DHCP Client...981machine # [ 7.246597] systemd[1]: Starting Address configuration of eth1...982machine # [ 7.248232] systemd[1]: Starting Extra networking commands....983machine # [ 7.292275] network-addresses-eth1-start[684]: adding address 192.168.1.1/24... done984machine # [ 7.297833] network-addresses-eth1-start[684]: adding address 2001:db8:1::1/64... done985machine # [ 7.308738] systemd[1]: Finished Address configuration of eth1.986machine # [ 7.330692] dhcpcd[694]: dhcpcd-10.3.2 starting987machine # [ 7.335554] dhcpcd[745]: dev: loaded udev988machine # [ 7.344171] systemd[1]: Finished Extra networking commands..989machine # [ 7.344836] systemd[1]: Reached target Network.990machine # [ 7.346186] systemd[1]: Starting Permit User Sessions...991machine # [ 7.493741] 8021q: 802.1Q VLAN Support v1.8992machine # [ 7.494572] 8021q: adding VLAN 0 to HW filter on device eth1993machine # [ 7.349936] systemd[1]: Started vault-agent-default.service.994machine # [ 7.351664] systemd[1]: Started Vault server daemon.995machine # [ 7.364618] systemd[1]: Finished Permit User Sessions.996machine # [ 7.367179] systemd[1]: Started Getty on tty1.997machine # [ 7.368567] systemd[1]: Reached target Login Prompts.998machine # [ 7.395865] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.999machine # [ 7.596299] cfg80211: Loading compiled-in X.509 certificates for regulatory database1000machine # [ 7.610441] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1001machine # [ 7.611706] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1002machine # [ 7.613562] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21003machine # [ 7.614784] cfg80211: failed to load regulatory.db1004machine # [ 7.681584] 8021q: adding VLAN 0 to HW filter on device eth01005machine # [ 7.537091] dhcpcd[745]: eth0: waiting for carrier1006machine # [ 7.537957] dhcpcd[745]: eth0: carrier acquired1007machine # [ 7.546441] setup-vault-agent-approle-start[590]: Error checking seal status: Get "http://127.0.0.1:8200/v1/sys/seal-status": dial tcp 127.0.0.1:8200: connect: connection refused1008machine # [ 7.549650] dhcpcd[745]: DUID 00:01:00:01:32:3c:61:d9:52:54:00:12:34:561009machine # [ 7.550426] dhcpcd[745]: eth0: IAID 00:12:34:561010machine # [ 7.551128] dhcpcd[745]: eth0: adding address fe80::5054:ff:fe12:34561011machine # [ 7.552127] setup-vault-agent-approle-start[569]: + sleep 11012machine # [ 7.557499] vault[754]: 2026-09-15T20:06:49.850Z [WARN] The HSM distribution of OpenBao is discontinued and will no longer receive updates beyond this minor version. PKCS#11 support has not been removed, but is now available via an external KMS plugin that is drop-in compatible with the previously built-in PKCS#11 seal. To remove this warning, migrate your deployment to the default distribution of OpenBao and use the PKCS#11 KMS plugin to regain PKCS#11 seal functionality. For more information, see https://openbao.org/docs/release-notes/2-6-0/#v2601013machine # [ 7.564269] vault[754]: 2026-09-15T20:06:49.850Z [INFO] proxy environment: http_proxy="" https_proxy="" no_proxy=""1014machine # [ 7.565074] vault[754]: 2026-09-15T20:06:49.850Z [WARN] no `api_addr` value specified in config or in BAO_API_ADDR; falling back to detection if possible, but this value should be manually set1015machine # [ 7.565562] vault[754]: 2026-09-15T20:06:49.857Z [INFO] core: Initializing version history cache for core1016machine # [ 7.566091] vault[754]: ==> OpenBao server configuration:1017machine # [ 7.566557] vault[754]: Api Address: http://127.0.0.1:82001018machine # [ 7.567136] vault[754]: Cgo: enabled1019machine # [ 7.567569] vault[754]: Cluster Address: https://127.0.0.1:82011020machine # [ 7.568104] vault[754]: Environment Variables: HOME, INVOCATION_ID, IO_PRESSURE_WATCH, IO_PRESSURE_WRITE, JOURNAL_STREAM, LANG, LOCALE_ARCHIVE, LOGNAME, MEMORY_PRESSURE_WATCH, MEMORY_PRESSURE_WRITE, PATH, SHELL, STATE_DIRECTORY, SYSTEMD_EXEC_PID, TZDIR, USER1021machine # [ 7.568563] vault[754]: Go Version: go1.26.71022machine # [ 7.569108] vault[754]: Listener 1: tcp (addr: "127.0.0.1:8200", cluster address: "127.0.0.1:8201", max_request_duration: "1m30s", max_request_json_memory: "34078720", max_request_json_strings: "1000", max_request_size: "33554432", tls: "disabled")1023machine # [ 7.569567] vault[754]: Log Level:1024machine # [ 7.570102] vault[754]: Recovery Mode: false1025machine # [ 7.570561] vault[754]: Storage: inmem1026machine # [ 7.570978] vault[754]: Version: OpenBao v2.6.21027machine # [ 7.571560] vault[754]: Version Sha: refs/tags/v2.6.21028machine # [ 7.572379] bao[753]: ==> OpenBao Agent started!1029machine # [ 7.572939] bao[753]: ==> OpenBao Agent configuration:1030machine # [ 7.573553] bao[753]: Api Address 1: http://bufconn1031machine # [ 7.574055] bao[753]: Cgo: enabled1032machine # [ 7.574509] bao[753]: Log Level:1033machine # [ 7.575046] bao[753]: Version: OpenBao v2.6.21034machine # [ 7.575521] bao[753]: Version Sha: refs/tags/v2.6.21035machine # [ 7.576057] vault[754]: 2026-09-15T20:06:49.858Z [INFO] core: security barrier not initialized1036machine # [ 7.576502] vault[754]: 2026-09-15T20:06:49.859Z [INFO] core: security barrier initialized: shares=1 threshold=11037machine # [ 7.577018] vault[754]: 2026-09-15T20:06:49.861Z [INFO] core: post-unseal setup starting1038machine # [ 7.578194] vault[754]: 2026-09-15T20:06:49.871Z [INFO] core: loaded wrapping token key1039machine # [ 7.578624] vault[754]: 2026-09-15T20:06:49.871Z [INFO] core: successfully setup plugin catalog: plugin-directory=""1040machine # [ 7.579799] vault[754]: 2026-09-15T20:06:49.872Z [INFO] core: reading transactional mount table1041machine # [ 7.580435] vault[754]: 2026-09-15T20:06:49.872Z [INFO] core: no mounts in transactional mount table; adding default mount table1042machine # [ 7.581461] vault[754]: 2026-09-15T20:06:49.874Z [INFO] core: successfully mounted: type=cubbyhole version="v2.6.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: "1043machine # [ 7.582606] vault[754]: 2026-09-15T20:06:49.875Z [INFO] core: successfully mounted: type=system version="v2.6.2+builtin.bao" path=sys/ namespace="ID: root. Path: "1044machine # [ 7.583674] vault[754]: 2026-09-15T20:06:49.876Z [INFO] core: successfully mounted: type=identity version="v2.6.2+builtin.bao" path=identity/ namespace="ID: root. Path: "1045machine # [ 7.587850] vault[754]: 2026-09-15T20:06:49.880Z [INFO] core: reading transactional auth mount table1046machine # [ 7.588546] vault[754]: 2026-09-15T20:06:49.880Z [INFO] core: no auth mounts in transactional auth mount table; adding default auth mount table1047machine # [ 7.589211] vault[754]: 2026-09-15T20:06:49.882Z [INFO] core: successfully mounted: type=token version="v2.6.2+builtin.bao" path=token/ namespace="ID: root. Path: "1048machine # [ 7.589777] vault[754]: 2026-09-15T20:06:49.882Z [INFO] rollback: Starting the rollback manager with 256 workers1049machine # [ 7.592456] vault[754]: 2026-09-15T20:06:49.884Z [INFO] core: restoring leases1050machine # [ 7.593197] vault[754]: 2026-09-15T20:06:49.884Z [INFO] rollback: starting rollback manager1051machine # [ 7.594871] vault[754]: 2026-09-15T20:06:49.887Z [INFO] expiration: lease restore complete1052machine # [ 7.595505] vault[754]: 2026-09-15T20:06:49.888Z [INFO] core: entities restored1053machine # [ 7.595966] vault[754]: 2026-09-15T20:06:49.888Z [INFO] core: groups restored1054machine # [ 7.596604] vault[754]: 2026-09-15T20:06:49.888Z [INFO] core: Recorded vault version: vault version=2.6.2 upgrade time="2026-09-15 20:06:49.888815058 +0000 UTC" commit date=""1055machine # [ 7.598474] vault[754]: 2026-09-15T20:06:49.891Z [INFO] core: post-unseal setup complete1056machine # [ 7.599413] vault[754]: 2026-09-15T20:06:49.892Z [INFO] core: root token generated1057machine # [ 7.599885] vault[754]: 2026-09-15T20:06:49.892Z [INFO] core: pre-seal teardown starting1058machine # [ 7.600540] vault[754]: 2026-09-15T20:06:49.892Z [INFO] rollback: stopping rollback manager1059machine # [ 7.601097] vault[754]: 2026-09-15T20:06:49.893Z [INFO] core: pre-seal teardown complete1060machine # [ 7.601540] vault[754]: 2026-09-15T20:06:49.893Z [INFO] core.cluster-listener.tcp: starting listener: listener_address=127.0.0.1:82011061machine # [ 7.602077] vault[754]: 2026-09-15T20:06:49.893Z [INFO] core.cluster-listener: serving cluster requests: cluster_listen_address=127.0.0.1:82011062machine # [ 7.602528] vault[754]: 2026-09-15T20:06:49.894Z [INFO] core: post-unseal setup starting1063machine # [ 7.603079] vault[754]: 2026-09-15T20:06:49.894Z [INFO] core: loaded wrapping token key1064machine # [ 7.603516] vault[754]: 2026-09-15T20:06:49.894Z [INFO] core: successfully setup plugin catalog: plugin-directory=""1065machine # [ 7.604058] vault[754]: 2026-09-15T20:06:49.895Z [INFO] core: reading transactional mount table1066machine # [ 7.604538] vault[754]: 2026-09-15T20:06:49.896Z [INFO] core: successfully mounted: type=system version="v2.6.2+builtin.bao" path=sys/ namespace="ID: root. Path: "1067machine # [ 7.605065] vault[754]: 2026-09-15T20:06:49.897Z [INFO] core: successfully mounted: type=identity version="v2.6.2+builtin.bao" path=identity/ namespace="ID: root. Path: "1068machine # [ 7.605521] vault[754]: 2026-09-15T20:06:49.897Z [INFO] core: successfully mounted: type=cubbyhole version="v2.6.2+builtin.bao" path=cubbyhole/ namespace="ID: root. Path: "1069machine # [ 7.606090] vault[754]: 2026-09-15T20:06:49.898Z [INFO] core: reading transactional auth mount table1070machine # [ 7.606526] vault[754]: 2026-09-15T20:06:49.898Z [INFO] core: successfully mounted: type=token version="v2.6.2+builtin.bao" path=token/ namespace="ID: root. Path: "1071machine # [ 7.607097] vault[754]: 2026-09-15T20:06:49.899Z [INFO] rollback: Starting the rollback manager with 256 workers1072machine # [ 7.607801] vault[754]: 2026-09-15T20:06:49.900Z [INFO] core: restoring leases1073machine # [ 7.609583] vault[754]: 2026-09-15T20:06:49.902Z [INFO] core: entities restored1074machine # [ 7.610056] vault[754]: 2026-09-15T20:06:49.902Z [INFO] rollback: starting rollback manager1075machine # [ 7.610504] vault[754]: 2026-09-15T20:06:49.902Z [INFO] core: groups restored1076machine # [ 7.611494] vault[754]: 2026-09-15T20:06:49.902Z [INFO] expiration: lease restore complete1077machine # [ 7.612052] vault[754]: 2026-09-15T20:06:49.903Z [INFO] core: post-unseal setup complete1078machine # [ 7.612491] vault[754]: 2026-09-15T20:06:49.903Z [INFO] core: vault is unsealed1079machine # [ 7.616710] vault[754]: 2026-09-15T20:06:49.909Z [INFO] expiration: revoked lease: lease_id=auth/token/root/h542bd5e0cebb3632415f5ce81c6fe5d2f4ff9cda6d533b13f95a228a4c2aa9891080machine # [ 7.625230] vault[754]: 2026-09-15T20:06:49.917Z [INFO] core: successful mount: namespace="" path=secret/ type=kv version=""1081machine # [ 7.625950] vault[754]: 2026-09-15T20:06:49.917Z [INFO] beginning post-unseal configuration1082machine # [ 7.626553] vault[754]: 2026-09-15T20:06:49.918Z [INFO] secrets.kv.kv_a5f393fd: collecting keys to upgrade1083machine # [ 7.627086] vault[754]: ==> OpenBao server started!1084machine # [ 7.627560] vault[754]: 2026-09-15T20:06:49.918Z [INFO] secrets.kv.kv_a5f393fd: done collecting keys: num_keys=11085machine # [ 7.628098] vault[754]: 2026-09-15T20:06:49.918Z [INFO] secrets.kv.kv_a5f393fd: upgrading keys finished1086machine # [ 7.646912] bao[753]: 2026-09-15T20:06:49.939Z [INFO] agent.exec.server: starting exec server1087machine # [ 7.647525] bao[753]: 2026-09-15T20:06:49.939Z [INFO] agent.exec.server: no env templates or exec config, exiting1088machine # [ 7.648048] bao[753]: 2026-09-15T20:06:49.939Z [INFO] agent.auth.handler: starting auth handler1089machine # [ 7.648492] bao[753]: 2026-09-15T20:06:49.939Z [INFO] agent.auth.handler: authenticating1090machine # [ 7.649032] bao[753]: 2026-09-15T20:06:49.939Z [ERROR] agent.auth.handler: error getting path or data from method: error="no known role ID" backoff=1s1091machine # [ 7.649483] bao[753]: 2026-09-15T20:06:49.939Z [INFO] agent.sink.server: starting sink server1092machine # [ 7.653878] bao[753]: 2026-09-15T20:06:49.946Z [INFO] agent.template.server: starting template server1093machine # [ 7.655190] bao[753]: 2026-09-15T20:06:49.948Z [INFO] agent: (runner) creating new runner (dry: false, once: false)1094machine # [ 7.657212] bao[753]: 2026-09-15T20:06:49.950Z [INFO] agent: (runner) creating watcher1095machine # [ 7.726578] vault[754]: WARNING! dev mode is enabled! In this mode, OpenBao runs entirely in-memory1096machine # [ 7.728245] vault[754]: and starts unsealed with a single unseal key. The root token is already1097machine # [ 7.729816] vault[754]: authenticated to the CLI, so you can immediately begin using OpenBao.1098machine # [ 7.731422] vault[754]: You may need to set the following environment variables:1099machine # [ 7.732980] vault[754]: $ export BAO_ADDR='http://127.0.0.1:8200'1100machine # [ 7.735094] vault[754]: The unseal key and root token are displayed below in case you want to1101machine # [ 7.736217] vault[754]: seal/unseal the Vault or re-authenticate.1102machine # [ 7.737370] vault[754]: Unseal Key: k5JMQKOPpX2/K0CW3KUedQLde89NzCEkvm5H51wva+4=1103machine # [ 7.738925] vault[754]: Root Token: phony-secret1104machine # [ 7.739726] vault[754]: Development mode should NOT be used in production installations!1105machine: (finished: waiting for unit vault.service, in 8.86 seconds)1106machine # [ 8.244299] dhcpcd[745]: eth0: soliciting a DHCP lease1107machine: waiting for TCP port 8200 on localhost1108machine # [ 8.401156] NET: Registered PF_PACKET protocol family1109machine # [ 8.263592] dhcpcd[745]: eth0: offered 10.0.2.15 from 10.0.2.21110machine # [ 8.269335] dhcpcd[745]: eth0: probing address 10.0.2.15/241111machine # Connection to localhost (127.0.0.1) 8200 port [tcp/trivnet1] succeeded!1112machine: (finished: waiting for TCP port 8200 on localhost, in 0.04 seconds)1113machine: waiting for unit setup-vault-agent-approle.service1114machine # [ 8.566428] setup-vault-agent-approle-start[569]: + vault status1115machine # [ 8.647534] bao[753]: 2026-09-15T20:06:50.940Z [INFO] agent.auth.handler: authenticating1116machine # [ 8.649204] bao[753]: 2026-09-15T20:06:50.940Z [ERROR] agent.auth.handler: error getting path or data from method: error="no known role ID" backoff=1.63s1117machine # [ 8.697675] setup-vault-agent-approle-start[805]: Key Value1118machine # [ 8.699106] setup-vault-agent-approle-start[805]: --- -----1119machine # [ 8.700254] setup-vault-agent-approle-start[805]: Seal Type shamir1120machine # [ 8.701363] setup-vault-agent-approle-start[805]: Initialized true1121machine # [ 8.702865] setup-vault-agent-approle-start[805]: Sealed false1122machine # [ 8.704407] setup-vault-agent-approle-start[805]: Total Shares 11123machine # [ 8.705966] setup-vault-agent-approle-start[805]: Threshold 11124machine # [ 8.707100] setup-vault-agent-approle-start[805]: Version 2.6.21125machine # [ 8.708244] setup-vault-agent-approle-start[805]: Storage Type inmem1126machine # [ 8.709384] setup-vault-agent-approle-start[805]: Cluster Name vault-cluster-e65de1981127machine # [ 8.710935] setup-vault-agent-approle-start[805]: Cluster ID 3d4d0de5-7bed-6778-710a-f2c180b960571128machine # [ 8.712463] setup-vault-agent-approle-start[805]: HA Enabled false1129machine # [ 8.722754] setup-vault-agent-approle-start[569]: + cat1130machine # [ 8.728488] setup-vault-agent-approle-start[569]: + vault policy write demo /tmp/policy-file.hcl1131machine # [ 8.869601] setup-vault-agent-approle-start[814]: Success! Uploaded policy: demo1132machine # [ 8.875155] setup-vault-agent-approle-start[823]: ++ printf '\x00\x01binary\xff'1133machine # [ 8.876989] setup-vault-agent-approle-start[824]: ++ base641134machine # [ 8.879688] setup-vault-agent-approle-start[569]: + vault kv put secret/my-secret foo=bar blob=base64:AAFiaW5hcnn/1135machine # [ 9.007138] setup-vault-agent-approle-start[825]: ==== Secret Path ====1136machine # [ 9.009348] setup-vault-agent-approle-start[825]: secret/data/my-secret1137machine # [ 9.011474] setup-vault-agent-approle-start[825]: ======= Metadata =======1138machine # [ 9.013632] setup-vault-agent-approle-start[825]: Key Value1139machine # [ 9.015816] setup-vault-agent-approle-start[825]: --- -----1140machine # [ 9.018064] setup-vault-agent-approle-start[825]: created_time 2026-09-15T20:06:51.297630424Z1141machine # [ 9.020802] setup-vault-agent-approle-start[825]: custom_metadata <nil>1142machine # [ 9.022988] setup-vault-agent-approle-start[825]: deletion_time n/a1143machine # [ 9.025182] setup-vault-agent-approle-start[825]: destroyed false1144machine # [ 9.027325] setup-vault-agent-approle-start[825]: version 11145machine # [ 9.029442] setup-vault-agent-approle-start[569]: + vault auth enable approle1146machine # [ 9.117659] vault[754]: 2026-09-15T20:06:51.410Z [INFO] core: enabled credential backend: namespace="" path=approle/ type=approle version=""1147machine # [ 9.121699] setup-vault-agent-approle-start[833]: Success! Enabled approle auth method at: approle/1148machine # [ 9.125737] setup-vault-agent-approle-start[569]: + vault write auth/approle/role/role1 bind_secret_id=true token_policies=demo1149machine # [ 9.241787] setup-vault-agent-approle-start[841]: Success! Data written to: auth/approle/role/role11150machine # [ 9.250276] setup-vault-agent-approle-start[850]: ++ jq -r .data.role_id1151machine # [ 9.252894] setup-vault-agent-approle-start[849]: ++ vault read -format json auth/approle/role/role1/role-id1152machine # [ 9.402120] setup-vault-agent-approle-start[569]: + echo -n ec58417f-9972-39ca-ca6a-1457cb27c8651153machine # [ 9.405514] setup-vault-agent-approle-start[863]: ++ vault write -force -format json auth/approle/role/role1/secret-id1154machine # [ 9.406843] setup-vault-agent-approle-start[864]: ++ jq -r .data.secret_id1155machine # [ 9.410801] dhcpcd[745]: eth0: soliciting an IPv6 router1156machine # [ 9.412729] dhcpcd[745]: eth0: Router Advertisement from fe80::21157machine # [ 9.414808] dhcpcd[745]: eth0: adding address fec0::5054:ff:fe12:3456/641158machine # [ 9.417084] dhcpcd[745]: eth0: adding route to fec0::/641159machine # [ 9.418957] dhcpcd[745]: eth0: adding default route via fe80::21160machine # [ 9.525657] setup-vault-agent-approle-start[569]: + echo -n 1ae7ece4-63eb-9154-4435-82956f8d46971161machine # [ 9.530786] systemd[1]: Finished setup-vault-agent-approle.service.1162machine # [ 10.287171] bao[753]: 2026-09-15T20:06:52.579Z [INFO] agent.auth.handler: authenticating1163machine # [ 10.300427] bao[753]: 2026-09-15T20:06:52.593Z [INFO] agent.auth.handler: authentication successful, sending token to sinks1164machine # [ 10.302356] bao[753]: 2026-09-15T20:06:52.593Z [INFO] agent.template.server: template server received new token1165machine # [ 10.303495] bao[753]: 2026-09-15T20:06:52.593Z [INFO] agent: (runner) stopping1166machine # [ 10.304974] bao[753]: 2026-09-15T20:06:52.593Z [INFO] agent: (runner) creating new runner (dry: false, once: false)1167machine # [ 10.306878] bao[753]: 2026-09-15T20:06:52.593Z [INFO] agent: (runner) creating watcher1168machine # [ 10.308455] bao[753]: 2026-09-15T20:06:52.594Z [INFO] agent: (runner) starting1169machine # [ 10.310062] bao[753]: 2026-09-15T20:06:52.596Z [INFO] agent.auth.handler: starting renewal process1170machine # [ 10.311165] bao[753]: 2026-09-15T20:06:52.600Z [INFO] agent.auth.handler: renewed auth token1171machine # [ 10.332770] bao[753]: 2026-09-15T20:06:52.625Z [INFO] agent: (runner) rendered "(dynamic)" => "/run/systemd-vaultd/secrets/service1.service.json"1172machine # [ 10.334842] systemd-vaultd[588]: 2026/09/15 20:06:52 Detected added file: 26706932481173machine # [ 10.336199] systemd-vaultd[588]: 2026/09/15 20:06:52 Detected added file: service1.service.json1174machine # [ 10.337313] systemd-vaultd[588]: 2026/09/15 20:06:52 Ignore unknown file: 26706932481175machine # [ 10.338299] systemd-vaultd[588]: 2026/09/15 20:06:52 Ignore unknown file: service1.service.json1176machine # [ 10.339298] systemd-vaultd[588]: 2026/09/15 20:06:52 Detected added file: 31107559081177machine # [ 10.340291] systemd-vaultd[588]: 2026/09/15 20:06:52 Ignore unknown file: 31107559081178machine # [ 10.341637] systemd-vaultd[588]: 2026/09/15 20:06:52 Detected added file: service1.service.EnvironmentFile1179machine # [ 10.342826] systemd-vaultd[588]: 2026/09/15 20:06:52 Served service1.service.EnvironmentFile to @c6c961e45f2f2fa7/unit/service1-envfile.service/service1.service.EnvironmentFile1180machine # [ 10.344077] bao[753]: 2026-09-15T20:06:52.626Z [INFO] agent: (runner) rendered "(dynamic)" => "/run/systemd-vaultd/secrets/service1.service.EnvironmentFile"1181machine # [ 10.345321] bao[753]: 2026-09-15T20:06:52.626Z [INFO] agent: (runner) executing command "[\"systemctl try-reload-or-restart service1.service\"]" from "(dynamic)" => "/run/systemd-vaultd/secrets/service1.service.json"1182machine # [ 10.346585] bao[753]: 2026-09-15T20:06:52.627Z [INFO] agent: (child) spawning: /bin/sh -c systemctl try-reload-or-restart service1.service1183machine # [ 10.347810] bao[753]: 2026-09-15T20:06:52.628Z [WARN] agent: (view) vault.read(secret/blocking-secret): no secret exists at secret/data/blocking-secret (retry attempt 1 after "250ms")1184machine # [ 10.361061] systemd[1]: Finished service1-envfile.service.1185machine # [ 10.369571] systemd[1]: Starting service1.service...1186machine # [ 10.381515] systemd-vaultd[588]: 2026/09/15 20:06:52 Systemd requested secret for service1.service/blob1187machine # [ 10.382504] systemd-vaultd[588]: 2026/09/15 20:06:52 Systemd requested secret for service1.service/foo1188machine: (finished: waiting for unit setup-vault-agent-approle.service, in 2.10 seconds)1189machine: waiting for unit vault-agent-default.service1190machine # [ 10.394449] systemd[1]: Started service1.service.1191machine # [ 10.406087] systemd[1]: service1.service: Deactivated successfully.1192machine # [ 10.408351] systemd[1]: service1-envfile.service: Deactivated successfully.1193machine # [ 10.408976] systemd[1]: Stopped service1-envfile.service.1194machine: (finished: waiting for unit vault-agent-default.service, in 0.03 seconds)1195machine: waiting for success: grep -q bar /tmp/service11196machine: (finished: waiting for success: grep -q bar /tmp/service1, in 0.02 seconds)1197machine: must succeed: grep -q bar /tmp/service1-env1198machine: (finished: must succeed: grep -q bar /tmp/service1-env, in 0.01 seconds)1199machine: must succeed: printf '\x00\x01binary\xff' | cmp - /tmp/service1-blob1200machine: (finished: must succeed: printf '\x00\x01binary\xff' | cmp - /tmp/service1-blob, in 0.01 seconds)1201machine: must succeed: systemctl status service2 || :1202machine: (finished: must succeed: systemctl status service2 || :, in 0.02 seconds)1203machine: must succeed: vault kv put secret/blocking-secret foo=bar1204machine # [ 10.588700] bao[753]: 2026-09-15T20:06:52.881Z [WARN] agent: (view) vault.read(secret/blocking-secret): no secret exists at secret/data/blocking-secret (retry attempt 2 after "500ms")1205machine: (finished: must succeed: vault kv put secret/blocking-secret foo=bar, in 0.12 seconds)1206machine: waiting for success: grep -q bar /tmp/service2 >&21207machine # grep: /tmp/service2: No such file or directory1208machine # [ 11.093368] systemd-vaultd[588]: 2026/09/15 20:06:53 Detected added file: 3060964451209machine # [ 11.094528] systemd-vaultd[588]: 2026/09/15 20:06:53 Detected added file: service2.service.json1210machine # [ 11.095434] systemd-vaultd[588]: 2026/09/15 20:06:53 Ignore unknown file: 3060964451211machine # [ 11.096268] bao[753]: 2026-09-15T20:06:53.386Z [INFO] agent: (runner) rendered "(dynamic)" => "/run/systemd-vaultd/secrets/service2.service.json"1212machine # [ 11.097117] bao[753]: 2026-09-15T20:06:53.386Z [INFO] agent: (runner) executing command "[\"systemctl try-reload-or-restart service2.service\"]" from "(dynamic)" => "/run/systemd-vaultd/secrets/service2.service.json"1213machine # [ 11.097909] systemd-vaultd[588]: 2026/09/15 20:06:53 Served service2.service.json to @49b36785c8c8afcb/unit/service2.service/secret1214machine # [ 11.102202] bao[753]: 2026-09-15T20:06:53.395Z [INFO] agent: (child) spawning: /bin/sh -c systemctl try-reload-or-restart service2.service1215machine # [ 11.145727] systemd-vaultd[588]: 2026/09/15 20:06:53 Systemd requested secret for service2.service/secret1216machine # [ 11.158833] systemd[1]: Started service2.service.1217machine # [ 11.165084] service2-start[927]: + true1218machine # [ 11.177588] service2-start[927]: + cat /run/service2/secrets/secret1219machine # [ 11.178643] service2-start[929]: bar1220machine # [ 11.179167] service2-start[927]: + cat /run/service2/secrets/secret1221machine # [ 11.179963] service2-start[927]: + sleep 0.11222machine # [ 11.278937] service2-start[927]: + true1223machine # [ 11.279656] service2-start[927]: + cat /run/service2/secrets/secret1224machine # [ 11.284782] service2-start[932]: bar1225machine # [ 11.285382] service2-start[927]: + cat /run/service2/secrets/secret1226machine # [ 11.288622] service2-start[927]: + sleep 0.11227machine # [ 11.394594] service2-start[927]: + true1228machine # [ 11.395282] service2-start[927]: + cat /run/service2/secrets/secret1229machine # [ 11.400230] service2-start[935]: bar1230machine # [ 11.400741] service2-start[927]: + cat /run/service2/secrets/secret1231machine # [ 11.404023] service2-start[927]: + sleep 0.11232machine # [ 11.513076] service2-start[927]: + true1233machine # [ 11.514158] service2-start[927]: + cat /run/service2/secrets/secret1234machine # [ 11.517988] service2-start[938]: bar1235machine # [ 11.518882] service2-start[927]: + cat /run/service2/secrets/secret1236machine # [ 11.521503] service2-start[927]: + sleep 0.11237machine # [ 11.626737] service2-start[927]: + true1238machine # [ 11.627384] service2-start[927]: + cat /run/service2/secrets/secret1239machine # [ 11.630165] service2-start[944]: bar1240machine # [ 11.630705] service2-start[927]: + cat /run/service2/secrets/secret1241machine # [ 11.635651] service2-start[927]: + sleep 0.11242machine: (finished: waiting for success: grep -q bar /tmp/service2 >&2, in 1.05 seconds)1243machine: must succeed: umount /run/credentials/service2.service1244machine: (finished: must succeed: umount /run/credentials/service2.service, in 0.01 seconds)1245machine: must succeed: rm /run/systemd-vaultd/secrets/service2.service.json1246machine: (finished: must succeed: rm /run/systemd-vaultd/secrets/service2.service.json, in 0.02 seconds)1247machine: must succeed: vault kv put secret/blocking-secret foo=reload1248machine # [ 11.741801] service2-start[927]: + true1249machine # [ 11.742824] service2-start[927]: + cat /run/service2/secrets/secret1250machine # [ 11.745348] service2-start[965]: bar1251machine # [ 11.746235] service2-start[927]: + cat /run/service2/secrets/secret1252machine # [ 11.748485] service2-start[927]: + sleep 0.11253machine: (finished: must succeed: vault kv put secret/blocking-secret foo=reload, in 0.15 seconds)1254machine: must succeed: systemctl restart vault-agent-default1255machine # [ 11.847439] bao[753]: ==> OpenBao Agent shutdown triggered1256machine # [ 11.848578] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent: (runner) stopping1257machine # [ 11.850154] systemd[1]: Stopping vault-agent-default.service...1258machine # [ 11.851145] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent.template.server: template server stopped1259machine # [ 11.851986] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent.auth.handler: shutdown triggered, stopping lifetime watcher1260machine # [ 11.852714] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent.auth.handler: auth handler stopped1261machine # [ 11.853437] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent.sink.server: sink server stopped1262machine # [ 11.854138] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent: sinks finished, exiting1263machine # [ 11.854763] bao[753]: 2026-09-15T20:06:54.139Z [INFO] agent.exec.server: exec server stopped1264machine # [ 11.855556] service2-start[927]: + true1265machine # [ 11.856149] service2-start[927]: + cat /run/service2/secrets/secret1266machine # [ 11.857190] service2-start[972]: bar1267machine # [ 11.857840] service2-start[927]: + cat /run/service2/secrets/secret1268machine # [ 11.858767] service2-start[927]: + sleep 0.11269machine # [ 11.861271] systemd[1]: vault-agent-default.service: Deactivated successfully.1270machine # [ 11.862788] systemd[1]: Stopped vault-agent-default.service.1271machine # [ 11.863420] systemd[1]: vault-agent-default.service: Consumed 210ms CPU time over 4.513s wall clock time, 18.4M memory peak, 5.5K incoming IP traffic, 3.8K outgoing IP traffic.1272machine # [ 11.867583] systemd[1]: Started vault-agent-default.service.1273machine: (finished: must succeed: systemctl restart vault-agent-default, in 0.04 seconds)1274machine: waiting for success: cat /run/systemd-vaultd/secrets/service2.service.json >&21275machine # cat: /run/systemd-vaultd/secrets/service2.service.json: No such file or directory1276machine # [ 11.963574] service2-start[927]: + true1277machine # [ 11.964758] service2-start[927]: + cat /run/service2/secrets/secret1278machine # [ 11.971463] service2-start[991]: bar1279machine # [ 11.972751] service2-start[927]: + cat /run/service2/secrets/secret1280machine # [ 11.979144] service2-start[927]: + sleep 0.11281machine # [ 11.992878] bao[976]: ==> OpenBao Agent started!1282machine # [ 11.993576] bao[976]: ==> OpenBao Agent configuration:1283machine # [ 11.995417] bao[976]: Api Address 1: http://bufconn1284machine # [ 11.996085] bao[976]: Cgo: enabled1285machine # [ 11.996808] bao[976]: Log Level:1286machine # [ 11.997761] bao[976]: Version: OpenBao v2.6.21287machine # [ 11.998635] bao[976]: Version Sha: refs/tags/v2.6.21288machine # [ 11.999506] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.exec.server: starting exec server1289machine # [ 12.000408] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.auth.handler: starting auth handler1290machine # [ 12.001045] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.exec.server: no env templates or exec config, exiting1291machine # [ 12.001627] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.auth.handler: authenticating1292machine # [ 12.002514] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.sink.server: starting sink server1293machine # [ 12.003413] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent.template.server: starting template server1294machine # [ 12.004047] bao[976]: 2026-09-15T20:06:54.288Z [INFO] agent: (runner) creating new runner (dry: false, once: false)1295machine # [ 12.007705] bao[976]: 2026-09-15T20:06:54.300Z [INFO] agent.auth.handler: authentication successful, sending token to sinks1296machine # [ 12.008867] bao[976]: 2026-09-15T20:06:54.300Z [INFO] agent.auth.handler: starting renewal process1297machine # [ 12.018447] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent: (runner) creating watcher1298machine # [ 12.019058] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent.template.server: template server received new token1299machine # [ 12.019472] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent: (runner) stopping1300machine # [ 12.019976] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent: (runner) creating new runner (dry: false, once: false)1301machine # [ 12.020586] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent: (runner) creating watcher1302machine # [ 12.021196] bao[976]: 2026-09-15T20:06:54.311Z [INFO] agent: (runner) starting1303machine # [ 12.021651] bao[976]: 2026-09-15T20:06:54.313Z [INFO] agent.auth.handler: renewed auth token1304machine # [ 12.031981] systemd-vaultd[588]: 2026/09/15 20:06:54 Detected added file: 16071328151305machine # [ 12.032540] systemd-vaultd[588]: 2026/09/15 20:06:54 Detected added file: service2.service.json1306machine # [ 12.033165] systemd-vaultd[588]: 2026/09/15 20:06:54 Ignore unknown file: 16071328151307machine # [ 12.033630] systemd-vaultd[588]: 2026/09/15 20:06:54 Ignore unknown file: service2.service.json1308machine # [ 12.034429] bao[976]: 2026-09-15T20:06:54.324Z [INFO] agent: (runner) rendered "(dynamic)" => "/run/systemd-vaultd/secrets/service2.service.json"1309machine # [ 12.034904] bao[976]: 2026-09-15T20:06:54.324Z [INFO] agent: (runner) executing command "[\"systemctl try-reload-or-restart service2.service\"]" from "(dynamic)" => "/run/systemd-vaultd/secrets/service2.service.json"1310machine # [ 12.035641] bao[976]: 2026-09-15T20:06:54.326Z [INFO] agent: (child) spawning: /bin/sh -c systemctl try-reload-or-restart service2.service1311machine # [ 12.043975] systemd[1]: Reloading service2.service...1312machine # [ 12.068359] systemd[1]: Reloaded service2.service.1313machine # [ 12.088290] service2-start[927]: + true1314machine # [ 12.088583] service2-start[927]: + cat /run/service2/secrets/secret1315machine # [ 12.092920] service2-start[1004]: reload1316machine # [ 12.093665] service2-start[927]: + cat /run/service2/secrets/secret1317machine # [ 12.096880] service2-start[927]: + sleep 0.11318machine # [ 12.203054] service2-start[927]: + true1319machine # [ 12.204425] service2-start[927]: + cat /run/service2/secrets/secret1320machine # [ 12.210751] service2-start[1007]: reload1321machine # [ 12.212105] service2-start[927]: + cat /run/service2/secrets/secret1322machine # [ 12.214217] service2-start[927]: + sleep 0.11323machine # [ 12.322275] service2-start[927]: + true1324machine # [ 12.323739] service2-start[927]: + cat /run/service2/secrets/secret1325machine # [ 12.330542] service2-start[1010]: reload1326machine # [ 12.331889] service2-start[927]: + cat /run/service2/secrets/secret1327machine # [ 12.338429] service2-start[927]: + sleep 0.11328machine # [ 12.446091] service2-start[927]: + true1329machine # [ 12.447544] service2-start[927]: + cat /run/service2/secrets/secret1330machine # [ 12.454246] service2-start[1013]: reload1331machine # [ 12.455578] service2-start[927]: + cat /run/service2/secrets/secret1332machine # [ 12.462104] service2-start[927]: + sleep 0.11333machine # [ 12.572362] service2-start[927]: + true1334machine # [ 12.573914] service2-start[927]: + cat /run/service2/secrets/secret1335machine # [ 12.579093] service2-start[1016]: reload1336machine # [ 12.580403] service2-start[927]: + cat /run/service2/secrets/secret1337machine # [ 12.587268] service2-start[927]: + sleep 0.11338machine # [ 12.692818] service2-start[927]: + true1339machine # [ 12.694287] service2-start[927]: + cat /run/service2/secrets/secret1340machine # [ 12.701131] service2-start[1019]: reload1341machine # [ 12.702449] service2-start[927]: + cat /run/service2/secrets/secret1342machine # [ 12.704346] service2-start[927]: + sleep 0.11343machine # [ 12.812919] service2-start[927]: + true1344machine # [ 12.814450] service2-start[927]: + cat /run/service2/secrets/secret1345machine # [ 12.821347] service2-start[1022]: reload1346machine # [ 12.822709] service2-start[927]: + cat /run/service2/secrets/secret1347machine # [ 12.829263] service2-start[927]: + sleep 0.11348machine # 1349machine # {"secret":"reload"}1350machine: (finished: waiting for success: cat /run/systemd-vaultd/secrets/service2.service.json >&2, in 1.05 seconds)1351machine: must succeed: systemctl restart service21352machine # [ 12.940516] service2-start[927]: + true1353machine # [ 12.941525] service2-start[927]: + cat /run/service2/secrets/secret1354machine # [ 12.942760] systemd[1]: Stopping service2.service...1355machine # [ 12.944822] systemd[1]: service2.service: Deactivated successfully.1356machine # [ 12.945917] systemd[1]: Stopped service2.service.1357machine # [ 12.951444] systemd[1]: Starting service2.service...1358machine # [ 12.967886] systemd-vaultd[588]: 2026/09/15 20:06:55 Systemd requested secret for service2.service/secret1359machine # [ 13.004825] systemd-vaultd[588]: 2026/09/15 20:06:55 Systemd requested secret for service2.service/secret1360machine # [ 13.017848] systemd[1]: Started service2.service.1361machine: (finished: must succeed: systemctl restart service2, in 0.10 seconds)1362machine: must succeed: rm /tmp/service21363machine # [ 13.024554] service2-start[1040]: + true1364machine # [ 13.025786] service2-start[1040]: + cat /run/service2/secrets/secret1365machine # [ 13.029711] service2-start[1044]: reload1366machine # [ 13.030909] service2-start[1040]: + cat /run/service2/secrets/secret1367machine # [ 13.034622] service2-start[1040]: + sleep 0.11368machine: (finished: must succeed: rm /tmp/service2, in 0.02 seconds)1369machine: waiting for success: grep -q reload /tmp/service2 >&21370machine # grep: /tmp/service2: No such file or directory1371machine # [ 13.125703] dhcpcd[745]: eth0: leased 10.0.2.15 for 86400 seconds1372machine # [ 13.127192] dhcpcd[745]: eth0: adding route to 10.0.2.0/241373machine # [ 13.128330] dhcpcd[745]: eth0: adding default route via 10.0.2.21374machine # [ 13.144325] service2-start[1040]: + true1375machine # [ 13.145706] service2-start[1040]: + cat /run/service2/secrets/secret1376machine # [ 13.151797] service2-start[1057]: reload1377machine # [ 13.153133] service2-start[1040]: + cat /run/service2/secrets/secret1378machine # [ 13.159164] service2-start[1040]: + sleep 0.11379machine # [ 13.266890] systemd[1]: Started DHCP Client.1380machine # [ 13.268503] systemd[1]: Reached target Multi-User System.1381machine # [ 13.270306] systemd[1]: Startup finished in 1.004s (kernel) + 3.573s (initrd) + 8.690s (userspace) = 13.268s.1382machine # [ 13.272214] service2-start[1040]: + true1383machine # [ 13.273269] service2-start[1040]: + cat /run/service2/secrets/secret1384machine # [ 13.275830] service2-start[1111]: reload1385machine # [ 13.277258] service2-start[1040]: + cat /run/service2/secrets/secret1386machine # [ 13.283837] service2-start[1040]: + sleep 0.11387machine # [ 13.394264] service2-start[1040]: + true1388machine # [ 13.395723] service2-start[1040]: + cat /run/service2/secrets/secret1389machine # [ 13.402617] service2-start[1114]: reload1390machine # [ 13.403906] service2-start[1040]: + cat /run/service2/secrets/secret1391machine # [ 13.410417] service2-start[1040]: + sleep 0.11392machine # [ 13.521063] service2-start[1040]: + true1393machine # [ 13.522474] service2-start[1040]: + cat /run/service2/secrets/secret1394machine # [ 13.529275] service2-start[1117]: reload1395machine # [ 13.530657] service2-start[1040]: + cat /run/service2/secrets/secret1396machine # [ 13.537529] service2-start[1040]: + sleep 0.11397machine # [ 13.647995] service2-start[1040]: + true1398machine # [ 13.649454] service2-start[1040]: + cat /run/service2/secrets/secret1399machine # [ 13.656242] service2-start[1120]: reload1400machine # [ 13.657552] service2-start[1040]: + cat /run/service2/secrets/secret1401machine # [ 13.664407] service2-start[1040]: + sleep 0.11402machine # [ 13.774310] service2-start[1040]: + true1403machine # [ 13.775068] service2-start[1040]: + cat /run/service2/secrets/secret1404machine # [ 13.778433] service2-start[1123]: reload1405machine # [ 13.778685] service2-start[1040]: + cat /run/service2/secrets/secret1406machine # [ 13.785781] service2-start[1040]: + sleep 0.11407machine # [ 13.891050] service2-start[1040]: + true1408machine # [ 13.891946] service2-start[1040]: + cat /run/service2/secrets/secret1409machine # [ 13.894887] service2-start[1127]: reload1410machine # [ 13.895511] service2-start[1040]: + cat /run/service2/secrets/secret1411machine # [ 13.902168] service2-start[1040]: + sleep 0.11412machine # [ 14.007548] service2-start[1040]: + true1413machine # [ 14.008663] service2-start[1040]: + cat /run/service2/secrets/secret1414machine # [ 14.014950] service2-start[1130]: reload1415machine # [ 14.015886] service2-start[1040]: + cat /run/service2/secrets/secret1416machine # [ 14.019090] service2-start[1040]: + sleep 0.11417machine: (finished: waiting for success: grep -q reload /tmp/service2 >&2, in 1.06 seconds)1418machine: must succeed: stat -c %u /run/service2/secrets/secret1419machine: (finished: must succeed: stat -c %u /run/service2/secrets/secret, in 0.02 seconds)1420machine: must succeed: stat -c %g /run/service2/secrets/secret1421machine # [ 14.123471] service2-start[1040]: + true1422machine # [ 14.124521] service2-start[1040]: + cat /run/service2/secrets/secret1423machine # [ 14.127791] service2-start[1142]: reload1424machine # [ 14.128577] service2-start[1040]: + cat /run/service2/secrets/secret1425machine # [ 14.134162] service2-start[1040]: + sleep 0.11426machine: (finished: must succeed: stat -c %g /run/service2/secrets/secret, in 0.02 seconds)1427machine: must succeed: stat -c %a /run/service2/secrets/secret1428machine: (finished: must succeed: stat -c %a /run/service2/secrets/secret, in 0.02 seconds)1429(finished: run the VM test script, in 15.00 seconds)1430test script finished in 15.05s1431cleanup1432kill QemuMachine (pid 46)1433machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/d64q19q1xjdwfhqx6czvrjgrhq0n3lcc-python3-3.14.7/bin/python3.14)1434machine # [2026-09-15T20:06:57Z INFO virtiofsd] Client disconnected, shutting down1435machine # [2026-09-15T20:06:57Z INFO virtiofsd] Client disconnected, shutting down1436machine # [2026-09-15T20:06:57Z INFO virtiofsd] Client disconnected, shutting down1437(finished: cleanup, in 0.20 seconds)1438additionally exposed symbols:1439 machine,1440 vlan1,1441 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_ssh1442● service2.service1443 Loaded: loaded (/etc/systemd/system/service2.service; enabled; preset: ignored)1444 Active: activating (start-pre) since Tue 2026-09-15 20:06:49 UTC; 3s ago1445 Job: 2751446 Invocation: b50908127e6d4fe2b7826b1676c946111447 Cntrl PID: 565 ((service2-pre-))1448 IP: 0B in, 0B out1449 IO: 0B read, 0B written1450 Tasks: 1 (limit: 1110)1451 Memory: 1.1M (peak: 1.5M)1452 CPU: 6ms1453 CGroup: /system.slice/service2.service1454 └─565 "(service2-pre-start)"14551456Sep 15 20:06:49 machine systemd[1]: Starting service2.service...1457