vm-test-run-url-media-archive-keep-failed-temp
checks.x86_64-linux.url-media-archive-keep-failed-temp
· build #22
· raw
1Machine state will be reset. To keep it, pass --keep-machine-state2start all VLans3(finished: start all VLans, in 0.00 seconds)4Test will time out and terminate in 3600.0 seconds5run the VM test script6additionally exposed symbols:7 machine,8 vlan1,9 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_ssh10machine: starting vm11machine: QEMU running (pid 45)12machine # Disk image does not exist, creating the virtualisation disk image...13machine: waiting for unit postgresql.service14machine # Formatting '/build/vm-state-machine/tmp.o2FHyUWKHf', fmt=raw size=107374182415machine: waiting for the VM to finish booting16machine # mke2fs 1.47.4 (6-Mar-2025)17machine # Discarding device blocks: 0/262144 done18machine # Creating filesystem with 262144 4k blocks and 65536 inodes19machine # Filesystem UUID: 22a74be1-ba2a-4819-a445-ae4254dc530f20machine # Superblock backups stored on blocks:21machine # 32768, 98304, 163840, 22937622machine # 23machine # Allocating group tables: 0/8 done24machine # Writing inode tables: 0/8 done25machine # Creating journal (8192 blocks): done26machine # Writing superblocks and filesystem accounting information: 0/8 done27machine # 28machine # Virtualisation disk image created.29machine # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)30machine # 31machine # 32machine # iPXE (http://ipxe.org) 00:02.0 CA00 PCI2.10 PnP PMM+3EFCC730+3EF2C730 CA0033machine # Press Ctrl-B to configure iPXE (PCI 00:02.0)...34machine # 35machine # 36machine # 37machine # 38machine # iPXE (http://ipxe.org) 00:08.0 CB00 PCI2.10 PnP PMM 3EFCC730 3EF2C730 CB0039machine # Press Ctrl-B to configure iPXE (PCI 00:08.0)...40machine # 41machine # 42machine # Booting from ROM...43machine # Probing EDD (edd=off to disable)... ok44machine # [ 0.000000] Linux version 6.18.45 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Wed Aug 19 16:18:21 UTC 202645machine # [ 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/lajw30qh6wi91hnww3wn22y1qjdby1n9-nixos-system-machine-test/init regInfo=/nix/store/hls2a36zp5si3sipnb8nyb3r0dvg4gp0-closure-info/registration console=ttyS0,115200n8 console=tty046machine # [ 0.000000] x86 CPU feature dependency check failure: CPU0 has '18*32+31' enabled but '18*32+26' disabled. Kernel might be fine, but no guarantees.47machine # [ 0.000000] BIOS-provided physical RAM map:48machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable49machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved50machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved51machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffd7fff] usable52machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffd8000-0x000000003fffffff] reserved53machine # [ 0.000000] BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved54machine # [ 0.000000] BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved55machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved56machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved57machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved58machine # [ 0.000000] NX (Execute Disable) protection: active59machine # [ 0.000000] APIC: Static calls initialized60machine # [ 0.000000] SMBIOS 2.8 present.61machine # [ 0.000000] DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/201462machine # [ 0.000000] DMI: Memory slots populated: 1/163machine # [ 0.000000] Hypervisor detected: KVM64machine # [ 0.000000] last_pfn = 0x3ffd8 max_arch_pfn = 0x40000000065machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d0066machine # [ 0.000000] kvm-clock: using sched offset of 442181420 cycles67machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns68machine # [ 0.000005] tsc: Detected 3792.874 MHz processor69machine # [ 0.000753] last_pfn = 0x3ffd8 max_arch_pfn = 0x40000000070machine # [ 0.000778] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs71machine # [ 0.000780] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT72machine # [ 0.002310] found SMP MP-table at [mem 0x000f5450-0x000f545f]73machine # [ 0.002322] Using GB pages for direct mapping74machine # [ 0.002428] RAMDISK: [mem 0x3e34d000-0x3ffcffff]75machine # [ 0.002433] ACPI: Early table checksum verification disabled76machine # [ 0.002437] ACPI: RSDP 0x00000000000F5270 000014 (v00 BOCHS )77machine # [ 0.002441] ACPI: RSDT 0x000000003FFE2422 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)78machine # [ 0.002445] ACPI: FACP 0x000000003FFE221A 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001)79machine # [ 0.002450] ACPI: DSDT 0x000000003FFE0040 0021DA (v01 BOCHS BXPC 00000001 BXPC 00000001)80machine # [ 0.002452] ACPI: FACS 0x000000003FFE0000 00004081machine # [ 0.002453] ACPI: APIC 0x000000003FFE230E 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)82machine # [ 0.002454] ACPI: HPET 0x000000003FFE2386 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)83machine # [ 0.002456] ACPI: MCFG 0x000000003FFE23BE 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)84machine # [ 0.002457] ACPI: WAET 0x000000003FFE23FA 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)85machine # [ 0.002458] ACPI: Reserving FACP table memory at [mem 0x3ffe221a-0x3ffe230d]86machine # [ 0.002459] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe2219]87machine # [ 0.002460] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]88machine # [ 0.002460] ACPI: Reserving APIC table memory at [mem 0x3ffe230e-0x3ffe2385]89machine # [ 0.002461] ACPI: Reserving HPET table memory at [mem 0x3ffe2386-0x3ffe23bd]90machine # [ 0.002461] ACPI: Reserving MCFG table memory at [mem 0x3ffe23be-0x3ffe23f9]91machine # [ 0.002461] ACPI: Reserving WAET table memory at [mem 0x3ffe23fa-0x3ffe2421]92machine # [ 0.002851] No NUMA configuration found93machine # [ 0.002853] Faking a node at [mem 0x0000000000000000-0x000000003ffd7fff]94machine # [ 0.002855] NODE_DATA(0) allocated [mem 0x3ffd2780-0x3ffd7cff]95machine # [ 0.002925] Zone ranges:96machine # [ 0.002926] DMA [mem 0x0000000000001000-0x0000000000ffffff]97machine # [ 0.002927] DMA32 [mem 0x0000000001000000-0x000000003ffd7fff]98machine # [ 0.002928] Normal empty99machine # [ 0.002929] Device empty100machine # [ 0.002929] Movable zone start for each node101machine # [ 0.002930] Early memory node ranges102machine # [ 0.002930] node 0: [mem 0x0000000000001000-0x000000000009efff]103machine # [ 0.002931] node 0: [mem 0x0000000000100000-0x000000003ffd7fff]104machine # [ 0.002932] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffd7fff]105machine # [ 0.002948] On node 0, zone DMA: 1 pages in unavailable ranges106machine # [ 0.003151] On node 0, zone DMA: 97 pages in unavailable ranges107machine # [ 0.016914] On node 0, zone DMA32: 40 pages in unavailable ranges108machine # [ 0.017786] ACPI: PM-Timer IO Port: 0x608109machine # [ 0.017798] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])110machine # [ 0.017819] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23111machine # [ 0.017822] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)112machine # [ 0.017823] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)113machine # [ 0.017824] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)114machine # [ 0.017825] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)115machine # [ 0.017825] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)116machine # [ 0.017827] ACPI: Using ACPI (MADT) for SMP configuration information117machine # [ 0.017828] ACPI: HPET id: 0x8086a201 base: 0xfed00000118machine # [ 0.017832] TSC deadline timer available119machine # [ 0.017836] CPU topo: Max. logical packages: 1120machine # [ 0.017837] CPU topo: Max. logical dies: 1121machine # [ 0.017837] CPU topo: Max. dies per package: 1122machine # [ 0.017840] CPU topo: Max. threads per core: 1123machine # [ 0.017841] CPU topo: Num. cores per package: 1124machine # [ 0.017841] CPU topo: Num. threads per package: 1125machine # [ 0.017841] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs126machine # [ 0.017857] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()127machine # [ 0.017888] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]128machine # [ 0.017890] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]129machine # [ 0.017891] [mem 0x40000000-0xafffffff] available for PCI devices130machine # [ 0.017892] Booting paravirtualized kernel on KVM131machine # [ 0.017895] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns132machine # [ 0.021613] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1133machine # [ 0.023303] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152134machine # [ 0.023336] kvm-guest: PV spinlocks disabled, single CPU135machine # [ 0.023338] 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/lajw30qh6wi91hnww3wn22y1qjdby1n9-nixos-system-machine-test/init regInfo=/nix/store/hls2a36zp5si3sipnb8nyb3r0dvg4gp0-closure-info/registration console=ttyS0,115200n8 console=tty0136machine # [ 0.023417] Unknown kernel command line parameters "regInfo=/nix/store/hls2a36zp5si3sipnb8nyb3r0dvg4gp0-closure-info/registration", will be passed to user space.137machine # [ 0.023435] random: crng init done138machine # [ 0.023435] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes139machine # [ 0.024270] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)140machine # [ 0.024286] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)141machine # [ 0.024311] Fallback order for Node 0: 0142machine # [ 0.024313] Built 1 zonelists, mobility grouping on. Total pages: 262006143machine # [ 0.024314] Policy zone: DMA32144machine # [ 0.026019] mem auto-init: stack:all(zero), heap alloc:on, heap free:off145machine # [ 0.028576] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1146machine # [ 0.030419] allocated 2097152 bytes of page_ext147machine # [ 0.039495] ftrace: allocating 48728 entries in 192 pages148machine # [ 0.039496] ftrace: allocated 192 pages with 2 groups149machine # [ 0.040187] Dynamic Preempt: lazy150machine # [ 0.040318] rcu: Preemptible hierarchical RCU implementation.151machine # [ 0.040319] rcu: RCU event tracing is enabled.152machine # [ 0.040319] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.153machine # [ 0.040320] Trampoline variant of Tasks RCU enabled.154machine # [ 0.040321] Rude variant of Tasks RCU enabled.155machine # [ 0.040321] Tracing variant of Tasks RCU enabled.156machine # [ 0.040321] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.157machine # [ 0.040322] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1158machine # [ 0.040339] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.159machine # [ 0.040340] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.160machine # [ 0.040341] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.161machine # [ 0.044130] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16162machine # [ 0.044382] rcu: srcu_init: Setting srcu_struct sizes based on contention.163machine # [ 0.044388] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns164machine # [ 0.044479] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)165machine # [ 0.050227] Console: colour VGA+ 80x25166machine # [ 0.050230] printk: legacy console [tty0] enabled167machine # [ 0.083470] printk: legacy console [ttyS0] enabled168machine # [ 0.236624] ACPI: Core revision 20250807169machine # [ 0.237791] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns170machine # [ 0.239887] APIC: Switch to symmetric I/O mode setup171machine # [ 0.241188] x2apic enabled172machine # [ 0.242105] APIC: Switched APIC routing to: physical x2apic173machine # [ 0.244167] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1174machine # [ 0.245512] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x6d5818a734c, max_idle_ns: 881590694765 ns175machine # [ 0.247783] Calibrating delay loop (skipped) preset value.. 7585.74 BogoMIPS (lpj=3792874)176machine # [ 0.249853] x86/cpu: User Mode Instruction Prevention (UMIP) activated177machine # [ 0.251901] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127178machine # [ 0.252783] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0179machine # [ 0.253785] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto180machine # [ 0.254782] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl181machine # [ 0.255783] Spectre V2 : Mitigation: Retpolines182machine # [ 0.256782] Speculative Return Stack Overflow: Mitigation: Safe RET183machine # [ 0.257782] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization184machine # [ 0.259782] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT185machine # [ 0.260782] Spectre V2 : Enabling Restricted Speculation for firmware calls186machine # [ 0.261784] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier187machine # [ 0.263783] active return thunk: srso_alias_return_thunk188machine # [ 0.265797] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'189machine # [ 0.266782] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'190machine # [ 0.267782] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'191machine # [ 0.268782] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'192machine # [ 0.269782] x86/fpu: Supporting XSAVE feature 0x800: 'Control-flow User registers'193machine # [ 0.270782] x86/fpu: Supporting XSAVE feature 0x1000: 'Control-flow Kernel registers (KVM only)'194machine # [ 0.272783] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256195machine # [ 0.274782] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8196machine # [ 0.275783] x86/fpu: xstate_offset[11]: 840, xstate_sizes[11]: 16197machine # [ 0.276782] x86/fpu: xstate_offset[12]: 856, xstate_sizes[12]: 24198machine # [ 0.278782] x86/fpu: Enabled xstate features 0x1a07, context size is 880 bytes, using 'compacted' format.199machine # [ 0.307689] Freeing SMP alternatives memory: 44K200machine # [ 0.308601] pid_max: default: 32768 minimum: 301201machine # [ 0.309952] LSM: initializing lsm=capability,landlock,yama,bpf,ima202machine # [ 0.310896] landlock: Up and running.203machine # [ 0.311784] Yama: becoming mindful.204machine # [ 0.313027] LSM support for eBPF active205machine # [ 0.314877] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)206machine # [ 0.315810] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)207machine # [ 0.318462] smpboot: CPU0: AMD Ryzen Threadripper PRO 5965WX 24-Cores (family: 0x19, model: 0x8, stepping: 0x2)208machine # [ 0.319330] Performance Events: Fam17h+ core perfctr, AMD PMU driver.209machine # [ 0.319787] ... version: 0210machine # [ 0.320792] ... bit width: 48211machine # [ 0.321772] ... generic counters: 6212machine # [ 0.322540] ... generic bitmap: 000000000000003f213machine # [ 0.322784] ... fixed-purpose counters: 0214machine # [ 0.323765] ... fixed-purpose bitmap: 0000000000000000215machine # [ 0.324776] ... value mask: 0000ffffffffffff216machine # [ 0.325770] ... max period: 00007fffffffffff217machine # [ 0.326771] ... global_ctrl mask: 000000000000003f218machine # [ 0.327860] signal: max sigframe size: 3376219machine # [ 0.328859] rcu: Hierarchical SRCU implementation.220machine # [ 0.329788] rcu: Max phase no-delay instances is 400.221machine # [ 0.334656] smp: Bringing up secondary CPUs ...222machine # [ 0.335612] smp: Brought up 1 node, 1 CPU223machine # [ 0.336512] smpboot: Total of 1 processors activated (7585.74 BogoMIPS)224machine # [ 0.336926] Memory: 942892K/1048024K available (17215K kernel code, 2726K rwdata, 13580K rodata, 3644K init, 2988K bss, 97700K reserved, 0K cma-reserved)225machine # [ 0.337967] devtmpfs: initialized226machine # [ 0.338926] x86/mm: Memory block size: 128MB227machine # [ 0.340625] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)228machine # [ 0.341810] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).229machine # [ 0.342859] pinctrl core: initialized pinctrl subsystem230machine # [ 0.344074] PM: RTC time: 18:04:46, date: 2026-08-23231machine # [ 0.346973] NET: Registered PF_NETLINK/PF_ROUTE protocol family232machine # [ 0.348102] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations233machine # [ 0.348805] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations234machine # [ 0.349902] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations235machine # [ 0.350793] audit: initializing netlink subsys (disabled)236machine # [ 0.352059] thermal_sys: Registered thermal governor 'fair_share'237machine # [ 0.352060] thermal_sys: Registered thermal governor 'bang_bang'238machine # [ 0.352784] thermal_sys: Registered thermal governor 'step_wise'239machine # [ 0.353787] audit: type=2000 audit(1787508287.222:1): state=initialized audit_enabled=0 res=1240machine # [ 0.355786] thermal_sys: Registered thermal governor 'user_space'241machine # [ 0.355787] thermal_sys: Registered thermal governor 'power_allocator'242machine # [ 0.356800] cpuidle: using governor menu243machine # [ 0.359674] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5244machine # [ 0.361026] PCI: ECAM [mem 0xb0000000-0xbfffffff] (base 0xb0000000) for domain 0000 [bus 00-ff]245machine # [ 0.361787] PCI: ECAM [mem 0xb0000000-0xbfffffff] reserved as E820 entry246machine # [ 0.362795] PCI: Using configuration type 1 for base access247machine # [ 0.363957] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.248machine # [ 0.372949] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages249machine # [ 0.373784] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page250machine # [ 0.378783] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages251machine # [ 0.379784] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page252machine # [ 0.386352] ACPI: Added _OSI(Module Device)253machine # [ 0.386784] ACPI: Added _OSI(Processor Device)254machine # [ 0.387784] ACPI: Added _OSI(Processor Aggregator Device)255machine # [ 0.397215] ACPI: 1 ACPI AML tables successfully acquired and loaded256machine # [ 0.401169] ACPI: Interpreter enabled257machine # [ 0.401799] ACPI: PM: (supports S0 S3 S4 S5)258machine # [ 0.402770] ACPI: Using IOAPIC for interrupt routing259machine # [ 0.405522] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug260machine # [ 0.406784] PCI: Using E820 reservations for host bridge windows261machine # [ 0.407923] ACPI: Enabled 2 GPEs in block 00 to 3F262machine # [ 0.412951] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])263machine # [ 0.413789] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]264machine # [ 0.414857] acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR]265machine # [ 0.415903] acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability]266machine # [ 0.417231] PCI host bridge to bus 0000:00267machine # [ 0.417789] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]268machine # [ 0.418785] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]269machine # [ 0.419785] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]270machine # [ 0.420785] pci_bus 0000:00: root bus resource [mem 0x40000000-0xafffffff window]271machine # [ 0.421785] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]272machine # [ 0.422785] pci_bus 0000:00: root bus resource [mem 0x100000000-0x8ffffffff window]273machine # [ 0.423785] pci_bus 0000:00: root bus resource [bus 00-ff]274machine # [ 0.424877] pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 conventional PCI endpoint275machine # [ 0.426524] pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint276machine # [ 0.429841] pci 0000:00:01.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]277machine # [ 0.430806] pci 0000:00:01.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]278machine # [ 0.431832] pci 0000:00:01.0: ROM [mem 0xfebc0000-0xfebcffff pref]279machine # [ 0.433098] pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]280machine # [ 0.434687] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint281machine # [ 0.436795] pci 0000:00:02.0: BAR 0 [io 0xc140-0xc15f]282machine # [ 0.437796] pci 0000:00:02.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]283machine # [ 0.438826] pci 0000:00:02.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]284machine # [ 0.439796] pci 0000:00:02.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]285machine # [ 0.441911] pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint286machine # [ 0.443795] pci 0000:00:03.0: BAR 0 [io 0xc160-0xc17f]287machine # [ 0.444797] pci 0000:00:03.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]288machine # [ 0.445842] pci 0000:00:03.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]289machine # [ 0.447767] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint290machine # [ 0.449795] pci 0000:00:04.0: BAR 0 [io 0xc080-0xc0bf]291machine # [ 0.450797] pci 0000:00:04.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]292machine # [ 0.451832] pci 0000:00:04.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]293machine # [ 0.453774] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint294machine # [ 0.456808] pci 0000:00:05.0: BAR 0 [io 0xc180-0xc19f]295machine # [ 0.457797] pci 0000:00:05.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]296machine # [ 0.458852] pci 0000:00:05.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]297machine # [ 0.460859] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint298machine # [ 0.462806] pci 0000:00:06.0: BAR 0 [io 0xc1a0-0xc1bf]299machine # [ 0.463799] pci 0000:00:06.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]300machine # [ 0.464834] pci 0000:00:06.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]301machine # [ 0.466806] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint302machine # [ 0.468805] pci 0000:00:07.0: BAR 0 [io 0xc000-0xc07f]303machine # [ 0.469800] pci 0000:00:07.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]304machine # [ 0.470832] pci 0000:00:07.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]305machine # [ 0.472897] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint306machine # [ 0.474795] pci 0000:00:08.0: BAR 0 [io 0xc1c0-0xc1df]307machine # [ 0.475799] pci 0000:00:08.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]308machine # [ 0.476832] pci 0000:00:08.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]309machine # [ 0.477799] pci 0000:00:08.0: ROM [mem 0xfeb80000-0xfebbffff pref]310machine # [ 0.479982] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint311machine # [ 0.481812] pci 0000:00:09.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]312machine # [ 0.482845] pci 0000:00:09.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]313machine # [ 0.485000] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint314machine # [ 0.487449] pci 0000:00:0a.0: BAR 0 [io 0xc0c0-0xc0ff]315machine # [ 0.487804] pci 0000:00:0a.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]316machine # [ 0.488841] pci 0000:00:0a.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]317machine # [ 0.491060] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint318machine # [ 0.492795] pci 0000:00:0b.0: BAR 0 [io 0xc1e0-0xc1ff]319machine # [ 0.493800] pci 0000:00:0b.0: BAR 1 [mem 0xfebda000-0xfebdafff]320machine # [ 0.494831] pci 0000:00:0b.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]321machine # [ 0.496833] pci 0000:00:1d.0: [8086:2934] type 00 class 0x0c0300 conventional PCI endpoint322machine # [ 0.498525] pci 0000:00:1d.0: BAR 4 [io 0xc200-0xc21f]323machine # [ 0.499094] pci 0000:00:1d.1: [8086:2935] type 00 class 0x0c0300 conventional PCI endpoint324machine # [ 0.501550] pci 0000:00:1d.1: BAR 4 [io 0xc220-0xc23f]325machine # [ 0.502119] pci 0000:00:1d.2: [8086:2936] type 00 class 0x0c0300 conventional PCI endpoint326machine # [ 0.503605] pci 0000:00:1d.2: BAR 4 [io 0xc240-0xc25f]327machine # [ 0.505109] pci 0000:00:1d.7: [8086:293a] type 00 class 0x0c0320 conventional PCI endpoint328machine # [ 0.506454] pci 0000:00:1d.7: BAR 0 [mem 0xfebdb000-0xfebdbfff]329machine # [ 0.507149] pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 conventional PCI endpoint330machine # [ 0.508360] pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO331machine # [ 0.509177] pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 conventional PCI endpoint332machine # [ 0.510748] pci 0000:00:1f.2: BAR 4 [io 0xc260-0xc27f]333machine # [ 0.511735] pci 0000:00:1f.2: BAR 5 [mem 0xfebdc000-0xfebdcfff]334machine # [ 0.513327] pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 conventional PCI endpoint335machine # [ 0.514477] pci 0000:00:1f.3: BAR 4 [io 0x0700-0x073f]336machine # [ 0.519802] ACPI: PCI: Interrupt link LNKA configured for IRQ 10337machine # [ 0.520921] ACPI: PCI: Interrupt link LNKB configured for IRQ 10338machine # [ 0.521918] ACPI: PCI: Interrupt link LNKC configured for IRQ 11339machine # [ 0.522913] ACPI: PCI: Interrupt link LNKD configured for IRQ 11340machine # [ 0.523913] ACPI: PCI: Interrupt link LNKE configured for IRQ 10341machine # [ 0.524913] ACPI: PCI: Interrupt link LNKF configured for IRQ 10342machine # [ 0.525938] ACPI: PCI: Interrupt link LNKG configured for IRQ 11343machine # [ 0.526914] ACPI: PCI: Interrupt link LNKH configured for IRQ 11344machine # [ 0.527837] ACPI: PCI: Interrupt link GSIA configured for IRQ 16345machine # [ 0.528803] ACPI: PCI: Interrupt link GSIB configured for IRQ 17346machine # [ 0.529855] ACPI: PCI: Interrupt link GSIC configured for IRQ 18347machine # [ 0.530856] ACPI: PCI: Interrupt link GSID configured for IRQ 19348machine # [ 0.531802] ACPI: PCI: Interrupt link GSIE configured for IRQ 20349machine # [ 0.532809] ACPI: PCI: Interrupt link GSIF configured for IRQ 21350machine # [ 0.533799] ACPI: PCI: Interrupt link GSIG configured for IRQ 22351machine # [ 0.534799] ACPI: PCI: Interrupt link GSIH configured for IRQ 23352machine # [ 0.536907] iommu: Default domain type: Translated353machine # [ 0.537792] iommu: DMA domain TLB invalidation policy: lazy mode354machine # [ 0.539022] ACPI: bus type USB registered355machine # [ 0.539846] usbcore: registered new interface driver usbfs356machine # [ 0.540801] usbcore: registered new interface driver hub357machine # [ 0.541809] usbcore: registered new device driver usb358machine # [ 0.543497] NetLabel: Initializing359machine # [ 0.543789] NetLabel: domain hash size = 128360machine # [ 0.544784] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO361machine # [ 0.545818] NetLabel: unlabeled traffic allowed by default362machine # [ 0.546794] PCI: Using ACPI for IRQ routing363machine # [ 0.635089] pci 0000:00:01.0: vgaarb: setting as boot VGA device364machine # [ 0.635780] pci 0000:00:01.0: vgaarb: bridge control possible365machine # [ 0.635780] pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none366machine # [ 0.635787] vgaarb: loaded367machine # [ 0.636693] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0368machine # [ 0.637668] hpet0: 3 comparators, 64-bit 100.000000 MHz counter369machine # [ 0.641868] clocksource: Switched to clocksource kvm-clock370machine # [ 0.645237] VFS: Disk quotas dquot_6.6.0371machine # [ 0.646205] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)372machine # [ 0.647929] pnp: PnP ACPI init373machine # [ 0.648903] ACPI: IRQ 4 override to edge(!), high(!)374machine # [ 0.650191] system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved375machine # [ 0.652197] pnp: PnP ACPI: found 6 devices376machine # [ 0.659831] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns377machine # [ 0.661754] clocksource: Switched to clocksource acpi_pm378machine # [ 0.663055] NET: Registered PF_INET protocol family379machine # [ 0.664439] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)380machine # [ 0.679139] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)381machine # [ 0.681226] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)382machine # [ 0.683021] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)383machine # [ 0.684771] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)384machine # [ 0.686433] TCP: Hash tables configured (established 8192 bind 8192)385machine # [ 0.687914] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)386machine # [ 0.689598] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)387machine # [ 0.691121] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)388machine # [ 0.692722] NET: Registered PF_UNIX/PF_LOCAL protocol family389machine # [ 0.694050] NET: Registered PF_XDP protocol family390machine # [ 0.695203] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]391machine # [ 0.696697] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]392machine # [ 0.698101] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]393machine # [ 0.699606] pci_bus 0000:00: resource 7 [mem 0x40000000-0xafffffff window]394machine # [ 0.701138] pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window]395machine # [ 0.702644] pci_bus 0000:00: resource 9 [mem 0x100000000-0x8ffffffff window]396machine # [ 0.704863] ACPI: \_SB_.GSIA: Enabled at IRQ 16397machine # [ 0.707107] ACPI: \_SB_.GSIB: Enabled at IRQ 17398machine # [ 0.709341] ACPI: \_SB_.GSIC: Enabled at IRQ 18399machine # [ 0.711639] ACPI: \_SB_.GSID: Enabled at IRQ 19400machine # [ 0.713643] PCI: CLS 0 bytes, default 64401machine # [ 0.714832] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x6d5818a734c, max_idle_ns: 881590694765 ns402machine # [ 0.717095] Trying to unpack rootfs image as initramfs...403machine # [ 0.755878] Initialise system trusted keyrings404machine # [ 0.760471] workingset: timestamp_bits=40 max_order=18 bucket_order=0405machine # [ 0.778696] Key type asymmetric registered406machine # [ 0.779693] Asymmetric key parser 'x509' registered407machine # [ 0.783463] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)408machine # [ 0.787464] io scheduler mq-deadline registered409machine # [ 0.790433] io scheduler kyber registered410machine # [ 0.794573] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled411machine # [ 0.796283] 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A412machine # [ 0.801939] Linux agpgart interface v0.103413machine # [ 0.802975] ACPI: bus type drm_connector registered414machine # [ 0.805871] usbcore: registered new interface driver usbserial_generic415machine # [ 0.807330] usbserial: USB Serial support registered for generic416machine # [ 0.811429] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled417machine # [ 0.813202] drop_monitor: Initializing network drop monitor service418machine # [ 0.817560] NET: Registered PF_INET6 protocol family419machine # [ 0.821724] Segment Routing with IPv6420machine # [ 0.822659] In-situ OAM (IOAM) with IPv6421machine # [ 0.825727] IPI shorthand broadcast: enabled422machine # [ 0.833934] sched_clock: Marking stable (636023803, 197391990)->(956384300, -122968507)423machine # [ 0.839543] registered taskstats version 1424machine # [ 0.840775] Loading compiled-in X.509 certificates425machine # [ 0.858435] Demotion targets for Node 0: null426machine # [ 0.859604] Key type .fscrypt registered427machine # [ 0.862425] Key type fscrypt-provisioning registered428machine # [ 0.863671] ima: No TPM chip found, activating TPM-bypass!429machine # [ 0.868453] ima: Allocated hash algorithm: sha1430machine # [ 0.869565] ima: No architecture policies found431machine # [ 0.872615] PM: Magic number: 6:165:90432machine # [ 0.874331] RAS: Correctable Errors collector initialized.433machine # [ 0.882809] clk: Disabling unused clocks434machine # [ 0.887433] PM: genpd: Disabling unused power domains435machine # [ 1.013869] Freeing initrd memory: 29196K436machine # [ 1.017055] Freeing unused decrypted memory: 2028K437machine # [ 1.019649] Freeing unused kernel image (initmem) memory: 3644K438machine # [ 1.021071] Write protecting the kernel read-only data: 32768k439machine # [ 1.023187] Freeing unused kernel image (text/rodata gap) memory: 1216K440machine # [ 1.025039] Freeing unused kernel image (rodata/data gap) memory: 756K441machine # [ 1.066467] x86/mm: Checked W+X mappings: passed, no W+X pages found.442machine # [ 1.067936] Run /init as init process443machine # [ 1.076723] systemd[1]: Inserted module 'autofs4'444machine # [ 1.091140] fuse: init (API version 7.45)445machine # [ 1.096514] ACPI: \_SB_.GSIG: Enabled at IRQ 22446machine # [ 1.099425] ACPI: \_SB_.GSIH: Enabled at IRQ 23447machine # [ 1.102906] ACPI: \_SB_.GSIE: Enabled at IRQ 20448machine # [ 1.105763] ACPI: \_SB_.GSIF: Enabled at IRQ 21449machine # [ 1.134186] systemd[1]: Successfully made /usr/ read-only.450machine # [ 1.471027] systemd[1]: systemd 261.1 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)451machine # [ 1.480505] systemd[1]: Detected virtualization kvm.452machine # [ 1.482014] systemd[1]: Detected architecture x86-64.453machine # [ 1.483310] systemd[1]: Running in initrd.454machine # [ 1.484683] systemd[1]: Initializing machine ID from random generator.455machine # [ 1.486316] systemd[1]: Hostname set to <machine>.456machine # [ 1.678557] systemd[1]: bpf-restrict-fs: LSM BPF program attached457machine # [ 1.714166] systemd[1]: Queued start job for default target Initrd Default Target.458machine # [ 1.718724] systemd[1]: Created slice Slice /system/modprobe.459machine # [ 1.720282] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.460machine # [ 1.722180] systemd[1]: Expecting device /dev/disk/by-label/nixos...461machine # [ 1.723699] systemd[1]: Reached target Path Units.462machine # [ 1.724918] systemd[1]: Reached target Slice Units.463machine # [ 1.726138] systemd[1]: Reached target Swaps.464machine # [ 1.727292] systemd[1]: Reached target Timer Units.465machine # [ 1.728616] systemd[1]: Listening on D-Bus System Message Bus Socket.466machine # [ 1.730252] systemd[1]: Listening on Journal Socket (/dev/log).467machine # [ 1.731840] systemd[1]: Listening on Journal Sockets.468machine # [ 1.733203] systemd[1]: Listening on udev Control Socket.469machine # [ 1.734606] systemd[1]: Listening on udev Kernel Socket.470machine # [ 1.735922] systemd[1]: Reached target Socket Units.471machine # [ 1.738007] systemd[1]: Starting Create List of Static Device Nodes...472machine # [ 1.742468] systemd[1]: Starting Load Kernel Module 9pnet_virtio...473machine # [ 1.748495] systemd[1]: Starting Load Kernel Module configfs...474machine # [ 1.762568] systemd[1]: Starting Journal Service...475machine # [ 1.773574] systemd[1]: Starting Load Kernel Modules...476machine # [ 1.779493] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os477machine # [ 1.793662] netfs: FS-Cache loaded478machine # [ 1.798532] 9pnet: Installing 9P2000 support479machine # [ 1.810588] systemd[1]: Starting Coldplug All udev Devices...480machine # [ 1.820591] systemd-journald[67]: Collecting audit messages is disabled.481machine # [ 1.826483] systemd[1]: Finished Create List of Static Device Nodes.482machine # [ 1.835024] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.483machine # [ 1.843932] systemd[1]: Finished Load Kernel Module 9pnet_virtio.484machine # [ 1.851845] systemd[1]: modprobe@configfs.service: Deactivated successfully.485machine # [ 1.853491] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.486machine # [ 1.860868] systemd[1]: Finished Load Kernel Module configfs.487machine # [ 1.864419] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev488machine # [ 1.867973] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config489machine # [ 1.882517] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...490machine # [ 1.899527] systemd[1]: Finished Load Kernel Modules.491machine # [ 1.910078] systemd[1]: Starting Apply Kernel Variables...492machine # [ 1.925464] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.493machine # [ 1.936941] systemd[1]: Starting Create Static Device Nodes in /dev...494machine # [ 1.955566] systemd[1]: Finished Apply Kernel Variables.495machine # [ 1.966516] systemd[1]: Finished Create Static Device Nodes in /dev.496machine # [ 1.972654] systemd[1]: Reached target Preparation for Local File Systems.497machine # [ 1.978495] systemd[1]: Reached target Local File Systems.498machine # [ 1.984592] systemd[1]: Starting Rule-based Manager for Device Events and Files...499machine # [ 1.789382] systemd-modules-load[68]: Inserted module 'dm_mod'500machine # [ 1.792507] systemd-modules-load[68]: Inserted module 'virtio_balloon'501machine # [ 1.793959] systemd-modules-load[68]: Inserted module 'virtio_gpu'502machine # [ 1.999607] systemd[1]: Started Journal Service.503machine # [ 1.821975] systemd[1]: Starting Create System Files and Directories...504machine # [ 1.849762] systemd[1]: Finished Create System Files and Directories.505machine # [ 1.851953] systemd-udevd[76]: Using default interface naming scheme 'v261'.506machine # [ 1.880446] systemd[1]: Started Rule-based Manager for Device Events and Files.507machine # [ 1.911090] systemd[1]: Finished Coldplug All udev Devices.508machine # [ 1.912286] systemd[1]: Reached target System Initialization.509machine # [ 1.913526] systemd[1]: Reached target Basic System.510machine # [ 2.341171] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12511machine # [ 2.364283] virtio_blk virtio5: 1/0/0 default/read/poll queues512machine # [ 2.373200] serio: i8042 KBD port at 0x60,0x64 irq 1513machine # [ 2.376330] uhci_hcd 0000:00:1d.0: UHCI Host Controller514machine # [ 2.382629] serio: i8042 AUX port at 0x60,0x64 irq 12515machine # [ 2.385207] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)516machine # [ 2.392411] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 1517machine # [ 2.398544] uhci_hcd 0000:00:1d.0: detected 2 ports518machine # [ 2.400267] uhci_hcd 0000:00:1d.0: irq 16, io port 0x0000c200519machine # [ 2.403637] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18520machine # [ 2.407394] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1521machine # [ 2.408892] usb usb1: Product: UHCI Host Controller522machine # [ 2.410200] SCSI subsystem initialized523machine # [ 2.411517] usb usb1: Manufacturer: Linux 6.18.45 uhci_hcd524machine # [ 2.412950] usb usb1: SerialNumber: 0000:00:1d.0525machine # [ 2.414571] hub 1-0:1.0: USB hub found526machine # [ 2.415826] hub 1-0:1.0: 2 ports detected527machine # [ 2.417578] ehci-pci 0000:00:1d.7: EHCI Host Controller528machine # [ 2.418527] ehci-pci 0000:00:1d.7: new USB bus registered, assigned bus number 2529machine # [ 2.420858] ehci-pci 0000:00:1d.7: irq 19, io mem 0xfebdb000530machine # [ 2.427450] ehci-pci 0000:00:1d.7: USB 2.0 started, EHCI 1.00531machine # [ 2.428815] usb usb2: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 6.18532machine # [ 2.431022] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1533machine # [ 2.432559] usb usb2: Product: EHCI Host Controller534machine # [ 2.433552] usb usb2: Manufacturer: Linux 6.18.45 ehci_hcd535machine # [ 2.434678] usb usb2: SerialNumber: 0000:00:1d.7536machine # [ 2.435941] hub 2-0:1.0: USB hub found537machine # [ 2.437102] hub 2-0:1.0: 6 ports detected538machine # [ 2.459716] hub 1-0:1.0: USB hub found539machine # [ 2.460928] hub 1-0:1.0: 2 ports detected540machine # [ 2.466665] uhci_hcd 0000:00:1d.1: UHCI Host Controller541machine # [ 2.467858] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3542machine # [ 2.484103] uhci_hcd 0000:00:1d.1: detected 2 ports543machine # [ 2.493597] uhci_hcd 0000:00:1d.1: irq 17, io port 0x0000c220544machine # [ 2.507677] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18545machine # [ 2.509706] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1546machine # [ 2.535806] usb usb3: Product: UHCI Host Controller547machine # [ 2.344508] systemd[1]: Starting Virtual Console Setup...548machine # [ 2.551405] usb usb3: Manufacturer: Linux 6.18.45 uhci_hcd549machine # [ 2.357759] (udev-worker)[90]: Network interface NamePolicy= disabled on kernel command line.550machine # [ 2.364423] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.551machine # [ 2.367516] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.552machine # [ 2.568393] usb usb3: SerialNumber: 0000:00:1d.1553machine # [ 2.577172] hub 3-0:1.0: USB hub found554machine # [ 2.588646] hub 3-0:1.0: 2 ports detected555machine # [ 2.399114] systemd-vconsole-setup[100]: Configuration of first virtual console was skipped, ignoring remaining ones.556machine # [ 2.403179] systemd[1]: Finished Virtual Console Setup.557machine # [ 2.603841] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0558machine # [ 2.611434] uhci_hcd 0000:00:1d.2: UHCI Host Controller559machine # [ 2.622982] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4560machine # [ 2.436167] systemd[1]: Found device /dev/disk/by-label/nixos.561machine # [ 2.437512] systemd[1]: Reached target Initrd Root Device.562machine # [ 2.636773] uhci_hcd 0000:00:1d.2: detected 2 ports563machine # [ 2.637932] uhci_hcd 0000:00:1d.2: irq 18, io port 0x0000c240564machine # [ 2.442088] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...565machine # [ 2.646004] ahci 0000:00:1f.2: AHCI vers 0001.0000, 32 command slots, 1.5 Gbps, SATA mode566machine # [ 2.651583] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18567machine # [ 2.655395] ahci 0000:00:1f.2: 6/6 ports implemented (port mask 0x3f)568machine # [ 2.658395] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1569machine # [ 2.659942] ahci 0000:00:1f.2: flags: 64bit ncq only570machine # [ 2.661283] usb usb4: Product: UHCI Host Controller571machine # [ 2.662207] usb usb4: Manufacturer: Linux 6.18.45 uhci_hcd572machine # [ 2.669936] usb usb4: SerialNumber: 0000:00:1d.2573machine # [ 2.671024] scsi host0: ahci574machine # [ 2.475050] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks575machine # [ 2.674650] scsi host1: ahci576machine # [ 2.676405] usb 2-1: new high-speed USB device number 2 using ehci-pci577machine # [ 2.677787] hub 4-0:1.0: USB hub found578machine # [ 2.679535] scsi host2: ahci579machine # [ 2.681406] hub 4-0:1.0: 2 ports detected580machine # [ 2.682869] scsi host3: ahci581machine # [ 2.488568] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.582machine # [ 2.690464] scsi host4: ahci583machine # [ 2.692052] scsi host5: ahci584machine # [ 2.693796] ata1: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc100 irq 44 lpm-pol 1585machine # [ 2.707228] ata2: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc180 irq 44 lpm-pol 1586machine # [ 2.716081] ata3: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc200 irq 44 lpm-pol 1587machine # [ 2.723667] ata4: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc280 irq 44 lpm-pol 1588machine # [ 2.730904] ata5: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc300 irq 44 lpm-pol 1589machine # [ 2.736224] ata6: SATA max UDMA/133 abar m4096@0xfebdc000 port 0xfebdc380 irq 44 lpm-pol 1590machine # [ 2.807522] usb 2-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00591machine # [ 2.809574] usb 2-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10592machine # [ 2.811852] usb 2-1: Product: QEMU USB Tablet593machine # [ 2.813225] usb 2-1: Manufacturer: QEMU594machine # [ 2.814519] usb 2-1: SerialNumber: 28754-0000:00:1d.7-1595machine # [ 2.629395] systemd[1]: Mounting /sysroot...596machine # [ 2.842030] hid: raw HID events driver (C) Jiri Kosina597machine # [ 3.049154] ata1: SATA link down (SStatus 0 SControl 300)598machine # [ 3.050664] ata5: SATA link down (SStatus 0 SControl 300)599machine # [ 3.052440] ata2: SATA link down (SStatus 0 SControl 300)600machine # [ 3.053930] ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300)601machine # [ 3.055649] ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100602machine # [ 3.057442] ata3.00: applying bridge limits603machine # [ 3.058818] ata6: SATA link down (SStatus 0 SControl 300)604machine # [ 3.060400] ata4: SATA link down (SStatus 0 SControl 300)605machine # [ 3.061877] ata3.00: configured for UDMA/100606machine # [ 3.064340] scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5607machine # [ 3.121586] usbcore: registered new interface driver usbhid608machine # [ 3.126380] usbhid: USB HID core driver609machine # [ 3.142860] 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/input2610machine # [ 3.146701] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:1d.7-1/input0611machine # [ 3.154065] sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray612machine # [ 3.162067] EXT4-fs (vda): mounted filesystem 22a74be1-ba2a-4819-a445-ae4254dc530f r/w with ordered data mode. Quota mode: none.613machine # [ 2.971858] systemd[1]: Mounted /sysroot.614machine # [ 2.973763] systemd[1]: Reached target Initrd Root File System.615machine # [ 3.172265] cdrom: Uniform CD-ROM driver Revision: 3.20616machine # [ 2.979083] systemd[1]: Starting Mountpoints Configured in the Real Root...617machine # [ 2.996179] systemd-sysroot-fstab-check[138]: /sysroot should be mounted in the initrd, will request daemon-reload.618machine # [ 3.000076] systemd[1]: Reload requested from client PID 138 ('systemd-sysroot') (unit initrd-parse-etc.service)...619machine # [ 3.002107] systemd[1]: Reloading...620machine # [ 3.092061] systemd[1]: Reloading finished in 92 ms.621machine # [ 3.101435] systemd-sysroot-fstab-check[138]: Requesting initrd-fs.target/start/replace...622machine # [ 3.107390] systemd-sysroot-fstab-check[138]: Requesting swap.target/start/replace...623machine # [ 3.113516] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio624machine # [ 3.116463] systemd[1]: initrd-parse-etc.service: Deactivated successfully.625machine # [ 3.118528] systemd[1]: Finished Mountpoints Configured in the Real Root.626machine # [ 3.120185] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.627machine # [ 3.629162] systemd[1]: Mounting /sysroot/nix/.ro-store...628machine # [ 3.633933] systemd[1]: Mounting /sysroot/nix/.rw-store...629machine # [ 3.638949] systemd[1]: Mounting /sysroot/run...630machine # [ 3.642871] systemd[1]: Mounting /sysroot/tmp/shared...631machine # [ 3.647703] systemd[1]: Mounting /sysroot/tmp/xchg...632machine # [ 3.868235] 9p: Installing v9fs 9p2000 file system support633machine # [ 3.673646] systemd[1]: Mounted /sysroot/nix/.rw-store.634machine # [ 3.675926] systemd[1]: Mounted /sysroot/run.635machine # [ 3.682328] systemd[1]: Mounted /sysroot/nix/.ro-store.636machine # [ 3.685163] systemd[1]: Mounted /sysroot/tmp/shared.637machine # [ 3.686225] systemd[1]: Mounted /sysroot/tmp/xchg.638machine # [ 3.690251] systemd[1]: Starting rw-sysroot-nix-store.service...639machine # [ 3.702787] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.640machine # [ 3.705592] systemd[1]: Finished rw-sysroot-nix-store.service.641machine # [ 4.628806] systemd[1]: Mounting /sysroot/nix/store...642machine # [ 4.651093] systemd[1]: Mounted /sysroot/nix/store.643machine # [ 4.653332] systemd[1]: Reached target Initrd File Systems.644machine # [ 4.656135] systemd[1]: Starting Find NixOS closure...645machine # [ 4.660427] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...646machine # [ 4.680818] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.647machine # [ 4.685756] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.648machine # [ 4.691581] systemd[1]: Finished Find NixOS closure.649machine # [ 4.693963] systemd[1]: Reached target Initrd Default Target.650machine # [ 4.695545] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...651machine # [ 4.708741] systemd[1]: Stopped target Initrd Default Target.652machine # [ 4.711073] systemd[1]: Stopped target Basic System.653machine # [ 4.712254] systemd[1]: Stopped target Initrd Root Device.654machine # [ 4.713615] systemd[1]: Stopped target Path Units.655machine # [ 4.714740] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.656machine # [ 4.716520] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.657machine # [ 4.718623] systemd[1]: Stopped target Slice Units.658machine # [ 4.720302] systemd[1]: Stopped target Socket Units.659machine # [ 4.721612] systemd[1]: Stopped target System Initialization.660machine # [ 4.723268] systemd[1]: Stopped target Swaps.661machine # [ 4.724450] systemd[1]: Stopped target Timer Units.662machine # [ 4.726227] systemd[1]: dbus.socket: Deactivated successfully.663machine # [ 4.727499] systemd[1]: Closed D-Bus System Message Bus Socket.664machine # [ 4.728839] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.665machine # [ 4.730677] systemd[1]: Stopped Find NixOS closure.666machine # [ 4.732175] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio667machine # [ 4.734479] systemd[1]: Starting rw-sysroot-nix-store.service...668machine # [ 4.737178] systemd[1]: systemd-sysctl.service: Deactivated successfully.669machine # [ 4.738922] systemd[1]: Stopped Apply Kernel Variables.670machine # [ 4.740329] systemd[1]: systemd-modules-load.service: Deactivated successfully.671machine # [ 4.743182] systemd[1]: Stopped Load Kernel Modules.672machine # [ 4.744522] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.673machine # [ 4.746491] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.674machine # [ 4.748559] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.675machine # [ 4.751256] systemd[1]: Stopped Create System Files and Directories.676machine # [ 4.753428] systemd[1]: Stopped target Local File Systems.677machine # [ 4.755738] systemd[1]: Stopped target Preparation for Local File Systems.678machine # [ 4.757589] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.679machine # [ 4.758953] systemd[1]: Stopped Coldplug All udev Devices.680machine # [ 4.764986] systemd[1]: Stopping Rule-based Manager for Device Events and Files...681machine # [ 4.766974] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.682machine # [ 4.768810] systemd[1]: Stopped Virtual Console Setup.683machine # [ 4.777527] systemd[1]: initrd-cleanup.service: Deactivated successfully.684machine # [ 4.780344] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.685machine # [ 4.782861] systemd[1]: systemd-udevd.service: Deactivated successfully.686machine # [ 4.784336] systemd[1]: Stopped Rule-based Manager for Device Events and Files.687machine # [ 4.786843] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.688machine # [ 4.788338] systemd[1]: Finished rw-sysroot-nix-store.service.689machine # [ 4.792552] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.690machine # [ 4.794264] systemd[1]: Closed udev Control Socket.691machine # [ 4.796355] systemd[1]: Starting Cleanup udev Database...692machine # [ 4.797524] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.693machine # [ 4.800166] systemd[1]: Stopped Create Static Device Nodes in /dev.694machine # [ 4.802081] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.695machine # [ 4.803659] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.696machine # [ 4.805175] systemd[1]: kmod-static-nodes.service: Deactivated successfully.697machine # [ 4.807177] systemd[1]: Stopped Create List of Static Device Nodes.698machine # [ 4.820398] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.699machine # [ 4.822660] systemd[1]: Finished Cleanup udev Database.700machine # [ 4.824329] systemd[1]: Reached target Switch Root.701machine # [ 4.826451] systemd[1]: Starting NixOS Activation...702machine # [ 4.931723] initrd-nixos-activation-start[191]: booting system configuration /nix/store/lajw30qh6wi91hnww3wn22y1qjdby1n9-nixos-system-machine-test703machine # [ 4.971854] initrd-nixos-activation-start[191]: running activation script...704machine # [ 5.277310] initrd-nixos-activation-start[214]: setting up /etc...705machine # [ 5.468485] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.706machine # [ 5.471190] systemd[1]: Finished NixOS Activation.707machine # [ 5.472932] systemd[1]: Starting Switch Root...708machine # [ 5.487145] systemd[1]: Switching root.709machine # [ 5.807822] systemd-journald[67]: Received SIGTERM from PID 1 (systemd).710machine # [ 5.927432] NET: Registered PF_VSOCK protocol family711machine # [ 6.295029] systemd[1]: systemd 261.1 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)712machine # [ 6.302221] systemd[1]: Detected virtualization kvm.713machine # [ 6.303557] systemd[1]: Detected architecture x86-64.714machine # [ 6.304903] systemd[1]: Detected first boot.715machine # [ 6.308231] systemd[1]: Initializing machine ID from random generator.716machine # [ 6.541732] systemd[1]: bpf-restrict-fs: LSM BPF program attached717machine # [ 6.641405] systemd[1]: Applying preset policy.718machine # [ 6.978015] systemd[1]: Populated /etc with preset unit settings.719machine # [ 7.350577] systemd[1]: initrd-switch-root.service: Deactivated successfully.720machine # [ 7.352363] systemd[1]: Stopped initrd-switch-root.service.721machine # [ 7.355140] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.722machine # [ 7.357646] systemd[1]: Created slice Slice /system/getty.723machine # [ 7.359175] systemd[1]: Created slice User and Session Slice.724machine # [ 7.360358] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.725machine # [ 7.362101] systemd[1]: Started Forward Password Requests to Wall Directory Watch.726machine # [ 7.363869] systemd[1]: Expecting device /dev/hvc0...727machine # [ 7.365094] systemd[1]: Expecting device /dev/ttyS0...728machine # [ 7.366387] systemd[1]: Reached target Local Encrypted Volumes.729machine # [ 7.367747] systemd[1]: Stopped target initrd-fs.target.730machine # [ 7.381123] systemd[1]: Stopped target initrd-root-fs.target.731machine # [ 7.382193] systemd[1]: Stopped target initrd-switch-root.target.732machine # [ 7.383364] systemd[1]: Reached target Virtual Machines and Containers.733machine # [ 7.384650] systemd[1]: Reached target Path Units.734machine # [ 7.385612] systemd[1]: Reached target Remote File Systems.735machine # [ 7.386737] systemd[1]: Reached target Slice Units.736machine # [ 7.387732] systemd[1]: Reached target Swaps.737machine # [ 7.390852] systemd[1]: Listening on Query the User Interactively for a Password.738machine # [ 7.394208] systemd[1]: Listening on Process Core Dump Socket.739machine # [ 7.396829] systemd[1]: Listening on Credential Encryption/Decryption.740machine # [ 7.399473] systemd[1]: Listening on Factory Reset Management.741machine # [ 7.400729] systemd[1]: Listening on Hostname Service Socket.742machine # [ 7.404561] systemd[1]: Starting Journal Log Access Socket...743machine # [ 7.406124] systemd[1]: Listening on Journal Audit Socket.744machine # [ 7.409086] systemd[1]: Listening on Console Output Muting Service Socket.745machine # [ 7.410753] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.746machine # [ 7.412592] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os747machine # [ 7.415379] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki748machine # [ 7.423958] systemd[1]: Listening on Disk Repartitioning Service Socket.749machine # [ 7.425417] systemd[1]: Listening on udev Control Socket.750machine # [ 7.426581] systemd[1]: Listening on udev Varlink Socket.751machine # [ 7.429588] systemd[1]: Mounting Huge Pages File System...752machine # [ 7.433372] systemd[1]: Mounting POSIX Message Queue File System...753machine # [ 7.438781] systemd[1]: Mounting Kernel Debug File System...754machine # [ 7.443821] systemd[1]: Mounting Kernel Trace File System...755machine # [ 7.448120] systemd[1]: Starting Create List of Static Device Nodes...756machine # [ 7.453458] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio757machine # [ 7.464147] systemd[1]: Starting Load Kernel Module configfs...758machine # [ 7.473995] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm759machine # [ 7.482042] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore760machine # [ 7.484016] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse761machine # [ 7.496845] systemd[1]: Mounting FUSE Control File System...762machine # [ 7.501768] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67763machine # [ 7.511583] systemd[1]: Starting Journal Service...764machine # [ 7.522158] systemd[1]: Starting Load Kernel Modules...765machine # [ 7.535385] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...766machine # [ 7.550184] systemd[1]: Starting Remount Root and Kernel File Systems...767machine # [ 7.554618] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os768machine # [ 7.569189] systemd[1]: Starting Coldplug All udev Devices...769machine # [ 7.580614] systemd-journald[284]: Collecting audit messages is enabled.770machine # [ 7.597446] loop: module loaded771machine # [ 7.598188] systemd[1]: Listening on Journal Log Access Socket.772machine # [ 7.604016] systemd[1]: Mounted Huge Pages File System.773machine # [ 7.609882] systemd[1]: Mounted POSIX Message Queue File System.774machine # [ 7.614742] systemd[1]: Mounted Kernel Debug File System.775machine # [ 7.618367] EXT4-fs (vda): re-mounted 22a74be1-ba2a-4819-a445-ae4254dc530f.776machine # [ 7.622534] systemd[1]: Mounted Kernel Trace File System.777machine # [ 7.434831] systemd[1]: Queued start job for default target Multi-User System.778machine # [ 7.635918] systemd[1]: Finished Create List of Static Device Nodes.779machine # [ 7.440358] systemd[1]: systemd-journald.service: Deactivated successfully.780machine # [ 7.444792] systemd-modules-load[285]: Inserted module 'loop'781machine # [ 7.645432] systemd[1]: Started Journal Service.782machine # [ 7.454655] systemd[1]: modprobe@configfs.service: Deactivated successfully.783machine # [ 7.462141] systemd[1]: Finished Load Kernel Module configfs.784machine # [ 7.463433] systemd[1]: Mounted FUSE Control File System.785machine # [ 7.468106] systemd[1]: Finished Load Kernel Modules.786machine # [ 7.469298] systemd[1]: Finished Remount Root and Kernel File Systems.787machine # [ 7.485409] systemd-oomd[287]: No swap; memory pressure usage will be degraded788machine # [ 7.490122] systemd[1]: Listening on Disk Image Download Service Socket.789machine # [ 7.495312] systemd[1]: Mounting Kernel Configuration File System...790machine # [ 7.504130] systemd[1]: Starting Firewall...791machine # [ 7.514115] systemd[1]: Starting Flush Journal to Persistent Storage...792machine # [ 7.516194] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore793machine # [ 7.528130] systemd[1]: Starting Load/Save OS Random Seed...794machine # [ 7.538339] systemd[1]: Starting Apply Kernel Variables...795machine # [ 7.553315] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...796machine # [ 7.554826] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os797machine # [ 7.557201] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.798machine # [ 7.768345] systemd-journald[284]: Received client request to flush runtime journal.799machine # [ 7.765894] systemd[1]: Mounted Kernel Configuration File System.800machine # [ 7.769360] systemd[1]: Finished Load/Save OS Random Seed.801machine # [ 7.772743] systemd[1]: Reached target First Boot Complete.802machine # [ 7.776750] systemd[1]: Finished Apply Kernel Variables.803machine # [ 7.779303] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.804machine # [ 7.782397] systemd[1]: Starting Create Static Device Nodes in /dev...805machine # [ 7.785322] systemd[1]: Finished Flush Journal to Persistent Storage.806machine # [ 7.793762] systemd[1]: Finished Create Static Device Nodes in /dev.807machine # [ 7.797144] systemd[1]: Reached target Preparation for Local File Systems.808machine # [ 7.802490] systemd[1]: Starting Rule-based Manager for Device Events and Files...809machine # [ 7.881715] systemd-udevd[327]: Using default interface naming scheme 'v261'.810machine # [ 7.896307] systemd[1]: Finished Coldplug All udev Devices.811machine # [ 7.977159] systemd[1]: Started Rule-based Manager for Device Events and Files.812machine # [ 8.141682] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse813machine # [ 8.158204] systemd[1]: Mounting /run/wrappers...814machine # [ 8.190593] systemd[1]: Mounted /run/wrappers.815machine # [ 8.193152] systemd[1]: Reached target Local File Systems.816machine # [ 8.197252] systemd[1]: Listening on Boot Loader Control Service Socket.817machine # [ 8.202097] systemd[1]: Starting register-nix-paths.service...818machine # [ 8.205895] systemd[1]: Starting Create SUID/SGID Wrappers...819machine # [ 8.207557] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.820machine # [ 8.218427] systemd[1]: Starting Save Transient machine-id to Disk...821machine # [ 8.229995] systemd[1]: Starting Create System Files and Directories...822machine # [ 8.285052] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.823machine # [ 8.345187] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.824machine # [ 8.399541] systemd[1]: Finished Create System Files and Directories.825machine # [ 8.410208] systemd[1]: Starting Rebuild Journal Catalog...826machine # [ 8.420916] systemd[1]: Starting Record System Boot/Shutdown in UTMP...827machine # [ 8.426559] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.828machine # [ 8.446166] (udev-worker)[365]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.829machine # [ 8.451041] systemd[1]: Finished Save Transient machine-id to Disk.830machine # [ 8.456145] (udev-worker)[376]: Network interface NamePolicy= disabled on kernel command line.831machine # [ 8.460407] (udev-worker)[365]: Network interface NamePolicy= disabled on kernel command line.832machine # [ 8.524574] systemd[1]: Finished Record System Boot/Shutdown in UTMP.833machine # [ 8.568917] systemd[1]: Finished Rebuild Journal Catalog.834machine # [ 8.577644] systemd[1]: Starting Update is Completed...835machine # [ 8.635607] systemd[1]: Finished Update is Completed.836machine # [ 8.703458] systemd[1]: Condition check resulted in Virtio network device being skipped.837machine # [ 8.710785] systemd[1]: Finished Firewall.838machine # [ 8.712860] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore839machine # [ 8.715274] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.840machine # [ 8.718732] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67841machine # [ 8.722829] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore842machine # [ 8.725737] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os843machine # [ 8.728701] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os844machine # [ 8.809542] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.845machine # [ 8.812952] systemd[1]: Finished Create SUID/SGID Wrappers.846machine # [ 9.114904] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3847machine # [ 9.116986] bochs-drm 0000:00:01.0: vgaarb: deactivate vga console848machine # [ 9.134457] mousedev: PS/2 mouse device common for all mice849machine # [ 9.140774] ACPI: button: Power Button [PWRF]850machine # [ 9.198525] rtc_cmos 00:04: RTC can wake from S4851machine # [ 9.216694] rtc_cmos 00:04: registered as rtc0852machine # [ 9.216806] rtc_cmos 00:04: setting system clock to 2026-08-23T18:04:55 UTC (1787508295)853machine # [ 9.216899] rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs854machine # [ 9.217498] systemd-journald[284]: Time jumped backwards, rotating.855machine # [ 9.220442] parport_pc 00:02: reported by Plug and Play ACPI856machine # [ 9.130504] systemd[1]: Finished register-nix-paths.service.857machine # [ 9.134657] systemd[1]: Reached target System Initialization.858machine # [ 9.141108] systemd[1]: Started Discard unused filesystem blocks once a week.859machine # [ 9.142567] systemd[1]: Started Daily Cleanup of Temporary Directories.860machine # [ 9.144660] systemd[1]: Reached target Timer Units.861machine # [ 9.146197] systemd[1]: Listening on D-Bus System Message Bus Socket.862machine # [ 9.148035] systemd[1]: Listening on Nix Daemon Socket.863machine # [ 9.150129] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.864machine # [ 9.152549] systemd[1]: Reached target Socket Units.865machine # [ 9.153589] systemd[1]: Reached target Basic System.866machine # [ 9.155190] systemd[1]: Started backdoor.service.867machine # [ 9.156898] systemd[1]: Starting Import lastlog data into lastlog2 database...868machine # [ 9.220534] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]869machine # [ 9.252376] Console: switching to colour dummy device 80x25870machine # [ 9.169243] systemd[1]: Starting Name Service Cache Daemon (nsncd)...871machine # [ 9.175197] systemd[1]: Starting Post-Boot Actions...872machine # [ 9.192513] systemd[1]: Started Reset console on configuration changes.873machine # [ 9.207712] systemd[1]: Starting resolvconf update...874machine # [ 9.257339] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:09.0/virtio7/input/input4875machine # [ 9.264865] lpc_ich 0000:00:1f.0: I/O space for GPIO uninitialized876machine # connecting to host...877machine # [ 9.381192] i801_smbus 0000:00:1f.3: SMBus using PCI interrupt878machine # [ 9.381342] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD879machine: Guest shell says: b'Spawning backdoor root shell...\n'880machine: connected to guest root shell881machine: (connecting took 10.04 seconds)882machine: (finished: waiting for the VM to finish booting, in 10.04 seconds)883machine # [ 9.440205] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6884machine # [ 9.440559] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5885machine # [ 9.299559] systemd[1]: Starting D-Bus System Message Bus...886machine # [ 9.303462] systemd[1]: Finished Post-Boot Actions.887machine # [ 9.339341] systemd[1]: Started Name Service Cache Daemon (nsncd).888machine # [ 9.342621] nsncd[509]: Aug 23 18:04:55.816 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"889machine # [ 9.348133] systemd[1]: Finished Import lastlog data into lastlog2 database.890machine # [ 9.351841] systemd[1]: Reached target Host and Network Name Lookups.891machine # [ 9.353857] systemd[1]: Reached target User and Group Name Lookups.892machine # [ 9.369644] systemd[1]: Starting User Login Management...893machine # [ 9.580114] [drm] Found bochs VGA, ID 0xb0c5.894machine # [ 9.580116] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.895machine # [ 9.588407] bochs-drm 0000:00:01.0: [drm] Registered 1 planes with drm panic896machine # [ 9.622628] [drm] Initialized bochs-drm 1.0.0 for 0000:00:01.0 on minor 0897machine # [ 9.459187] dbus-broker-launch[525]: Looking up NSS user entry for 'systemd-timesync'...898machine # [ 9.475044] dbus-broker-launch[525]: NSS returned no entry for 'systemd-timesync'899machine # [ 9.476440] dbus-broker-launch[525]: Invalid user-name in /nix/store/yxq6fyy71hfhzbpd80p7hx6zk6vz00w9-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"900machine # [ 9.505818] systemd[1]: Stopped target Host and Network Name Lookups.901machine # [ 9.507326] systemd[1]: Stopping Host and Network Name Lookups...902machine # [ 9.511221] systemd[1]: Stopped target User and Group Name Lookups.903machine # [ 9.512754] systemd[1]: Stopping User and Group Name Lookups...904machine # [ 9.515255] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...905machine # [ 9.518670] systemd[1]: nscd.service: Deactivated successfully.906machine # [ 9.522539] systemd[1]: Stopped Name Service Cache Daemon (nsncd).907machine # [ 9.532822] systemd[1]: Started D-Bus System Message Bus.908machine # [ 9.534351] systemd-logind[544]: New seat seat0.909machine # [ 9.550319] dbus-broker-launch[525]: Ready910machine # [ 9.552386] systemd[1]: Started User Login Management.911machine # [ 9.580602] systemd[1]: Starting linger-users.service...912machine # [ 9.588702] systemd-logind[544]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)913machine # [ 9.590497] systemd[1]: Starting Name Service Cache Daemon (nsncd)...914machine # [ 9.602613] systemd[1]: Starting Virtual Console Setup...915machine # [ 9.649432] systemd[1]: linger-users.service: Deactivated successfully.916machine # [ 9.653483] systemd[1]: Finished linger-users.service.917machine # [ 9.660035] systemd[1]: Finished resolvconf update.918machine # [ 9.663672] nsncd[598]: Aug 23 18:04:56.143 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"919machine # [ 9.892136] Console: switching to colour frame buffer device 160x50920machine # [ 9.967279] bochs-drm 0000:00:01.0: [drm] fb0: bochs-drmdrmfb frame buffer device921machine # [ 9.667950] systemd[1]: Started Name Service Cache Daemon (nsncd).922machine # [ 9.773362] systemd[1]: Reached target Preparation for Network.923machine # [ 9.774755] systemd[1]: Reached target Host and Network Name Lookups.924machine # [ 9.778800] systemd[1]: Reached target User and Group Name Lookups.925machine # [ 9.783591] systemd[1]: Starting DHCP Client...926machine # [ 9.785912] systemd-logind[544]: Watching system buttons on /dev/input/event2 (Power Button)927machine # [ 9.788279] systemd[1]: Starting Address configuration of eth1...928machine # [ 9.790338] systemd[1]: Starting Extra networking commands....929machine # [ 9.792953] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.930machine # [ 9.798291] systemd[1]: Stopped Virtual Console Setup.931machine # [ 9.804288] network-addresses-eth1-start[623]: adding address 192.168.1.1/24... done932machine # [ 10.009541] ppdev: user-space parallel port driver933machine # [ 9.822899] network-addresses-eth1-start[623]: adding address 2001:db8:1::1/64... done934machine # [ 9.831353] systemd[1]: Starting Virtual Console Setup...935machine # [ 9.855822] systemd[1]: Finished Address configuration of eth1.936machine # [ 10.129248] iTCO_wdt iTCO_wdt.1.auto: Found a ICH9 TCO device (Version=2, TCOBASE=0x0660)937machine # [ 9.951978] systemd[1]: Finished Extra networking commands..938machine # [ 9.956092] systemd[1]: Reached target Network.939machine # [ 9.965450] systemd[1]: Starting PostgreSQL Server...940machine # [ 9.974886] dhcpcd[631]: dhcpcd-10.3.2 starting941machine # [ 9.977732] systemd[1]: Started Restate durable execution server.942machine # [ 9.981443] systemd-logind[544]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)943machine # [ 9.986343] dhcpcd[694]: dev: loaded udev944machine # [ 9.995208] systemd[1]: Starting Permit User Sessions...945machine # [ 10.207527] iTCO_wdt iTCO_wdt.1.auto: initialized. heartbeat=30 sec (nowayout=0)946machine # [ 10.210182] 8021q: 802.1Q VLAN Support v1.8947machine # [ 10.214824] 8021q: adding VLAN 0 to HW filter on device eth1948machine # [ 10.096504] systemd[1]: Finished Permit User Sessions.949machine # [ 10.107905] systemd[1]: Started Getty on tty1.950machine # [ 10.109259] systemd[1]: Reached target Login Prompts.951machine # [ 10.220588] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.952machine # [ 10.231928] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.953machine # [ 10.236300] systemd[1]: Stopped Virtual Console Setup.954machine # [ 10.269556] systemd[1]: Starting Virtual Console Setup...955machine # [ 10.518013] cfg80211: Loading compiled-in X.509 certificates for regulatory database956machine # [ 10.545091] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'957machine # [ 10.547720] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'958machine # [ 10.553192] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2959machine # [ 10.554350] cfg80211: failed to load regulatory.db960machine # [ 10.412778] postgresql-pre-start[705]: The files belonging to this database system will be owned by user "postgres".961machine # [ 10.417409] postgresql-pre-start[705]: This user must also own the server process.962machine # [ 10.629071] kvm_amd: TSC scaling supported963machine # [ 10.629831] kvm_amd: Nested Virtualization enabled964machine # [ 10.435390] postgresql-pre-start[705]: The database cluster will be initialized with locale "en_US.UTF-8".965machine # [ 10.439290] postgresql-pre-start[705]: The default database encoding has accordingly been set to "UTF8".966machine # [ 10.441653] postgresql-pre-start[705]: The default text search configuration will be set to "english".967machine # [ 10.445312] postgresql-pre-start[705]: Data page checksums are enabled.968machine # [ 10.447308] postgresql-pre-start[705]: fixing permissions on existing directory /var/lib/postgresql/18 ... ok969machine # [ 10.450829] postgresql-pre-start[705]: creating subdirectories ... ok970machine # [ 10.649481] kvm_amd: Nested Paging enabled971machine # [ 10.650104] kvm_amd: LBR virtualization supported972machine # [ 10.454251] postgresql-pre-start[705]: selecting dynamic shared memory implementation ... posix973machine # [ 10.656170] kvm_amd: Virtual VMLOAD VMSAVE supported974machine # [ 10.657629] kvm_amd: Virtual GIF supported975machine # [ 10.676005] 8021q: adding VLAN 0 to HW filter on device eth0976machine # [ 10.484305] dhcpcd[694]: eth0: waiting for carrier977machine # [ 10.486531] dhcpcd[694]: eth0: carrier acquired978machine # [ 10.511207] dhcpcd[694]: DUID 00:01:00:01:32:1d:f2:c8:52:54:00:12:34:56979machine # [ 10.514539] dhcpcd[694]: eth0: IAID 00:12:34:56980machine # [ 10.516214] dhcpcd[694]: eth0: adding address fe80::5054:ff:fe12:3456981machine # [ 10.760115] EDAC MC: Ver: 3.0.0982machine # [ 10.610948] postgresql-pre-start[705]: selecting default "max_connections" ... 100983machine # [ 10.659399] restate-server[692]: 2026-08-23T18:04:57.133960Z INFO restate_server984machine # [ 10.663330] restate-server[692]: Starting Restate Server 1.7.3 (v1.7.3 x86_64-unknown-linux-gnu 1980-01-01)985machine # [ 10.666657] restate-server[692]: node_name: "machine"986machine # [ 10.668094] restate-server[692]: config_source: /nix/store/ggxclmybgs9yabd1qwaskm57br206qza-restate-keep-failed-temp-test.toml987machine # [ 10.671228] restate-server[692]: base_dir: /var/lib/restate/machine/988machine # [ 10.672424] restate-server[692]: cpus: 1989machine # [ 10.675354] restate-server[692]: on main990machine # [ 10.676486] systemd-vconsole-setup[708]: Configuration of first virtual console was skipped, ignoring remaining ones.991machine # [ 10.682120] systemd[1]: Finished Virtual Console Setup.992machine # [ 10.735250] restate-server[692]: 2026-08-23T18:04:57.215345Z ERROR octocrab993machine # [ 10.737786] restate-server[692]: failed with error client error (Connect)994machine # [ 10.739840] restate-server[692]: on rs:worker-0995machine # [ 10.741628] postgresql-pre-start[705]: selecting default "shared_buffers" ... 128MB996machine # [ 11.251566] dhcpcd[694]: eth0: soliciting a DHCP lease997machine # [ 11.465908] NET: Registered PF_PACKET protocol family998machine # [ 11.275514] dhcpcd[694]: eth0: offered 10.0.2.15 from 10.0.2.2999machine # [ 11.277378] dhcpcd[694]: eth0: probing address 10.0.2.15/241000machine # [ 11.404144] restate-server[692]: 2026-08-23T18:04:57.884238Z INFO restate_core::network::net_util1001machine # [ 11.406448] restate-server[692]: Server listening1002machine # [ 11.408107] restate-server[692]: on rs:worker-01003machine # [ 11.409357] restate-server[692]: in restate_core::network::net_util::server1004machine # [ 11.411292] restate-server[692]: server_name: message-fabric-server1005machine # [ 11.412677] restate-server[692]: uds.path: "machine/fabric.sock"1006machine # [ 11.414138] restate-server[692]: server.address: "127.0.0.1"1007machine # [ 11.415581] restate-server[692]: server.port: 51221008machine # [ 11.417307] restate-server[692]: 2026-08-23T18:04:57.888378Z INFO restate_node::init1009machine # [ 11.420482] restate-server[692]: Trying to join the cluster 'localcluster'1010machine # [ 11.423363] restate-server[692]: on rs:worker-01011machine # [ 11.511074] restate-server[692]: 2026-08-23T18:04:57.991198Z INFO restate_metadata_server::raft::server::member1012machine # [ 11.513847] restate-server[692]: Run as member of the metadata cluster1013machine # [ 11.515289] restate-server[692]: configuration: v1; [N1]1014machine # [ 11.516520] restate-server[692]: on rs:worker-01015machine # [ 11.518273] restate-server[692]: in restate_metadata_server::raft::server::member::run1016machine # [ 11.520419] restate-server[692]: member_id: N1:10e81017machine # [ 11.561686] restate-server[692]: 2026-08-23T18:04:58.041867Z INFO restate_metadata_server::raft::server::member1018machine # [ 11.564466] restate-server[692]: Won metadata cluster leadership1019machine # [ 11.566322] restate-server[692]: on rs:worker-01020machine # [ 11.567473] restate-server[692]: in restate_metadata_server::raft::server::member::run1021machine # [ 11.569312] restate-server[692]: member_id: N1:10e81022machine # [ 11.593360] restate-server[692]: 2026-08-23T18:04:58.073514Z INFO restate_node1023machine # [ 11.596145] restate-server[692]: Cluster 'localcluster' has been automatically provisioned1024machine # [ 11.597984] restate-server[692]: on rs:worker-21025machine # [ 11.740308] restate-server[692]: 2026-08-23T18:04:58.219855Z INFO restate_node1026machine # [ 11.742780] restate-server[692]: My Node ID is N1:21027machine # [ 11.745100] restate-server[692]: node_name: machine1028machine # [ 11.746103] restate-server[692]: roles: http-ingress | admin | worker | log-server | metadata-server1029machine # [ 11.747681] restate-server[692]: address: http://127.0.0.1:5122/1030machine # [ 11.748898] restate-server[692]: location:1031machine # [ 11.749787] restate-server[692]: nodes_config_version: v21032machine # [ 11.750838] restate-server[692]: cluster_name: localcluster1033machine # [ 11.753112] restate-server[692]: cluster_fingerprint: Some(ClusterFingerprint(17761077970194028532))1034machine # [ 11.754677] restate-server[692]: partition_table_version: v11035machine # [ 11.755778] restate-server[692]: logs_version: v11036machine # [ 11.756887] restate-server[692]: on rs:worker-21037machine # [ 11.801947] restate-server[692]: 2026-08-23T18:04:58.281988Z INFO restate_ingress_http::server1038machine # [ 11.805919] restate-server[692]: Ingress HTTP listening1039machine # [ 11.808319] restate-server[692]: on rs:worker-21040machine # [ 11.809759] restate-server[692]: in restate_ingress_http::server::server1041machine # [ 11.811949] restate-server[692]: server_name: http-ingress-server1042machine # [ 11.813920] restate-server[692]: uds.path: "machine/ingress.sock"1043machine # [ 11.815834] restate-server[692]: server.address: "127.0.0.1"1044machine # [ 11.817104] restate-server[692]: server.port: 80801045machine # [ 11.818481] restate-server[692]: 2026-08-23T18:04:58.293881Z INFO restate_node1046machine # [ 11.820342] restate-server[692]: Restate node roles [http-ingress | admin | worker | log-server | metadata-server] were started1047machine # [ 11.822851] restate-server[692]: on rs:worker-21048machine # [ 11.823958] restate-server[692]: 2026-08-23T18:04:58.294092Z INFO restate_node::failure_detector1049machine # [ 11.826278] restate-server[692]: Failure Detector Started1050machine # [ 11.827840] restate-server[692]: on rs:worker-21051machine # [ 11.858843] restate-server[692]: 2026-08-23T18:04:58.338925Z INFO restate_admin::service1052machine # [ 11.861256] restate-server[692]: Admin API starting on: http://127.0.0.1:9070/1053machine # [ 11.862990] restate-server[692]: on rs:worker-21054machine # [ 11.864745] restate-server[692]: 2026-08-23T18:04:58.338965Z INFO restate_core::network::net_util1055machine # [ 11.866714] restate-server[692]: Server listening1056machine # [ 11.868087] restate-server[692]: on rs:worker-21057machine # [ 11.869219] restate-server[692]: in restate_core::network::net_util::server1058machine # [ 11.870931] restate-server[692]: server_name: admin-api-server1059machine # [ 11.872159] restate-server[692]: uds.path: "machine/admin.sock"1060machine # [ 11.873353] restate-server[692]: server.address: "127.0.0.1"1061machine # [ 11.874601] restate-server[692]: server.port: 90701062machine # [ 11.885084] restate-server[692]: 2026-08-23T18:04:58.365130Z INFO restate_node::failure_detector::node_state1063machine # [ 11.887510] restate-server[692]: N1:2 transitioned from Dead to Alive (gossip-age=0)1064machine # [ 11.889379] restate-server[692]: on rs:worker-01065machine # [ 11.891238] restate-server[692]: 2026-08-23T18:04:58.371570Z INFO restate_admin::cluster_controller::service::cluster_controller_state1066machine # [ 11.893878] restate-server[692]: Cluster controller switching to leader mode1067machine # [ 11.895854] restate-server[692]: on rs:worker-01068machine # [ 12.359290] restate-server[692]: 2026-08-23T18:04:58.838972Z INFO restate_worker::partition_processor_manager1069machine # [ 12.361825] restate-server[692]: Reconciling partition processors: starts=[P0(v1 [N1]), P1(v1 [N1]), P2(v1 [N1]), P3(v1 [N1]), P4(v1 [N1]), P5(v1 [N1]), P6(v1 [N1]), P7(v1 [N1]), P8(v1 [N1]), P9(v1 [N1]), P10(v1 [N1]), P11(v1 [N1]), P12(v1 [N1]), P13(v1 [N1]), P14(v1 [N1]), P15(v1 [N1]), P16(v1 [N1]), P17(v1 [N1]), P18(v1 [N1]), P19(v1 [N1]), P20(v1 [N1]), P21(v1 [N1]), P22(v1 [N1]), P23(v1 [N1])] stops=[]1070machine # [ 12.367600] restate-server[692]: on rs:worker-11071machine # [ 12.462674] postgresql-pre-start[705]: selecting default time zone ... UTC1072machine # [ 12.465845] postgresql-pre-start[705]: creating configuration files ... ok1073machine # [ 12.538616] dhcpcd[694]: eth0: soliciting an IPv6 router1074machine # [ 12.540562] dhcpcd[694]: eth0: Router Advertisement from fe80::21075machine # [ 12.541776] dhcpcd[694]: eth0: adding address fec0::5054:ff:fe12:3456/641076machine # [ 12.543762] dhcpcd[694]: eth0: adding route to fec0::/641077machine # [ 12.544877] dhcpcd[694]: eth0: adding default route via fe80::21078machine # [ 12.718602] postgresql-pre-start[705]: running bootstrap script ... ok1079machine # [ 13.009951] restate-server[692]: 2026-08-23T18:04:59.488723Z INFO restate_worker::partition::processor::status1080machine # [ 13.014209] restate-server[692]: Partition 0 started1081machine # [ 13.016336] restate-server[692]: on rt:pp-01082machine # [ 13.018104] restate-server[692]: in restate_worker::partition::run1083machine # [ 13.019525] restate-server[692]: partition_id: 01084machine # [ 13.077505] restate-server[692]: 2026-08-23T18:04:59.552226Z INFO restate_worker::partition::processor::status1085machine # [ 13.079986] restate-server[692]: Partition 3 started1086machine # [ 13.082781] restate-server[692]: on rt:pp-31087machine # [ 13.083768] restate-server[692]: in restate_worker::partition::run1088machine # [ 13.086239] restate-server[692]: partition_id: 31089machine # [ 13.087214] restate-server[692]: 2026-08-23T18:04:59.553555Z INFO restate_worker::partition::processor::status1090machine # [ 13.089401] restate-server[692]: Partition 9 started1091machine # [ 13.090799] restate-server[692]: on rt:pp-91092machine # [ 13.091778] restate-server[692]: in restate_worker::partition::run1093machine # [ 13.095050] restate-server[692]: partition_id: 91094machine # [ 13.095981] restate-server[692]: 2026-08-23T18:04:59.554630Z INFO restate_worker::partition::processor::status1095machine # [ 13.098249] restate-server[692]: Partition 8 started1096machine # [ 13.099703] restate-server[692]: on rt:pp-81097machine # [ 13.100669] restate-server[692]: in restate_worker::partition::run1098machine # [ 13.103179] restate-server[692]: partition_id: 81099machine # [ 13.104207] restate-server[692]: 2026-08-23T18:04:59.557549Z INFO restate_worker::partition::leadership1100machine # [ 13.107931] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1101machine # [ 13.110187] restate-server[692]: partition_id: 01102machine # [ 13.112102] restate-server[692]: leader_epoch: e21103machine # [ 13.113083] restate-server[692]: campaign_duration: 63ms 596µs 630ns1104machine # [ 13.114465] restate-server[692]: on rt:pp-01105machine # [ 13.115424] restate-server[692]: in restate_worker::partition::run1106machine # [ 13.116834] restate-server[692]: partition_id: 01107machine # [ 13.181512] restate-server[692]: 2026-08-23T18:04:59.660817Z INFO restate_worker::partition::leadership1108machine # [ 13.183636] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1109machine # [ 13.185919] restate-server[692]: partition_id: 81110machine # [ 13.186882] restate-server[692]: leader_epoch: e21111machine # [ 13.187840] restate-server[692]: campaign_duration: 106ms 87µs 505ns1112machine # [ 13.189325] restate-server[692]: on rt:pp-81113machine # [ 13.190278] restate-server[692]: in restate_worker::partition::run1114machine # [ 13.192195] restate-server[692]: partition_id: 81115machine # [ 13.193166] restate-server[692]: 2026-08-23T18:04:59.661864Z INFO restate_worker::partition::leadership1116machine # [ 13.196210] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1117machine # [ 13.198465] restate-server[692]: partition_id: 31118machine # [ 13.199617] restate-server[692]: leader_epoch: e21119machine # [ 13.200726] restate-server[692]: campaign_duration: 109ms 569µs 792ns1120machine # [ 13.202329] restate-server[692]: on rt:pp-31121machine # [ 13.203741] restate-server[692]: in restate_worker::partition::run1122machine # [ 13.205354] restate-server[692]: partition_id: 31123machine # [ 13.212389] restate-server[692]: 2026-08-23T18:04:59.692076Z INFO restate_worker::partition::leadership1124machine # [ 13.214913] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1125machine # [ 13.217303] restate-server[692]: partition_id: 91126machine # [ 13.219100] restate-server[692]: leader_epoch: e21127machine # [ 13.220259] restate-server[692]: campaign_duration: 138ms 244µs 107ns1128machine # [ 13.221903] restate-server[692]: on rt:pp-91129machine # [ 13.224197] restate-server[692]: in restate_worker::partition::run1130machine # [ 13.225599] restate-server[692]: partition_id: 91131machine # [ 13.276388] restate-server[692]: 2026-08-23T18:04:59.756565Z INFO restate_worker::partition::leadership1132machine # [ 13.279059] restate-server[692]: Processor became Leader of epoch e2. Spent 198ms 983µs 391ns as BecomingLeader1133machine # [ 13.280962] restate-server[692]: campaign_duration: 262ms 612µs 148ns1134machine # [ 13.282190] restate-server[692]: partition_id: 01135machine # [ 13.284422] restate-server[692]: on rt:pp-01136machine # [ 13.285456] restate-server[692]: in restate_worker::partition::run1137machine # [ 13.286892] restate-server[692]: partition_id: 01138machine # [ 13.318327] restate-server[692]: 2026-08-23T18:04:59.796570Z INFO restate_worker::partition::processor::status1139machine # [ 13.320512] restate-server[692]: Partition 6 started1140machine # [ 13.321831] restate-server[692]: on rt:pp-61141machine # [ 13.322821] restate-server[692]: in restate_worker::partition::run1142machine # [ 13.324183] restate-server[692]: partition_id: 61143machine # [ 13.344702] restate-server[692]: 2026-08-23T18:04:59.825053Z INFO restate_worker::partition::leadership1144machine # [ 13.346805] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1145machine # [ 13.348988] restate-server[692]: partition_id: 61146machine # [ 13.349968] restate-server[692]: leader_epoch: e21147machine # [ 13.351176] restate-server[692]: campaign_duration: 28ms 393µs 274ns1148machine # [ 13.354120] restate-server[692]: on rt:pp-61149machine # [ 13.355078] restate-server[692]: in restate_worker::partition::run1150machine # [ 13.356470] restate-server[692]: partition_id: 61151machine # [ 13.358846] restate-server[692]: 2026-08-23T18:04:59.838714Z INFO restate_worker::partition::leadership1152machine # [ 13.360928] restate-server[692]: Processor became Leader of epoch e2. Spent 166ms 700µs 237ns as BecomingLeader1153machine # [ 13.362825] restate-server[692]: campaign_duration: 286ms 419µs 923ns1154machine # [ 13.365115] restate-server[692]: partition_id: 31155machine # [ 13.366230] restate-server[692]: on rt:pp-31156machine # [ 13.367213] restate-server[692]: in restate_worker::partition::run1157machine # [ 13.368618] restate-server[692]: partition_id: 31158machine # [ 13.405243] restate-server[692]: 2026-08-23T18:04:59.883692Z INFO restate_worker::partition::processor::status1159machine # [ 13.407462] restate-server[692]: Partition 12 started1160machine # [ 13.408805] restate-server[692]: on rt:pp-121161machine # [ 13.409784] restate-server[692]: in restate_worker::partition::run1162machine # [ 13.411221] restate-server[692]: partition_id: 121163machine # [ 13.416635] restate-server[692]: 2026-08-23T18:04:59.895300Z INFO restate_worker::partition::processor::status1164machine # [ 13.418796] restate-server[692]: Partition 4 started1165machine # [ 13.420155] restate-server[692]: on rt:pp-41166machine # [ 13.421124] restate-server[692]: in restate_worker::partition::run1167machine # [ 13.422524] restate-server[692]: partition_id: 41168machine # [ 13.424241] restate-server[692]: 2026-08-23T18:04:59.895622Z INFO restate_worker::partition::processor::status1169machine # [ 13.428236] restate-server[692]: Partition 23 started1170machine # [ 13.429592] restate-server[692]: on rt:pp-231171machine # [ 13.430548] restate-server[692]: in restate_worker::partition::run1172machine # [ 13.431918] restate-server[692]: partition_id: 231173machine # [ 13.442232] restate-server[692]: 2026-08-23T18:04:59.921318Z INFO restate_worker::partition::leadership1174machine # [ 13.444358] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1175machine # [ 13.446662] restate-server[692]: partition_id: 121176machine # [ 13.447626] restate-server[692]: leader_epoch: e21177machine # [ 13.448571] restate-server[692]: campaign_duration: 37ms 553µs 656ns1178machine # [ 13.450033] restate-server[692]: on rt:pp-121179machine # [ 13.450996] restate-server[692]: in restate_worker::partition::run1180machine # [ 13.453774] restate-server[692]: partition_id: 121181machine # [ 13.458476] restate-server[692]: 2026-08-23T18:04:59.937660Z INFO restate_worker::partition::leadership1182machine # [ 13.460831] restate-server[692]: Processor became Leader of epoch e2. Spent 268ms 6µs 409ns as BecomingLeader1183machine # [ 13.462746] restate-server[692]: campaign_duration: 382ms 940µs 290ns1184machine # [ 13.464085] restate-server[692]: partition_id: 81185machine # [ 13.465192] restate-server[692]: on rt:pp-81186machine # [ 13.466139] restate-server[692]: in restate_worker::partition::run1187machine # [ 13.467516] restate-server[692]: partition_id: 81188machine # [ 13.471780] postgresql-pre-start[705]: performing post-bootstrap initialization ... ok1189machine # [ 13.511393] restate-server[692]: 2026-08-23T18:04:59.988763Z INFO restate_worker::partition::leadership1190machine # [ 13.513518] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1191machine # [ 13.515790] restate-server[692]: partition_id: 231192machine # [ 13.517251] restate-server[692]: leader_epoch: e21193machine # [ 13.518686] restate-server[692]: campaign_duration: 93ms 86µs 691ns1194machine # [ 13.521115] restate-server[692]: on rt:pp-231195machine # [ 13.522095] restate-server[692]: in restate_worker::partition::run1196machine # [ 13.523494] restate-server[692]: partition_id: 231197machine # [ 13.524468] restate-server[692]: 2026-08-23T18:04:59.990397Z INFO restate_worker::partition::leadership1198machine # [ 13.528118] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1199machine # [ 13.532300] restate-server[692]: partition_id: 41200machine # [ 13.533410] restate-server[692]: leader_epoch: e21201machine # [ 13.534822] restate-server[692]: campaign_duration: 95ms 5µs 929ns1202machine # [ 13.536198] restate-server[692]: on rt:pp-41203machine # [ 13.537158] restate-server[692]: in restate_worker::partition::run1204machine # [ 13.540102] restate-server[692]: partition_id: 41205machine # [ 13.599524] restate-server[692]: 2026-08-23T18:05:00.079216Z INFO restate_worker::partition::leadership1206machine # [ 13.603316] restate-server[692]: Processor became Leader of epoch e2. Spent 386ms 689µs 649ns as BecomingLeader1207machine # [ 13.606307] restate-server[692]: campaign_duration: 525ms 562µs 48ns1208machine # [ 13.608482] restate-server[692]: partition_id: 91209machine # [ 13.610328] restate-server[692]: on rt:pp-91210machine # [ 13.611651] restate-server[692]: in restate_worker::partition::run1211machine # [ 13.614116] restate-server[692]: partition_id: 91212machine # [ 13.696322] restate-server[692]: 2026-08-23T18:05:00.176625Z INFO restate_worker::partition::leadership1213machine # [ 13.699536] restate-server[692]: Processor became Leader of epoch e2. Spent 187ms 814µs 932ns as BecomingLeader1214machine # [ 13.702801] restate-server[692]: campaign_duration: 280ms 947µs 998ns1215machine # [ 13.704880] restate-server[692]: partition_id: 231216machine # [ 13.706295] restate-server[692]: on rt:pp-231217machine # [ 13.707408] restate-server[692]: in restate_worker::partition::run1218machine # [ 13.709823] restate-server[692]: partition_id: 231219machine # [ 13.714243] restate-server[692]: 2026-08-23T18:05:00.179825Z INFO restate_worker::partition::leadership1220machine # [ 13.716326] restate-server[692]: Processor became Leader of epoch e2. Spent 348ms 431µs 994ns as BecomingLeader1221machine # [ 13.718247] restate-server[692]: campaign_duration: 383ms 164µs 620ns1222machine # [ 13.719462] restate-server[692]: partition_id: 61223machine # [ 13.720556] restate-server[692]: on rt:pp-61224machine # [ 13.721494] restate-server[692]: in restate_worker::partition::run1225machine # [ 13.724617] restate-server[692]: partition_id: 61226machine # [ 13.725589] restate-server[692]: 2026-08-23T18:05:00.189609Z INFO restate_worker::partition::leadership1227machine # [ 13.727687] restate-server[692]: Processor became Leader of epoch e2. Spent 268ms 245µs 825ns as BecomingLeader1228machine # [ 13.729597] restate-server[692]: campaign_duration: 305ms 846µs 134ns1229machine # [ 13.730807] restate-server[692]: partition_id: 121230machine # [ 13.733217] restate-server[692]: on rt:pp-121231machine # [ 13.734651] restate-server[692]: in restate_worker::partition::run1232machine # [ 13.736052] restate-server[692]: partition_id: 121233machine # [ 13.736970] restate-server[692]: 2026-08-23T18:05:00.191416Z INFO restate_worker::partition::leadership1234machine # [ 13.739852] restate-server[692]: Processor became Leader of epoch e2. Spent 200ms 993µs 143ns as BecomingLeader1235machine # [ 13.742232] restate-server[692]: campaign_duration: 296ms 25µs 332ns1236machine # [ 13.743729] restate-server[692]: partition_id: 41237machine # [ 13.744914] restate-server[692]: on rt:pp-41238machine # [ 13.745871] restate-server[692]: in restate_worker::partition::run1239machine # [ 13.747496] restate-server[692]: partition_id: 41240machine # [ 13.748580] restate-server[692]: 2026-08-23T18:05:00.213392Z INFO restate_worker::partition::processor::status1241machine # [ 13.750957] restate-server[692]: Partition 11 started1242machine # [ 13.754099] restate-server[692]: on rt:pp-111243machine # [ 13.755371] restate-server[692]: in restate_worker::partition::run1244machine # [ 13.756796] restate-server[692]: partition_id: 111245machine # [ 13.795793] restate-server[692]: 2026-08-23T18:05:00.275941Z INFO restate_worker::partition::leadership1246machine # [ 13.798471] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1247machine # [ 13.800945] restate-server[692]: partition_id: 111248machine # [ 13.801909] restate-server[692]: leader_epoch: e21249machine # [ 13.802859] restate-server[692]: campaign_duration: 62ms 240µs 34ns1250machine # [ 13.804907] restate-server[692]: on rt:pp-111251machine # [ 13.806189] restate-server[692]: in restate_worker::partition::run1252machine # [ 13.807572] restate-server[692]: partition_id: 111253machine # [ 13.810551] restate-server[692]: 2026-08-23T18:05:00.285007Z INFO restate_worker::partition::processor::status1254machine # [ 13.812996] restate-server[692]: Partition 1 started1255machine # [ 13.814355] restate-server[692]: on rt:pp-11256machine # [ 13.815313] restate-server[692]: in restate_worker::partition::run1257machine # [ 13.816702] restate-server[692]: partition_id: 11258machine # [ 13.817861] restate-server[692]: 2026-08-23T18:05:00.289974Z INFO restate_worker::partition::processor::status1259machine # [ 13.820238] restate-server[692]: Partition 13 started1260machine # [ 13.821608] restate-server[692]: on rt:pp-131261machine # [ 13.822568] restate-server[692]: in restate_worker::partition::run1262machine # [ 13.823958] restate-server[692]: partition_id: 131263machine # [ 13.878244] restate-server[692]: 2026-08-23T18:05:00.358497Z INFO restate_worker::partition::leadership1264machine # [ 13.881292] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1265machine # [ 13.885877] restate-server[692]: partition_id: 11266machine # [ 13.887268] restate-server[692]: leader_epoch: e21267machine # [ 13.888916] restate-server[692]: campaign_duration: 73ms 438µs 384ns1268machine # [ 13.890613] restate-server[692]: on rt:pp-11269machine # [ 13.891838] restate-server[692]: in restate_worker::partition::run1270machine # [ 13.893234] restate-server[692]: partition_id: 11271machine # [ 13.894249] restate-server[692]: 2026-08-23T18:05:00.366030Z INFO restate_worker::partition::leadership1272machine # [ 13.896965] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1273machine # [ 13.899308] restate-server[692]: partition_id: 131274machine # [ 13.900650] restate-server[692]: leader_epoch: e21275machine # [ 13.901606] restate-server[692]: campaign_duration: 76ms 9µs 939ns1276machine # [ 13.903332] restate-server[692]: on rt:pp-131277machine # [ 13.904329] restate-server[692]: in restate_worker::partition::run1278machine # [ 13.905873] restate-server[692]: partition_id: 131279machine # [ 13.906859] restate-server[692]: 2026-08-23T18:05:00.377003Z INFO restate_worker::partition::leadership1280machine # [ 13.909914] restate-server[692]: Processor became Leader of epoch e2. Spent 101ms 15µs 911ns as BecomingLeader1281machine # [ 13.911882] restate-server[692]: campaign_duration: 163ms 303µs 716ns1282machine # [ 13.913170] restate-server[692]: partition_id: 111283machine # [ 13.914303] restate-server[692]: on rt:pp-111284machine # [ 13.915279] restate-server[692]: in restate_worker::partition::run1285machine # [ 13.916715] restate-server[692]: partition_id: 111286machine # [ 13.961259] restate-server[692]: 2026-08-23T18:05:00.440729Z INFO restate_worker::partition::processor::status1287machine # [ 13.964462] restate-server[692]: Partition 2 started1288machine # [ 13.967144] restate-server[692]: on rt:pp-21289machine # [ 13.968374] restate-server[692]: in restate_worker::partition::run1290machine # [ 13.970327] restate-server[692]: partition_id: 21291machine # [ 13.976137] restate-server[692]: 2026-08-23T18:05:00.454053Z INFO restate_worker::partition::leadership1292machine # [ 13.978576] restate-server[692]: Processor became Leader of epoch e2. Spent 88ms 288µs 595ns as BecomingLeader1293machine # [ 13.980531] restate-server[692]: campaign_duration: 168ms 545µs 164ns1294machine # [ 13.981981] restate-server[692]: partition_id: 11295machine # [ 13.983468] restate-server[692]: on rt:pp-11296machine # [ 13.984519] restate-server[692]: in restate_worker::partition::run1297machine # [ 13.986195] restate-server[692]: partition_id: 11298machine # [ 14.014590] restate-server[692]: 2026-08-23T18:05:00.494244Z INFO restate_worker::partition::leadership1299machine # [ 14.016827] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1300machine # [ 14.019251] restate-server[692]: partition_id: 21301machine # [ 14.020679] restate-server[692]: leader_epoch: e21302machine # [ 14.021646] restate-server[692]: campaign_duration: 53ms 455µs 956ns1303machine # [ 14.023149] restate-server[692]: on rt:pp-21304machine # [ 14.024830] restate-server[692]: in restate_worker::partition::run1305machine # [ 14.026495] restate-server[692]: partition_id: 21306machine # [ 14.030288] restate-server[692]: 2026-08-23T18:05:00.500758Z INFO restate_worker::partition::processor::status1307machine # [ 14.033246] restate-server[692]: Partition 10 started1308machine # [ 14.034716] restate-server[692]: on rt:pp-101309machine # [ 14.035692] restate-server[692]: in restate_worker::partition::run1310machine # [ 14.037103] restate-server[692]: partition_id: 101311machine # [ 14.058160] restate-server[692]: 2026-08-23T18:05:00.538490Z INFO restate_worker::partition::leadership1312machine # [ 14.060825] restate-server[692]: Processor became Leader of epoch e2. Spent 172ms 372µs 466ns as BecomingLeader1313machine # [ 14.063281] restate-server[692]: campaign_duration: 248ms 470µs 685ns1314machine # [ 14.064807] restate-server[692]: partition_id: 131315machine # [ 14.066647] restate-server[692]: on rt:pp-131316machine # [ 14.067642] restate-server[692]: in restate_worker::partition::run1317machine # [ 14.069042] restate-server[692]: partition_id: 131318machine # [ 14.074095] restate-server[692]: 2026-08-23T18:05:00.554357Z INFO restate_worker::partition::leadership1319machine # [ 14.076230] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1320machine # [ 14.078447] restate-server[692]: partition_id: 101321machine # [ 14.079493] restate-server[692]: leader_epoch: e21322machine # [ 14.080450] restate-server[692]: campaign_duration: 53ms 522µs 166ns1323machine # [ 14.081842] restate-server[692]: on rt:pp-101324machine # [ 14.082806] restate-server[692]: in restate_worker::partition::run1325machine # [ 14.085350] restate-server[692]: partition_id: 101326machine # [ 14.127447] restate-server[692]: 2026-08-23T18:05:00.606470Z INFO restate_worker::partition::processor::status1327machine # [ 14.129732] restate-server[692]: Partition 14 started1328machine # [ 14.131119] restate-server[692]: on rt:pp-141329machine # [ 14.132105] restate-server[692]: in restate_worker::partition::run1330machine # [ 14.133516] restate-server[692]: partition_id: 141331machine # [ 14.141802] restate-server[692]: 2026-08-23T18:05:00.621324Z INFO restate_worker::partition::leadership1332machine # [ 14.144591] restate-server[692]: Processor became Leader of epoch e2. Spent 127ms 36µs 537ns as BecomingLeader1333machine # [ 14.146577] restate-server[692]: campaign_duration: 180ms 535µs 515ns1334machine # [ 14.147805] restate-server[692]: partition_id: 21335machine # [ 14.148933] restate-server[692]: on rt:pp-21336machine # [ 14.150236] restate-server[692]: in restate_worker::partition::run1337machine # [ 14.151633] restate-server[692]: partition_id: 21338machine # [ 14.152689] restate-server[692]: 2026-08-23T18:05:00.621853Z INFO restate_worker::partition::leadership1339machine # [ 14.155268] restate-server[692]: Processor became Leader of epoch e2. Spent 67ms 458µs 15ns as BecomingLeader1340machine # [ 14.157232] restate-server[692]: campaign_duration: 121ms 17µs 895ns1341machine # [ 14.158461] restate-server[692]: partition_id: 101342machine # [ 14.159566] restate-server[692]: on rt:pp-101343machine # [ 14.161048] restate-server[692]: in restate_worker::partition::run1344machine # [ 14.162658] restate-server[692]: partition_id: 101345machine # [ 14.187187] restate-server[692]: 2026-08-23T18:05:00.667498Z INFO restate_worker::partition::leadership1346machine # [ 14.190141] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1347machine # [ 14.193197] restate-server[692]: partition_id: 141348machine # [ 14.194394] restate-server[692]: leader_epoch: e21349machine # [ 14.195963] restate-server[692]: campaign_duration: 60ms 948µs 807ns1350machine # [ 14.197816] restate-server[692]: on rt:pp-141351machine # [ 14.198972] restate-server[692]: in restate_worker::partition::run1352machine # [ 14.201399] restate-server[692]: partition_id: 141353machine # [ 14.206435] restate-server[692]: 2026-08-23T18:05:00.684711Z INFO restate_worker::partition::processor::status1354machine # [ 14.209116] restate-server[692]: Partition 7 started1355machine # [ 14.210548] restate-server[692]: on rt:pp-71356machine # [ 14.211502] restate-server[692]: in restate_worker::partition::run1357machine # [ 14.212864] restate-server[692]: partition_id: 71358machine # [ 14.241144] restate-server[692]: 2026-08-23T18:05:00.718962Z INFO restate_worker::partition::leadership1359machine # [ 14.244683] restate-server[692]: Processor became Leader of epoch e2. Spent 48ms 762µs 901ns as BecomingLeader1360machine # [ 14.247756] restate-server[692]: campaign_duration: 112ms 412µs 52ns1361machine # [ 14.249213] restate-server[692]: partition_id: 141362machine # [ 14.250826] restate-server[692]: on rt:pp-141363machine # [ 14.251995] restate-server[692]: in restate_worker::partition::run1364machine # [ 14.254088] restate-server[692]: partition_id: 141365machine # [ 14.256069] restate-server[692]: 2026-08-23T18:05:00.736337Z INFO restate_worker::partition::leadership1366machine # [ 14.258213] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1367machine # [ 14.260522] restate-server[692]: partition_id: 71368machine # [ 14.261448] restate-server[692]: leader_epoch: e21369machine # [ 14.262464] restate-server[692]: campaign_duration: 51ms 569µs 124ns1370machine # [ 14.263882] restate-server[692]: on rt:pp-71371machine # [ 14.264845] restate-server[692]: in restate_worker::partition::run1372machine # [ 14.266225] restate-server[692]: partition_id: 71373machine # [ 14.311162] restate-server[692]: 2026-08-23T18:05:00.790829Z INFO restate_worker::partition::processor::status1374machine # [ 14.314234] restate-server[692]: Partition 5 started1375machine # [ 14.315667] restate-server[692]: on rt:pp-51376machine # [ 14.316696] restate-server[692]: in restate_worker::partition::run1377machine # [ 14.318170] restate-server[692]: partition_id: 51378machine # [ 14.323551] restate-server[692]: 2026-08-23T18:05:00.803600Z INFO restate_worker::partition::leadership1379machine # [ 14.325753] restate-server[692]: Processor became Leader of epoch e2. Spent 67ms 212µs 732ns as BecomingLeader1380machine # [ 14.327851] restate-server[692]: campaign_duration: 118ms 832µs 980ns1381machine # [ 14.329125] restate-server[692]: partition_id: 71382machine # [ 14.330235] restate-server[692]: on rt:pp-71383machine # [ 14.331222] restate-server[692]: in restate_worker::partition::run1384machine # [ 14.333090] restate-server[692]: partition_id: 71385machine # [ 14.365109] restate-server[692]: 2026-08-23T18:05:00.844823Z INFO restate_worker::partition::leadership1386machine # [ 14.368128] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1387machine # [ 14.370622] restate-server[692]: partition_id: 51388machine # [ 14.371560] restate-server[692]: leader_epoch: e21389machine # [ 14.373183] restate-server[692]: campaign_duration: 53ms 919µs 702ns1390machine # [ 14.374557] restate-server[692]: on rt:pp-51391machine # [ 14.375564] restate-server[692]: in restate_worker::partition::run1392machine # [ 14.376950] restate-server[692]: partition_id: 51393machine # [ 14.384183] restate-server[692]: 2026-08-23T18:05:00.853047Z INFO restate_worker::partition::processor::status1394machine # [ 14.387132] restate-server[692]: Partition 15 started1395machine # [ 14.388532] restate-server[692]: on rt:pp-151396machine # [ 14.389503] restate-server[692]: in restate_worker::partition::run1397machine # [ 14.390891] restate-server[692]: partition_id: 151398machine # [ 14.392818] restate-server[692]: 2026-08-23T18:05:00.860563Z INFO restate_worker::partition::processor::status1399machine # [ 14.395608] restate-server[692]: Partition 16 started1400machine # [ 14.397312] restate-server[692]: on rt:pp-161401machine # [ 14.398531] restate-server[692]: in restate_worker::partition::run1402machine # [ 14.401159] restate-server[692]: partition_id: 161403machine # [ 14.460341] restate-server[692]: 2026-08-23T18:05:00.940553Z INFO restate_worker::partition::leadership1404machine # [ 14.464144] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1405machine # [ 14.467084] restate-server[692]: partition_id: 151406machine # [ 14.468259] restate-server[692]: leader_epoch: e21407machine # [ 14.469311] restate-server[692]: campaign_duration: 87ms 403µs 8ns1408machine # [ 14.470740] restate-server[692]: on rt:pp-151409machine # [ 14.471719] restate-server[692]: in restate_worker::partition::run1410machine # [ 14.473145] restate-server[692]: partition_id: 151411machine # [ 14.475527] restate-server[692]: 2026-08-23T18:05:00.944373Z INFO restate_worker::partition::leadership1412machine # [ 14.477811] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1413machine # [ 14.481117] restate-server[692]: partition_id: 161414machine # [ 14.482148] restate-server[692]: leader_epoch: e21415machine # [ 14.483120] restate-server[692]: campaign_duration: 83ms 742µs 207ns1416machine # [ 14.484586] restate-server[692]: on rt:pp-161417machine # [ 14.485604] restate-server[692]: in restate_worker::partition::run1418machine # [ 14.487074] restate-server[692]: partition_id: 161419machine # [ 14.513056] restate-server[692]: 2026-08-23T18:05:00.993052Z INFO restate_worker::partition::leadership1420machine # [ 14.515777] restate-server[692]: Processor became Leader of epoch e2. Spent 144ms 837µs 961ns as BecomingLeader1421machine # [ 14.518264] restate-server[692]: campaign_duration: 202ms 150µs 832ns1422machine # [ 14.519658] restate-server[692]: partition_id: 51423machine # [ 14.520841] restate-server[692]: on rt:pp-51424machine # [ 14.521798] restate-server[692]: in restate_worker::partition::run1425machine # [ 14.523681] restate-server[692]: partition_id: 51426machine # [ 14.559789] restate-server[692]: 2026-08-23T18:05:01.039879Z INFO restate_worker::partition::processor::status1427machine # [ 14.562264] restate-server[692]: Partition 17 started1428machine # [ 14.563865] restate-server[692]: on rt:pp-171429machine # [ 14.564834] restate-server[692]: in restate_worker::partition::run1430machine # [ 14.566492] restate-server[692]: partition_id: 171431machine # [ 14.583204] restate-server[692]: 2026-08-23T18:05:01.063534Z INFO restate_worker::partition::leadership1432machine # [ 14.585708] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1433machine # [ 14.588002] restate-server[692]: partition_id: 171434machine # [ 14.589047] restate-server[692]: leader_epoch: e21435machine # [ 14.590873] restate-server[692]: campaign_duration: 23ms 560µs 257ns1436machine # [ 14.592277] restate-server[692]: on rt:pp-171437machine # [ 14.593290] restate-server[692]: in restate_worker::partition::run1438machine # [ 14.594688] restate-server[692]: partition_id: 171439machine # [ 14.597239] restate-server[692]: 2026-08-23T18:05:01.076918Z INFO restate_worker::partition::leadership1440machine # [ 14.600189] restate-server[692]: Processor became Leader of epoch e2. Spent 121ms 918µs 568ns as BecomingLeader1441machine # [ 14.602167] restate-server[692]: campaign_duration: 216ms 290µs 339ns1442machine # [ 14.603447] restate-server[692]: partition_id: 161443machine # [ 14.604636] restate-server[692]: on rt:pp-161444machine # [ 14.606100] restate-server[692]: in restate_worker::partition::run1445machine # [ 14.607546] restate-server[692]: partition_id: 161446machine # [ 14.609865] restate-server[692]: 2026-08-23T18:05:01.078175Z INFO restate_worker::partition::leadership1447machine # [ 14.612601] restate-server[692]: Processor became Leader of epoch e2. Spent 123ms 647µs as BecomingLeader1448machine # [ 14.614409] restate-server[692]: campaign_duration: 225ms 30µs 276ns1449machine # [ 14.615641] restate-server[692]: partition_id: 151450machine # [ 14.617052] restate-server[692]: on rt:pp-151451machine # [ 14.617991] restate-server[692]: in restate_worker::partition::run1452machine # [ 14.619522] restate-server[692]: partition_id: 151453machine # [ 14.647165] restate-server[692]: 2026-08-23T18:05:01.126818Z INFO restate_worker::partition::processor::status1454machine # [ 14.649526] restate-server[692]: Partition 19 started1455machine # [ 14.652106] restate-server[692]: on rt:pp-191456machine # [ 14.653087] restate-server[692]: in restate_worker::partition::run1457machine # [ 14.654464] restate-server[692]: partition_id: 191458machine # [ 14.685309] restate-server[692]: 2026-08-23T18:05:01.165601Z INFO restate_worker::partition::leadership1459machine # [ 14.688885] restate-server[692]: Processor became Leader of epoch e2. Spent 95ms 79µs 682ns as BecomingLeader1460machine # [ 14.691680] restate-server[692]: campaign_duration: 125ms 626µs 581ns1461machine # [ 14.693353] restate-server[692]: partition_id: 171462machine # [ 14.695429] restate-server[692]: on rt:pp-171463machine # [ 14.696798] restate-server[692]: in restate_worker::partition::run1464machine # [ 14.698247] restate-server[692]: partition_id: 171465machine # [ 14.701477] restate-server[692]: 2026-08-23T18:05:01.181838Z INFO restate_worker::partition::leadership1466machine # [ 14.703858] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1467machine # [ 14.706224] restate-server[692]: partition_id: 191468machine # [ 14.707199] restate-server[692]: leader_epoch: e21469machine # [ 14.709195] restate-server[692]: campaign_duration: 54ms 928µs 769ns1470machine # [ 14.710577] restate-server[692]: on rt:pp-191471machine # [ 14.711682] restate-server[692]: in restate_worker::partition::run1472machine # [ 14.713593] restate-server[692]: partition_id: 191473machine # [ 14.724608] restate-server[692]: 2026-08-23T18:05:01.201998Z INFO restate_worker::partition::processor::status1474machine # [ 14.726785] restate-server[692]: Partition 22 started1475machine # [ 14.728201] restate-server[692]: on rt:pp-221476machine # [ 14.729240] restate-server[692]: in restate_worker::partition::run1477machine # [ 14.730631] restate-server[692]: partition_id: 221478machine # [ 14.747242] restate-server[692]: 2026-08-23T18:05:01.227567Z INFO restate_worker::partition::leadership1479machine # [ 14.750417] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1480machine # [ 14.754239] restate-server[692]: partition_id: 221481machine # [ 14.755715] restate-server[692]: leader_epoch: e21482machine # [ 14.756901] restate-server[692]: campaign_duration: 25ms 496µs 816ns1483machine # [ 14.758485] restate-server[692]: on rt:pp-221484machine # [ 14.759528] restate-server[692]: in restate_worker::partition::run1485machine # [ 14.762206] restate-server[692]: partition_id: 221486machine # [ 14.788376] restate-server[692]: 2026-08-23T18:05:01.265998Z INFO restate_worker::partition::leadership1487machine # [ 14.790810] restate-server[692]: Processor became Leader of epoch e2. Spent 82ms 50µs 931ns as BecomingLeader1488machine # [ 14.793343] restate-server[692]: campaign_duration: 139ms 87µs 789ns1489machine # [ 14.794554] restate-server[692]: partition_id: 191490machine # [ 14.795668] restate-server[692]: on rt:pp-191491machine # [ 14.797144] restate-server[692]: in restate_worker::partition::run1492machine # [ 14.800327] restate-server[692]: partition_id: 191493machine # [ 14.811171] restate-server[692]: 2026-08-23T18:05:01.290559Z INFO restate_worker::partition::leadership1494machine # [ 14.813531] restate-server[692]: Processor became Leader of epoch e2. Spent 56ms 301µs 10ns as BecomingLeader1495machine # [ 14.816105] restate-server[692]: campaign_duration: 88ms 489µs 738ns1496machine # [ 14.818096] restate-server[692]: partition_id: 221497machine # [ 14.819224] restate-server[692]: on rt:pp-221498machine # [ 14.820243] restate-server[692]: in restate_worker::partition::run1499machine # [ 14.821799] restate-server[692]: partition_id: 221500machine # [ 14.849637] restate-server[692]: 2026-08-23T18:05:01.328660Z INFO restate_worker::partition::processor::status1501machine # [ 14.852626] restate-server[692]: Partition 18 started1502machine # [ 14.853935] restate-server[692]: on rt:pp-181503machine # [ 14.854856] restate-server[692]: in restate_worker::partition::run1504machine # [ 14.856217] restate-server[692]: partition_id: 181505machine # [ 14.870246] restate-server[692]: 2026-08-23T18:05:01.350319Z INFO restate_worker::partition::leadership1506machine # [ 14.872708] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1507machine # [ 14.875225] restate-server[692]: partition_id: 181508machine # [ 14.876220] restate-server[692]: leader_epoch: e21509machine # [ 14.877236] restate-server[692]: campaign_duration: 21ms 585µs 704ns1510machine # [ 14.878687] restate-server[692]: on rt:pp-181511machine # [ 14.879728] restate-server[692]: in restate_worker::partition::run1512machine # [ 14.881223] restate-server[692]: partition_id: 181513machine # [ 14.911792] restate-server[692]: 2026-08-23T18:05:01.390271Z INFO restate_worker::partition::processor::status1514machine # [ 14.914730] restate-server[692]: Partition 20 started1515machine # [ 14.916171] restate-server[692]: on rt:pp-201516machine # [ 14.917188] restate-server[692]: in restate_worker::partition::run1517machine # [ 14.918677] restate-server[692]: partition_id: 201518machine # [ 14.920402] restate-server[692]: 2026-08-23T18:05:01.391234Z INFO restate_worker::partition::processor::status1519machine # [ 14.922787] restate-server[692]: Partition 21 started1520machine # [ 14.924196] restate-server[692]: on rt:pp-211521machine # [ 14.925236] restate-server[692]: in restate_worker::partition::run1522machine # [ 14.926729] restate-server[692]: partition_id: 211523machine # [ 14.928185] restate-server[692]: 2026-08-23T18:05:01.394698Z INFO restate_worker::partition::leadership1524machine # [ 14.930402] restate-server[692]: Processor became Leader of epoch e2. Spent 44ms 333µs 288ns as BecomingLeader1525machine # [ 14.932552] restate-server[692]: campaign_duration: 65ms 967µs 43ns1526machine # [ 14.934052] restate-server[692]: partition_id: 181527machine # [ 14.935430] restate-server[692]: on rt:pp-181528machine # [ 14.936696] restate-server[692]: in restate_worker::partition::run1529machine # [ 14.938379] restate-server[692]: partition_id: 181530machine # [ 14.960667] restate-server[692]: 2026-08-23T18:05:01.440049Z INFO restate_worker::partition::leadership1531machine # [ 14.963975] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1532machine # [ 14.966633] restate-server[692]: partition_id: 211533machine # [ 14.967761] restate-server[692]: leader_epoch: e21534machine # [ 14.968959] restate-server[692]: campaign_duration: 48ms 768µs 209ns1535machine # [ 14.970665] restate-server[692]: on rt:pp-211536machine # [ 14.972183] restate-server[692]: in restate_worker::partition::run1537machine # [ 14.973790] restate-server[692]: partition_id: 211538machine # [ 14.974875] restate-server[692]: 2026-08-23T18:05:01.440743Z INFO restate_worker::partition::leadership1539machine # [ 14.977251] restate-server[692]: Processor transitioned into BecomingLeader. Will propose a `VersionBarrier` to enable [EnableJournalV2]1540machine # [ 14.979703] restate-server[692]: partition_id: 201541machine # [ 14.980694] restate-server[692]: leader_epoch: e21542machine # [ 14.981814] restate-server[692]: campaign_duration: 50ms 406µs 127ns1543machine # [ 14.983688] restate-server[692]: on rt:pp-201544machine # [ 14.984893] restate-server[692]: in restate_worker::partition::run1545machine # [ 14.986379] restate-server[692]: partition_id: 201546machine # [ 15.004173] restate-server[692]: 2026-08-23T18:05:01.483736Z INFO restate_worker::partition::leadership1547machine # [ 15.006675] restate-server[692]: Processor became Leader of epoch e2. Spent 42ms 961µs 606ns as BecomingLeader1548machine # [ 15.008853] restate-server[692]: campaign_duration: 93ms 398µs 742ns1549machine # [ 15.010074] restate-server[692]: partition_id: 201550machine # [ 15.011191] restate-server[692]: on rt:pp-201551machine # [ 15.012914] restate-server[692]: in restate_worker::partition::run1552machine # [ 15.014290] restate-server[692]: partition_id: 201553machine # [ 15.016279] restate-server[692]: 2026-08-23T18:05:01.487018Z INFO restate_worker::partition::leadership1554machine # [ 15.018467] restate-server[692]: Processor became Leader of epoch e2. Spent 46ms 914µs 622ns as BecomingLeader1555machine # [ 15.020440] restate-server[692]: campaign_duration: 95ms 739µs 822ns1556machine # [ 15.021869] restate-server[692]: partition_id: 211557machine # [ 15.023177] restate-server[692]: on rt:pp-211558machine # [ 15.024204] restate-server[692]: in restate_worker::partition::run1559machine # [ 15.025753] restate-server[692]: partition_id: 211560machine # [ 15.085042] postgresql-pre-start[705]: syncing data to disk ... ok1561machine # [ 15.086353] postgresql-pre-start[705]: initdb: warning: enabling "trust" authentication for local connections1562machine # [ 15.088144] postgresql-pre-start[705]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.1563machine # [ 15.091227] postgresql-pre-start[705]: Success. You can now start the database server using:1564machine # [ 15.092762] postgresql-pre-start[705]: pg_ctl -D /var/lib/postgresql/18 -l logfile start1565machine # [ 15.256488] postgres[896]: [896] LOG: starting PostgreSQL 18.6 on x86_64-pc-linux-gnu, compiled by clang version 21.1.8, 64-bit1566machine # [ 15.260828] postgres[896]: [896] LOG: listening on IPv6 address "::1", port 54321567machine # [ 15.262442] postgres[896]: [896] LOG: listening on IPv4 address "127.0.0.1", port 54321568machine # [ 15.277236] postgres[896]: [896] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"1569machine # [ 15.324984] postgres[905]: [905] LOG: database system was shut down at 2026-08-23 18:04:59 GMT1570machine # [ 15.350619] postgres[896]: [896] LOG: database system is ready to accept connections1571machine # [ 15.374281] systemd[1]: Started PostgreSQL Server.1572machine # [ 15.382116] systemd[1]: Starting PostgreSQL Setup Scripts...1573machine # [ 15.592735] postgresql-setup-start[916]: CREATE DATABASE1574machine # [ 15.631231] postgresql-setup-start[921]: CREATE ROLE1575machine # [ 15.655686] postgresql-setup-start[923]: ALTER DATABASE1576machine # [ 15.661698] systemd[1]: Finished PostgreSQL Setup Scripts.1577machine # [ 15.664460] systemd[1]: Reached target PostgreSQL.1578machine # [ 15.668770] systemd[1]: Starting Migrate URL media archive database...1579machine: (finished: waiting for unit postgresql.service, in 16.69 seconds)1580machine: waiting for unit restate.service1581machine: (finished: waiting for unit restate.service, in 0.06 seconds)1582machine: waiting for TCP port 8080 on localhost1583machine # Connection to localhost (127.0.0.1) 8080 port [tcp/http-alt] succeeded!1584machine: (finished: waiting for TCP port 8080 on localhost, in 0.06 seconds)1585machine: waiting for TCP port 9070 on localhost1586machine # Connection to localhost (127.0.0.1) 9070 port [tcp/*] succeeded!1587machine: (finished: waiting for TCP port 9070 on localhost, in 0.04 seconds)1588machine: waiting for success: systemctl show -p Result --value url-media-archive-worker-migrate.service | grep '^success$'1589machine: (finished: waiting for success: systemctl show -p Result --value url-media-archive-worker-migrate.service | grep '^success$', in 0.09 seconds)1590machine: waiting for unit url-media-archive-worker.service1591machine # [ 16.329715] dhcpcd[694]: eth0: leased 10.0.2.15 for 86400 seconds1592machine # [ 16.331963] dhcpcd[694]: eth0: adding route to 10.0.2.0/241593machine # [ 16.333326] dhcpcd[694]: eth0: adding default route via 10.0.2.21594machine # [ 16.455344] systemd[1]: Started DHCP Client.1595machine # [ 16.459436] systemd[1]: Reached target Network is Online.1596machine # [ 16.724191] systemd[1]: url-media-archive-worker-migrate.service: Deactivated successfully.1597machine # [ 16.725968] systemd[1]: Finished Migrate URL media archive database.1598machine # [ 16.728839] systemd[1]: url-media-archive-worker-migrate.service: Consumed 444ms CPU time over 1.054s wall clock time, 70.6M memory peak.1599machine # [ 16.741871] systemd[1]: Started URL media archive Restate worker.1600machine # [ 16.747631] systemd[1]: Starting Register URL media archive worker with Restate...1601machine # [ 16.853269] url-media-archive-worker-register-start[1029]: curl: (7) Failed to connect to 127.0.0.1:9080 after 2 ms: Could not connect to server1602machine # [ 17.130983] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:03.607Z] WARN: Accepting requests without validating request signatures; handler access must be restricted1603machine # [ 17.135652] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:03.615Z] WARN: Accepting requests without validating request signatures; handler access must be restricted1604machine: (finished: waiting for unit url-media-archive-worker.service, in 1.12 seconds)1605machine: waiting for TCP port 9080 on localhost1606machine # Connection to localhost (127.0.0.1) 9080 port [tcp/glrpc] succeeded!1607machine: (finished: waiting for TCP port 9080 on localhost, in 0.03 seconds)1608machine: waiting for success: systemctl show -p Result --value url-media-archive-worker-register.service | grep '^success$'1609machine: (finished: waiting for success: systemctl show -p Result --value url-media-archive-worker-register.service | grep '^success$', in 0.05 seconds)1610??? Warning (UserWarning): wait_until_succeeds(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1611 File "/nix/store/ri05iv8i720xw2qylqi7msjin73k6v9y-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391612machine: waiting for success: curl --fail --silent --show-error --max-time 5 -H 'content-type: application/json' --data '{"source": "example-feed", "sourceKey": "456", "url": "https://example.com/media/456", "metadata": {"author": "user"}}' http://127.0.0.1:8080/UrlMediaArchive/submitDiscoveredUrl > /tmp/accepted-456.json1613??? Warning (UserWarning): execute(): passing a bare int/float as a duration is deprecated. Use datetime.timedelta instead.1614 File "/nix/store/ri05iv8i720xw2qylqi7msjin73k6v9y-nixos-test-driver-1.1/lib/python3.14/site-packages/test_driver/duration.py", line 391615machine # curl: (22) The requested URL returned error: 4041616machine # [ 17.974609] url-media-archive-worker-register-start[1058]: {"id":"dp_16eWfOFyH8wkaFGxdrQc32V","services":[{"name":"UrlMediaAttempt","ty":"VirtualObject","handlers":[{"name":"run","ty":"Exclusive","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"status","ty":"Shared","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}}],"deployment_id":"dp_16eWfOFyH8wkaFGxdrQc32V","revision":1,"public":true,"idempotency_retention":"1d","journal_retention":"1d","inactivity_timeout":"0s","abort_timeout":"10m","enable_lazy_state":false,"retry_policy":{"initial_interval":"500ms","exponentiation_factor":2.0,"max_attempts":70,"max_interval":"1m","on_max_attempts":"Pause"}},{"name":"UrlMediaArchiveHostLeaseQueue","ty":"VirtualObject","handlers":[{"name":"release","ty":"Exclusive","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"acquire","ty":"Exclusive","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"drop","ty":"Exclusive","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"status","ty":"Shared","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}}],"deployment_id":"dp_16eWfOFyH8wkaFGxdrQc32V","revision":1,"public":true,"idempotency_retention":"1d","journal_retention":"1d","inactivity_timeout":"0s","abort_timeout":"10m","enable_lazy_state":false,"retry_policy":{"initial_interval":"500ms","exponentiation_factor":2.0,"max_attempts":70,"max_interval":"1m","on_max_attempts":"Pause"}},{"name":"UrlMediaArchiveRateLimit","ty":"VirtualObject","handlers":[{"name":"reserve","ty":"Exclusive","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}}],"deployment_id":"dp_16eWfOFyH8wkaFGxdrQc32V","revision":1,"public":true,"idempotency_retention":"1d","journal_retention":"1d","inactivity_timeout":"0s","abort_timeout":"10m","enable_lazy_state":false,"retry_policy":{"initial_interval":"500ms","exponentiation_factor":2.0,"max_attempts":70,"max_interval":"1m","on_max_attempts":"Pause"}},{"name":"UrlMediaWorkflow","ty":"Workflow","handlers":[{"name":"run","ty":"Workflow","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}}],"deployment_id":"dp_16eWfOFyH8wkaFGxdrQc32V","revision":1,"public":true,"idempotency_retention":"1d","workflow_completion_retention":"1d","journal_retention":"1d","inactivity_timeout":"0s","abort_timeout":"10m","enable_lazy_state":false,"retry_policy":{"initial_interval":"500ms","exponentiation_factor":2.0,"max_attempts":70,"max_interval":"1m","on_max_attempts":"Pause"}},{"name":"UrlMediaArchive","ty":"Service","handlers":[{"name":"startDiscoveryScan","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"submitJob","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"submitUrl","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"drainPending","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"status","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"statusBySource","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"submitDiscoveredUrl","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"recordDiscoveryPage","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}},{"name":"getDiscoveryState","public":true,"input_description":"application/json","output_description":"application/json","retry_policy":{"max_attempts":null}}],"deployment_id":"dp_16eWfOFyH8wkaFGxdrQc32V","revision":1,"public":true,"idempotency_retention":"1d","journal_retention":"1d","inactivity_timeout":"0s","abort_timeout":"10m","enable_lazy_state":false,"retry_policy":{"initial_interval":"500ms","exponentiation_factor":2.0,"max_attempts":70,"max_interval":"1m","on_max_attempts":"Pause"}}],"min_protocol_version":5,"max_protocol_version":6,"sdk_version":"restate-sdk-typescript/1.14.3"}1617machine # [ 18.045465] systemd[1]: url-media-archive-worker-register.service: Deactivated successfully.1618machine # [ 18.047743] systemd[1]: Finished Register URL media archive worker with Restate.1619machine # [ 18.049832] systemd[1]: url-media-archive-worker-register.service: Consumed 52ms CPU time over 1.293s wall clock time, 3.2M memory peak, 5.7K incoming IP traffic, 1.1K outgoing IP traffic.1620machine # [ 18.053085] systemd[1]: Reached target Multi-User System.1621machine # [ 18.054623] systemd[1]: Startup finished in 873ms (kernel) + 4.812s (initrd) + 12.368s (userspace) = 18.054s.1622machine # [ 18.513358] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:04.992Z][UrlMediaArchive/submitDiscoveredUrl][inv_16rECIkpEC2F7rDyfh3s60kcgepcMVterX] INFO: Starting invocation.1623machine # [ 18.562688] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.042Z][UrlMediaArchive/submitDiscoveredUrl][inv_16rECIkpEC2F7rDyfh3s60kcgepcMVterX] INFO: Invocation suspended1624machine # [ 18.595478] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.075Z][UrlMediaArchive/submitDiscoveredUrl][inv_16rECIkpEC2F7rDyfh3s60kcgepcMVterX] INFO: Replaying invocation.1625machine # [ 18.600965] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.081Z][UrlMediaArchive/submitDiscoveredUrl][inv_16rECIkpEC2F7rDyfh3s60kcgepcMVterX] INFO: Invocation completed successfully.1626machine: (finished: waiting for success: curl --fail --silent --show-error --max-time 5 -H 'content-type: application/json' --data '{"source": "example-feed", "sourceKey": "456", "url": "https://example.com/media/456", "metadata": {"author": "user"}}' http://127.0.0.1:8080/UrlMediaArchive/submitDiscoveredUrl > /tmp/accepted-456.json, in 1.29 seconds)1627machine: must succeed: cat /tmp/accepted-456.json1628machine # [ 18.668730] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.148Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Starting invocation.1629machine # [ 18.679711] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.158Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Invocation suspended1630machine: (finished: must succeed: cat /tmp/accepted-456.json, in 0.03 seconds)1631machine: waiting for success: curl --fail --silent --show-error --max-time 5 -H 'content-type: application/json' --data '{"source": "example-feed", "sourceKey": "456"}' http://127.0.0.1:8080/UrlMediaArchive/statusBySource | jq -e '.status == "terminal_failed" and .probeStatus == "has_media"'1632machine # [ 18.712347] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.192Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Replaying invocation.1633machine # [ 18.720592] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.199Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Invocation suspended1634machine # [ 18.776650] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.256Z][UrlMediaArchiveHostLeaseQueue/example.com/acquire][inv_1g3bLFi2O82v3J4jQzGV8rEyBeCbAJy5Vv] INFO: Starting invocation.1635machine # [ 18.787387] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.267Z][UrlMediaArchiveHostLeaseQueue/example.com/acquire][inv_1g3bLFi2O82v3J4jQzGV8rEyBeCbAJy5Vv] INFO: Invocation suspended1636machine # [ 18.795709] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.275Z][UrlMediaArchive/statusBySource][inv_1aifuqSthJy63WV8otAPtUJz30YZHbAlRU] INFO: Starting invocation.1637machine # [ 18.802811] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.282Z][UrlMediaArchive/statusBySource][inv_1aifuqSthJy63WV8otAPtUJz30YZHbAlRU] INFO: Invocation suspended1638machine # [ 18.889133] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.369Z][UrlMediaArchiveHostLeaseQueue/example.com/acquire][inv_1g3bLFi2O82v3J4jQzGV8rEyBeCbAJy5Vv] INFO: Replaying invocation.1639machine # [ 18.897067] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.376Z][UrlMediaArchiveHostLeaseQueue/example.com/acquire][inv_1g3bLFi2O82v3J4jQzGV8rEyBeCbAJy5Vv] INFO: Invocation completed successfully.1640machine # [ 18.899982] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.377Z][UrlMediaArchive/statusBySource][inv_1aifuqSthJy63WV8otAPtUJz30YZHbAlRU] INFO: Replaying invocation.1641machine # [ 18.904081] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.384Z][UrlMediaArchive/statusBySource][inv_1aifuqSthJy63WV8otAPtUJz30YZHbAlRU] INFO: Invocation completed successfully.1642machine # [ 19.010776] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.490Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Replaying invocation.1643machine # [ 19.017212] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.497Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Invocation suspended1644machine # [ 19.073270] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.552Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Starting invocation.1645machine # [ 19.081102] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.561Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1646machine # [ 19.121738] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.602Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1647machine # [ 19.142156] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.621Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1648machine # [ 19.177690] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.657Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1649machine # [ 19.202462] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.682Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1650machine # [ 19.244616] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.724Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1651machine # [ 19.261995] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.742Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1652machine # [ 19.289971] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.770Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1653machine # [ 19.299569] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.779Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1654machine # [ 19.338240] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.818Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1655machine # [ 19.368879] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.848Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1656machine # [ 19.414098] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.894Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1657machine # [ 19.438083] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.917Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1658machine # [ 19.462980] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.943Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1659machine # [ 19.470880] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.950Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation suspended1660machine # [ 19.511409] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.991Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Replaying invocation.1661machine # [ 19.519767] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:05.998Z][UrlMediaAttempt/pg:1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1jm3Re6J7bLa5fId33a5pqYdYhbSwhSERH] INFO: Invocation completed successfully.1662machine # [ 19.580481] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.060Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Replaying invocation.1663machine # [ 19.586085] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.066Z][UrlMediaWorkflow/1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/run][inv_1kLS5cFenK6d6Lq3Kipb9J1kKjN2aGRleV] INFO: Invocation completed successfully.1664machine # [ 19.647220] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.127Z][UrlMediaArchiveHostLeaseQueue/example.com/release][inv_1g3bLFi2O82v09D4aYnaKw3AffPsob0SB3] INFO: Starting invocation.1665machine # [ 19.653656] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.133Z][UrlMediaArchiveHostLeaseQueue/example.com/release][inv_1g3bLFi2O82v09D4aYnaKw3AffPsob0SB3] INFO: Invocation suspended1666machine # [ 19.705086] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.184Z][UrlMediaArchiveHostLeaseQueue/example.com/release][inv_1g3bLFi2O82v09D4aYnaKw3AffPsob0SB3] INFO: Replaying invocation.1667machine # [ 19.710426] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.190Z][UrlMediaArchiveHostLeaseQueue/example.com/release][inv_1g3bLFi2O82v09D4aYnaKw3AffPsob0SB3] INFO: Invocation completed successfully.1668machine # [ 20.070926] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.551Z][UrlMediaArchive/statusBySource][inv_124dyEFYNo5U0Axl3o3StE1sIRDAIcmf9U] INFO: Starting invocation.1669machine # [ 20.078783] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.558Z][UrlMediaArchive/statusBySource][inv_124dyEFYNo5U0Axl3o3StE1sIRDAIcmf9U] INFO: Invocation suspended1670machine # [ 20.102922] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.583Z][UrlMediaArchive/statusBySource][inv_124dyEFYNo5U0Axl3o3StE1sIRDAIcmf9U] INFO: Replaying invocation.1671machine # [ 20.107330] url-media-archive-worker[1023]: [restate][2026-08-23T18:05:06.587Z][UrlMediaArchive/statusBySource][inv_124dyEFYNo5U0Axl3o3StE1sIRDAIcmf9U] INFO: Invocation completed successfully.1672machine: (finished: waiting for success: curl --fail --silent --show-error --max-time 5 -H 'content-type: application/json' --data '{"source": "example-feed", "sourceKey": "456"}' http://127.0.0.1:8080/UrlMediaArchive/statusBySource | jq -e '.status == "terminal_failed" and .probeStatus == "has_media"', in 1.45 seconds)1673machine: must succeed: test -f /var/lib/url-media-archive/archive/.tmp/pg_1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/failure-marker.part1674machine: (finished: must succeed: test -f /var/lib/url-media-archive/archive/.tmp/pg_1959cc0d-d46f-46d1-8a0c-6a7a68f3309b/failure-marker.part, in 0.01 seconds)1675(finished: run the VM test script, in 21.07 seconds)1676test script finished in 21.12s1677cleanup1678kill QemuMachine (pid 45)1679machine # qemu-system-x86_64: terminating on signal 15 from pid 39 (/nix/store/3n4qphl9s728sz8frmpqqrv9b1m87g68-python3-3.14.7/bin/python3.14)1680(finished: cleanup, in 0.17 seconds)