summaryrefslogtreecommitdiff
path: root/artifacts/perf-multiworld/20260928T195839Z
diff options
context:
space:
mode:
authorSomhairle H. Marisol <[email protected]>2026-09-29 04:23:26 +0800
committerSomhairle H. Marisol <[email protected]>2026-09-29 04:23:26 +0800
commitf681867692f575b078f46afaf07060faed457461 (patch)
tree4ab11638357891257703e55f5aa790868e902e3c /artifacts/perf-multiworld/20260928T195839Z
parent2d9e4d845019b6c8793633258a45b91e0358e0e9 (diff)
downloadliving-village-f681867692f575b078f46afaf07060faed457461.tar.gz
p59: Sim 多世界并存后台压测(内存/GC 增长曲线证据单,只读)
目标:量化「多世界并存 × 天数」的内存/GC 增长,收口 P49 范围外项。 口径:新增 Headless `--profile-multiworld <worlds> <days> <npcs> <sampleEveryDays> <seedBase>`, N 个 Sim 世界同时存活,每轮 Parallel.For 各推进 sampleEveryDays 天并采样一行 (worlds/events/rumors/annals/memory_entries/gc_live_mb/working_set_rss_mb/elapsed_s, 行尾 flush);未改 Kernel/Sim 任何语义(Sim.initialWorldN / Sim.step 原样调用)。 标定:1 世界 × 2 天探针 = 34.2s(与 overnight-status 的 34.6s 一致),据此定 N=10 × 20 天。 运行:独立 systemd --user transient unit living-village-multiworld.service (scripts/profile-multiworld.sh,StandardOutput=append: + exec 2>&1,state.json 记 pid/unit/log/commit/参数/起止/exit)。主运行 wall=1024.4s(17.1min < 40min),exit=0。 结论(artifacts/perf-multiworld/20260928T195839Z/README.md): - 随世界数近似线性,未超线性:N=1 vs N=10(同日 D=20)annals/memory_entries 恰 10×、 rumors 9.67×、gc_live 8.81×(每世界 1.23MB,共享运行时开销摊薄)。 - RSS 有界无泄漏:N=10 39→峰值123(day8)→稳定104~112MB;每 2 天一轮墙钟恒 101~105s。 原因是历史集合有界(rumorRetentionDays=3 / rumorCapacity=16384 / maxAnnalEntries=128 / Mind.Memory 上限),约 day4 后进入稳态。 - 两轮世界0 digest 一致(2364CB74…)→ 并存+并行不改变单世界语义。 - 数字未越界 → 明确「不修」;只读本 slice 不修 Kernel/Sim。 回归:Desktop 304/304 + Kernel 119/119;--performance-baseline ×3 digest 953775FAEB2F… 不变,performance_determinism=PASS。未 push。
Diffstat (limited to 'artifacts/perf-multiworld/20260928T195839Z')
-rw-r--r--artifacts/perf-multiworld/20260928T195839Z/README.md113
-rw-r--r--artifacts/perf-multiworld/20260928T195839Z/acceptance.log15
-rw-r--r--artifacts/perf-multiworld/20260928T195839Z/control-n1.log13
-rw-r--r--artifacts/perf-multiworld/20260928T195839Z/state.json16
4 files changed, 157 insertions, 0 deletions
diff --git a/artifacts/perf-multiworld/20260928T195839Z/README.md b/artifacts/perf-multiworld/20260928T195839Z/README.md
new file mode 100644
index 0000000..f5dc676
--- /dev/null
+++ b/artifacts/perf-multiworld/20260928T195839Z/README.md
@@ -0,0 +1,113 @@
+# P59 多世界并存压测结论(Sim 多世界 × 天数的内存/GC 增长曲线)
+
+- 日期:2026-09-28
+- 代码 commit:`2c559a7`(本 slice 起点;压测期间未改 Kernel/Sim)
+- 运行方式:独立 `systemd --user` transient unit `living-village-multiworld.service`
+ (wrapper `scripts/profile-multiworld.sh`,`StandardOutput=append:` + `exec 2>&1` 汇一个文件)
+- 证据:本目录 `acceptance.log`(主运行 N=10)、`control-n1.log`(控制组 N=1)、`state.json`
+- 只读结论,**未修改任何 Kernel/Sim 语义**;`--performance-baseline` ×3 digest 仍为
+ `953775FAEB2F…`,Kernel 119/119。
+
+## 口径
+
+`dotnet LivingVillage.Headless.dll --profile-multiworld <worlds> <days> <npcs> <sampleEveryDays> <seedBase>`
+
+- N 个 `Sim.initialWorldN(seedBase+i, 30)` 世界**同时存活**;
+- 按采样轮推进:每轮用 `Parallel.For` 让全部世界各前进 `sampleEveryDays` 天,随后采样一次;
+- 采样字段:`worlds`(并存世界数)、`events`、`rumors`、`annals`、`memory_entries`
+ (全部世界的聚合)、`gc_live_mb`(`GC.GetTotalMemory(true)`)、`working_set_rss_mb`
+ (`Process.WorkingSet64`)、`elapsed_s`;每行 flush;
+- ground truth 为 **gc_live 与 RSS**;条目计数只作解释用。
+
+### 标定探针(先跑)
+
+`--profile-multiworld 1 2`(1 世界 × 2 天)= **34.2s**,与 `docs/overnight-status.md`
+中 Hermes 单 worker 亲测 34.6s 一致。据此定 **N=10 × 20 天**(10 世界并行一轮约 100s)。
+
+## 主运行 N=10 × 20 天(12 天口径内的采样,`acceptance.log`)
+
+| day | rumors | annals | memory_entries | gc_live_mb | rss_mb | elapsed_s |
+|----:|------:|------:|--------------:|----------:|------:|---------:|
+| 0 | 0 | 0 | 0 | 0.12 | 39.05 | 0.0 |
+| 2 | 38536 | 1280 | 19200 | 7.28 | 74.61 | 101.0 |
+| 4 | 76353 | 1280 | 19200 | 12.19 | 91.55 | 206.1 |
+| 6 | 75488 | 1280 | 19200 | 12.09 | 102.58 | 309.6 |
+| 8 | 75737 | 1280 | 19200 | 12.13 | 123.10 | 412.4 |
+| 10 | 75667 | 1280 | 19200 | 12.11 | 106.71 | 514.9 |
+| 12 | 75908 | 1280 | 19200 | 12.15 | 112.00 | 616.9 |
+| 14 | 76017 | 1280 | 19200 | 12.16 | 110.58 | 719.2 |
+| 16 | 75334 | 1280 | 19200 | 12.06 | 111.41 | 820.4 |
+| 18 | 75907 | 1280 | 19200 | 12.15 | 105.52 | 922.5 |
+| 20 | 76687 | 1280 | 19200 | 12.25 | 103.96 | 1024.3 |
+
+wall = **1024.4s(≈17.1 min,< 40 min 预算)**,exit=0。
+
+## 控制组 N=1 × 20 天(`control-n1.log`)
+
+| day | rumors | annals | memory_entries | gc_live_mb | rss_mb | elapsed_s |
+|----:|------:|------:|--------------:|----------:|------:|---------:|
+| 2 | 3921 | 128 | 1920 | 0.85 | 57.19 | 34.0 |
+| 4 | 7843 | 128 | 1920 | 1.37 | 61.71 | 68.1 |
+| 20 | 7932 | 128 | 1920 | 1.39 | 67.94 | 339.0 |
+
+wall = 339.1s。世界 0 的 `world_digests=0:2364CB74F5FCA345…` 与 N=10 主运行的
+世界 0 **逐字节一致** → 并存 + 并行推进不改变单世界语义。
+
+## 结论
+
+### 1) 增长是否随世界数超线性?——否,近似线性(内存实为略次线性)
+
+以 N=1 与 N=10 同日(D=20)对比:
+
+| 量 | N=1 | N=10 | 倍率 |
+|---|---:|---:|---:|
+| rumors | 7932 | 76687 | 9.67× |
+| annals | 128 | 1280 | 10.00× |
+| memory_entries | 1920 | 19200 | 10.00× |
+| gc_live_mb | 1.39 | 12.25 | 8.81×(每世界 1.23MB) |
+| wall_s | 339 | 1024 | 3.02×(10× 工作量,16 核并行) |
+
+条目计数严格 ~N 倍;GC live set **略低于** N 倍(运行时/JIT/GC 堆共享的固定开销被摊薄)。
+**未观测到任何超线性增长**。
+
+### 2) RSS 是否有界?——有界,无单调泄漏
+
+- N=10:39MB → 峰值 123MB(day 8)→ 回落并稳定在 **104–112MB**,day 10 后不再上升。
+- N=1:39MB → day 4 后稳定在 **64–68MB**。
+- 时间维度上,10 世界每 2 天一轮墙钟恒为 **101–105s**(波动 <4%),说明 2–20 天窗口内
+ 逐日成本**不随天数上升**——与早期 M3 phase2 在 100 天视野看到的逐日成本上升不同。
+
+原因(读码确认,非猜测,未改码):三类历史集合均有界——
+`Sim.rumorRetentionDays = 3`(按天淘汰,`rumorCapacity = 16384`/世界)、
+`maxAnnalEntries = 128`、`Mind.Memory` 每 NPC 上限。因此 day ~4 后每条曲线进入稳态。
+
+`events` 全程为 0:自主模拟不产生 `InteractionEvent`(仅玩家交互写入),符合预期,非泄漏信号。
+
+### 3) 是否有建议的最小修复?——**不修**
+
+所有指标未越界:live set 有界、RSS 有界且回落、随 N 线性、无 NaN(判据门在 M3R 另测)。
+本 slice 只读,不改任何 Kernel/Sim。
+
+观察项(留档,不在本 slice 处理):
+- M3 phase2 在 100 天视野的逐日成本上升未在 20 天窗口复现;若需定位需另设 >20 天采样。
+- 10 世界并行时单世界墙钟约为串行的 3.0×(GC/CPU 争用),16 核下仍远低于预算。
+
+## 复现
+
+```bash
+# 控制组(前台)
+dotnet src/LivingVillage.Headless/bin/Release/net8.0/LivingVillage.Headless.dll \
+ --profile-multiworld 1 20 30 2 42
+
+# 主运行(独立 systemd --user transient unit,见 deploy/living-village-multiworld.service)
+TS=$(date -u +%Y%m%dT%H%M%SZ)
+DIR=$PWD/artifacts/perf-multiworld/$TS
+systemd-run --user --unit=living-village-multiworld \
+ --property=Type=simple --property=WorkingDirectory=$PWD \
+ --setenv=PMW_REPO=$PWD --setenv=PMW_DIR=$DIR --setenv=PMW_COMMIT=2c559a7 \
+ --setenv=PMW_WORLDS=10 --setenv=PMW_DAYS=20 --setenv=PMW_NPCS=30 \
+ --setenv=PMW_SAMPLE_EVERY=2 --setenv=PMW_SEED_BASE=42 --setenv=PMW_LOG=$DIR/acceptance.log \
+ --property=StandardOutput=append:$DIR/acceptance.log \
+ --property=StandardError=append:$DIR/acceptance.log --property=Restart=no \
+ /usr/bin/bash $PWD/scripts/profile-multiworld.sh
+```
diff --git a/artifacts/perf-multiworld/20260928T195839Z/acceptance.log b/artifacts/perf-multiworld/20260928T195839Z/acceptance.log
new file mode 100644
index 0000000..8f6ac82
--- /dev/null
+++ b/artifacts/perf-multiworld/20260928T195839Z/acceptance.log
@@ -0,0 +1,15 @@
+[pmw] start unit=living-village-multiworld.service pid=165537 commit=2c559a7 worlds=10 days=20 npcs=30 sample_every=2 seed_base=42 started_at=2026-09-28T19:58:39Z
+multiworld_start worlds=10 days=20 npcs=30 sample_every_days=2 seed_base=42 ticks_per_day=5184000
+multiworld_sample worlds=10 day=0/20 events=0 rumors=0 annals=0 memory_entries=0 gc_live_mb=0.12 working_set_rss_mb=39.05 elapsed_s=0.0
+multiworld_sample worlds=10 day=2/20 events=0 rumors=38536 annals=1280 memory_entries=19200 gc_live_mb=7.28 working_set_rss_mb=74.61 elapsed_s=101.0
+multiworld_sample worlds=10 day=4/20 events=0 rumors=76353 annals=1280 memory_entries=19200 gc_live_mb=12.19 working_set_rss_mb=91.55 elapsed_s=206.1
+multiworld_sample worlds=10 day=6/20 events=0 rumors=75488 annals=1280 memory_entries=19200 gc_live_mb=12.09 working_set_rss_mb=102.58 elapsed_s=309.6
+multiworld_sample worlds=10 day=8/20 events=0 rumors=75737 annals=1280 memory_entries=19200 gc_live_mb=12.13 working_set_rss_mb=123.10 elapsed_s=412.4
+multiworld_sample worlds=10 day=10/20 events=0 rumors=75667 annals=1280 memory_entries=19200 gc_live_mb=12.11 working_set_rss_mb=106.71 elapsed_s=514.9
+multiworld_sample worlds=10 day=12/20 events=0 rumors=75908 annals=1280 memory_entries=19200 gc_live_mb=12.15 working_set_rss_mb=112.00 elapsed_s=616.9
+multiworld_sample worlds=10 day=14/20 events=0 rumors=76017 annals=1280 memory_entries=19200 gc_live_mb=12.16 working_set_rss_mb=110.58 elapsed_s=719.2
+multiworld_sample worlds=10 day=16/20 events=0 rumors=75334 annals=1280 memory_entries=19200 gc_live_mb=12.06 working_set_rss_mb=111.41 elapsed_s=820.4
+multiworld_sample worlds=10 day=18/20 events=0 rumors=75907 annals=1280 memory_entries=19200 gc_live_mb=12.15 working_set_rss_mb=105.52 elapsed_s=922.5
+multiworld_sample worlds=10 day=20/20 events=0 rumors=76687 annals=1280 memory_entries=19200 gc_live_mb=12.25 working_set_rss_mb=103.96 elapsed_s=1024.3
+multiworld_done worlds=10 day=20 elapsed_s=1024.4 world_digests=0:2364CB74F5FCA34503269F413F7184F455006C9975EB01B11219D25A3A33FDD2,1:BDD2F62D96C0F4A72ECDDA5DA17106B7910C5FEAE0FC197610DA0C467066467C,2:5F59925D880B8059E52B939BE72773BFD7C5971AC2D1DD9541C556577A4D23B2,3:AB78433838A44F13524D08ACC6639B2C4DA07A829AFD0C01AEA5AAEF7D09C72A,4:778B3F47193D016F314280A1752A34390699B1825C422D34C24C8F34FF8F965E,5:C3C7B02C3C7E8A368462F3C7E547C756477F38A4341D86E2259F1F7417D21587,6:1343B54480349D8807FC9AC0A886F4B30446F76346507CA2FB5A0C3A0521F737,7:6AA8096FA263FA2306B2C14298FD3C824FC8AB032176FE2A6CA85BDB9759F5EE,8:10537DB6C5CFC902A6FB05D2A0D94CF5087C4F31CC29D5A7320AD533C4679911,9:AB5EFD42759CA622AF94ADF875E082C6DADEB2C22DA43C35C01DF9C431C6BFBB
+[pmw] end pid=165537 exit=0 ended_at=2026-09-28T20:15:43Z
diff --git a/artifacts/perf-multiworld/20260928T195839Z/control-n1.log b/artifacts/perf-multiworld/20260928T195839Z/control-n1.log
new file mode 100644
index 0000000..88fe297
--- /dev/null
+++ b/artifacts/perf-multiworld/20260928T195839Z/control-n1.log
@@ -0,0 +1,13 @@
+multiworld_start worlds=1 days=20 npcs=30 sample_every_days=2 seed_base=42 ticks_per_day=5184000
+multiworld_sample worlds=1 day=0/20 events=0 rumors=0 annals=0 memory_entries=0 gc_live_mb=0.09 working_set_rss_mb=38.83 elapsed_s=0.0
+multiworld_sample worlds=1 day=2/20 events=0 rumors=3921 annals=128 memory_entries=1920 gc_live_mb=0.85 working_set_rss_mb=57.19 elapsed_s=34.0
+multiworld_sample worlds=1 day=4/20 events=0 rumors=7843 annals=128 memory_entries=1920 gc_live_mb=1.37 working_set_rss_mb=61.71 elapsed_s=68.1
+multiworld_sample worlds=1 day=6/20 events=0 rumors=7849 annals=128 memory_entries=1920 gc_live_mb=1.38 working_set_rss_mb=63.63 elapsed_s=101.9
+multiworld_sample worlds=1 day=8/20 events=0 rumors=7925 annals=128 memory_entries=1920 gc_live_mb=1.39 working_set_rss_mb=64.29 elapsed_s=135.8
+multiworld_sample worlds=1 day=10/20 events=0 rumors=7723 annals=128 memory_entries=1920 gc_live_mb=1.37 working_set_rss_mb=64.57 elapsed_s=169.6
+multiworld_sample worlds=1 day=12/20 events=0 rumors=7727 annals=128 memory_entries=1920 gc_live_mb=1.37 working_set_rss_mb=64.92 elapsed_s=203.6
+multiworld_sample worlds=1 day=14/20 events=0 rumors=8038 annals=128 memory_entries=1920 gc_live_mb=1.41 working_set_rss_mb=67.88 elapsed_s=237.2
+multiworld_sample worlds=1 day=16/20 events=0 rumors=7953 annals=128 memory_entries=1920 gc_live_mb=1.40 working_set_rss_mb=67.88 elapsed_s=271.2
+multiworld_sample worlds=1 day=18/20 events=0 rumors=7901 annals=128 memory_entries=1920 gc_live_mb=1.39 working_set_rss_mb=67.89 elapsed_s=305.2
+multiworld_sample worlds=1 day=20/20 events=0 rumors=7932 annals=128 memory_entries=1920 gc_live_mb=1.39 working_set_rss_mb=67.94 elapsed_s=339.0
+multiworld_done worlds=1 day=20 elapsed_s=339.1 world_digests=0:2364CB74F5FCA34503269F413F7184F455006C9975EB01B11219D25A3A33FDD2
diff --git a/artifacts/perf-multiworld/20260928T195839Z/state.json b/artifacts/perf-multiworld/20260928T195839Z/state.json
new file mode 100644
index 0000000..3ead223
--- /dev/null
+++ b/artifacts/perf-multiworld/20260928T195839Z/state.json
@@ -0,0 +1,16 @@
+{
+ "commit": "2c559a7",
+ "ended_at": "2026-09-28T20:15:43Z",
+ "exit": 0,
+ "log": "/home/somhairle/projects/living-village/artifacts/perf-multiworld/20260928T195839Z/acceptance.log",
+ "params": {
+ "days": 20,
+ "npcs": 30,
+ "sample_every_days": 2,
+ "seed_base": 42,
+ "worlds": 10
+ },
+ "pid": 165537,
+ "started_at": "2026-09-28T19:58:39Z",
+ "unit": "living-village-multiworld.service"
+}