|
{"version": 2, "width": 120, "height": 50, "timestamp": 1779593446, "env": {"SHELL": "/bin/bash", "TERM": "xterm-256color"}, "title": "Canonical MCP level-up flow evidence"} |
|
[0.198664, "o", "━━━━━━━ 1. GIT PROVENANCE ━━━━━━━\r\n"] |
|
[0.212074, "o", "HEAD SHA: 1b6b29797c28ad0a25ef7161c4e229f916a65c83\r\n"] |
|
[0.223854, "o", "Branch: pr6958-zfc-evidence-followups\r\n"] |
|
[0.2463, "o", "Merge-base vs main: e6ab5b1cbabcb98b7230ec21cc2699b98154595a\r\n"] |
|
[0.259635, "o", "Commits ahead of main: 23\r\n"] |
|
[0.259733, "o", "\r\n━━━━━━━ 2. COMMIT LOG ━━━━━━━\r\n"] |
|
[0.420406, "o", "\u001b[?1h\u001b=\r"] |
|
[0.42051, "o", "\u001b[33m1b6b29797\u001b[m\u001b[33m (\u001b[m\u001b[1;36mHEAD -> \u001b[m\u001b[1;32mpr6958-zfc-evidence-followups\u001b[m\u001b[33m, \u001b[m\u001b[1;31morigin/pr6958-zfc-evidence-followups\u001b[m\u001b[33m)\u001b[m [antig] fix(ci): resolve server \u001b[m \b\u001b[33m\u001b[m\u001b[33m\u001b[m\u001b[1;36m\u001b[m\u001b[1;32m\u001b[m\u001b[33m\u001b[m\u001b[1;31m\u001b[m\u001b[33m\u001b[mcache GHA mock collision and update prompt contract hash\u001b[m\r\n\u001b[33mf2d0342e1\u001b[m fix(rewards_engine): authorize MODE_LEVEL_UP/GOD/CHARACTER_CREATION in level mutation guards\u001b[m\r\n\u001b[33mcea202444\u001b[m fix(level-up): resolve stale completed loop, sync front-end exit IDs, and fix stream retries\u001b[m\r\n\u001b[33m3c310152f\u001b[m\u001b[33m (\u001b[m\u001b[1;32msubagent-Bugbot-Issue-Fixer-self-b385061e\u001b[m\u001b[33m)\u001b[m Bugbot Fixes: Resolve choiceId undefined and RewardsAgent skip str\u001b[m \b\u001b[33m\u001b[m\u001b[33m\u001b[m\u001b[1;32m\u001b[m\u001b[33m\u001b[mand level_up_available\u001b[m\r\n\u001b[33m46b00561f\u001b[m prompt(level-up): add compact DnD 5e mechanical superset guardrails\u001b[m\r\n\u001b[33meeb1135bf\u001b[m fix(level-up): harden gist URL validation, first-turn modal detection, and prompt contract sync\u001b[m\r\n"] |
|
[0.420773, "o", "\u001b[33mbe6b6e69b\u001b[m feat(code-standards): add thermo-nuclear review as 4th adversarial lane\u001b[m\r\n"] |
|
[0.421546, "o", "\u001b[33m939d8b9e5\u001b[m refactor(world_logic): extract _detect_first_turn_lu_modal, rename local\u001b[m\r\n"] |
|
[0.422296, "o", "\u001b[33m610139762\u001b[m Add PR7048 roadmap handoff\u001b[m\r\n"] |
|
[0.423398, "o", "\u001b[33me72a31016\u001b[m Close registered level-up adjuster beads\u001b[m\r\n"] |
|
[0.424734, "o", "\u001b[33m9f54b9cec\u001b[m Register level-up adjuster ledger\u001b[m\r\n"] |
|
[0.425561, "o", "\u001b[33me6a0d1800\u001b[m fix(frontend): sync MODAL_EXIT_IDS with backend canonical sets\u001b[m\r\n"] |
|
[0.426555, "o", "\u001b[33m26a562a63\u001b[m fix(level-up): bead feedback rev-7b4ft/rev-fvjkb/routing fixes\u001b[m\r\n"] |
|
[0.428314, "o", "\u001b[33ma6bb98453\u001b[m fix(level-up): address CodeRabbit P1/Major review items\u001b[m\r\n"] |
|
[0.428735, "o", "\u001b[33mb5e9bdda5\u001b[m Clarify level-up choice payload bead\u001b[m\r\n"] |
|
[0.429524, "o", "\u001b[33m0df375c7b\u001b[m Add --dest-email to copy_campaign.py; use email in repro SKILL.md\u001b[m\r\n\u001b[33me75f32874\u001b[m fix(level-up): block rewards_pending re-creation when level_up_complete=True with no new XP\u001b[m\r\n"] |
|
[0.430361, "o", "\u001b[33m428d9e6ed\u001b[m fix(prompt): add D&D 5e mechanical coverage + anti-self-commit rule + dedup ownership\u001b[m\r\n"] |
|
[0.431623, "o", "\u001b[33m3321b4a5c\u001b[m fix(frontend): submit CHOICE:<id> for level-up mechanic choices not display text\u001b[m\r\n"] |
|
[0.432363, "o", "\u001b[33m9148e22ff\u001b[m Track PR6958 level-up follow-ups\u001b[m\r\n"] |
|
[0.433539, "o", "\u001b[33m30d64880e\u001b[m fix(level-up): inject finish choice on first modal turn when mechanic choices present\u001b[m\r\n"] |
|
[0.434381, "o", "\u001b[33m54a22be21\u001b[m Beads: track PR6958 ZFC follow-up audit\u001b[m\r\n"] |
|
[0.435342, "o", "\u001b[33m9db8cc15f\u001b[m Adjustment registry: track evidence gist URLs\u001b[m\r\n"] |
|
[0.436053, "o", "\r\u001b[K\u001b[?1l\u001b>"] |
|
[0.437904, "o", "\r\n"] |
|
[0.437962, "o", "━━━━━━━ 3. CODE DIFF STAT ━━━━━━━\r\n"] |
|
[0.460778, "o", "\u001b[?1h\u001b=\r"] |
|
[0.517618, "o", " .beads/issues.jsonl | 13 \u001b[32m+\u001b[m\u001b[m\r\n .claude/skills/code-standards/SKILL.md | 14 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n .claude/skills/repro-twin-clone-evidence/SKILL.md | 14 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/agents.py | 37 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/backend_adjustment_registry.py | 867 \u001b[32m+++++++++++++++++++++++++++++++++++++++++\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/frontend_v1/app.js | 33 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/game_state.py | 39 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/llm_service.py | 110 \u001b[32m++++++\u001b[m\u001b[m\r\n mvp_site/prompts/level_up_instruction.md | 37 \u001b[32m++\u001b[m\u001b[m\r\n mvp_site/prompts/planning_protocol.md | 24 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_"] |
|
[0.517739, "o", "site/rewards_engine.py | 14 \u001b[32m+\u001b[m\u001b[m\r\n mvp_site/schemas/prompt_tool_contracts.json | 4 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/tests/frontend/test_app_js_structured_fields.js | 2 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/tests/test_agent_routing_with_state_validation.py | 2 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/tests/test_backend_adjustment_registry.py | 93 \u001b[32m++++\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/tests/test_llm_service_context.py | 15 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n mvp_site/tests/test_rewards_engine.py | 67 \u001b[32m++++\u001b[m\u001b[m\r\n mvp_site/tests/test_world_logic.py | 421 \u001b[32m++++++++++++++++++++\u001b[m\u001b[m\r\n mvp_site/world_logic.py | 94 \u001b[32m++++\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n roadmap/README.md | 1 \u001b[32m+\u001b[m\u001b[m\r\n roadmap/nextsteps-2026-05-24-pr6958-"] |
|
[0.517798, "o", "adjuster-registration.md | 126 \u001b[32m++++++\u001b[m\u001b[m\r\n roadmap/nextsteps-2026-05-24-pr7048-location-centralization-review.md | 72 \u001b[32m++++\u001b[m\u001b[m\r\n scripts/copy_campaign.py | 9 \u001b[32m+\u001b[m\u001b[m\r\n testing_mcp/lib/base_test.py | 32 \u001b[32m+\u001b[m\u001b[31m-\u001b[m\u001b[m\r\n testing_mcp/lib/llm_response_cache/prompt_fingerprint.py | 5 \u001b[32m+\u001b[m\u001b[m\r\n testing_mcp/lib/llm_response_cache/server_cache.py | 236 \u001b[32m++++++++++++\u001b[m\u001b[m\r\n 26 files changed, 2267 insertions(+), 114 deletions(-)\u001b[m\r\n"] |
|
[0.518097, "o", "\r\u001b[K\u001b[?1l\u001b>"] |
|
[0.519609, "o", "\r\n"] |
|
[0.519656, "o", "━━━━━━━ 4. LIVE TEST EXECUTION ━━━━━━━\r\n"] |
|
[0.757808, "o", "2026-05-23 20:30:47,192 - root - INFO - Unified logging configured: /var/folders/j0/byd1z6px50v88lf679bgt0h00000gn/T/worldarchitect.ai/pr6958-zfc-evidence-followups/app.log\r\n"] |
|
[1.086653, "o", "2026-05-23 20:30:47,521 - root - INFO - Applied clock skew patch: adjusting time by -720 seconds\r\n"] |
|
[1.605364, "o", "2026-05-23 20:30:48,040 - root - INFO - Loading service account from file: /Users/jleechan/serviceAccountKey.json\r\n"] |
|
[1.605552, "o", "2026-05-23 20:30:48,040 - root - INFO - ✅ Successfully loaded credentials from file: /Users/jleechan/serviceAccountKey.json\r\n"] |
|
[1.605635, "o", "2026-05-23 20:30:48,040 - root - INFO - Successfully loaded service account credentials\r\n"] |
|
[1.652697, "o", "2026-05-23 20:30:48,087 - root - INFO - Firebase initialized successfully in world_logic.py\r\n"] |
|
[1.770158, "o", "======================================================================\r\nTEST LEVEL UP ORGANIC\r\n======================================================================\r\nWork name: test_level_up_organic\r\nModel: gemini-3-flash-preview\r\n======================================================================"] |
|
[1.770195, "o", "\r\n"] |
|
[1.800125, "o", "📁 Evidence directory: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic\r\n Evidence will be saved to: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_XXX/\r\n"] |
|
[1.816794, "o", "📁 Base evidence directory (forced branch-scoped /tmp): /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic\r\n"] |
|
[1.818908, "o", "Created iteration directory for evidence: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n"] |
|
[1.873029, "o", "\r\n🚀 Starting fresh local MCP server on port 8074...\r\n"] |
|
[15.399103, "o", "✅ Server ready at http://127.0.0.1:8074\r\n"] |
|
[15.931883, "o", "Tmux video recording started for evidence bundle.\r\n"] |
|
[15.934301, "o", "2026-05-23 20:31:02,369 - root - INFO - 🧠 CLASSIFIER: Loading embedding model BAAI/bge-small-en-v1.5...\r\n"] |
|
[16.030201, "o", "2026-05-23 20:31:02,465 - root - INFO - 🧠 CLASSIFIER: Computing anchor embeddings...\r\n"] |
|
[16.38427, "o", "2026-05-23 20:31:02,819 - root - INFO - 🧠 CLASSIFIER: Ready for inference (succeeded on attempt 1).\r\n"] |
|
[16.387432, "o", "2026-05-23 20:31:02,822 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='finish level up' -> matched=True (score=1.000) | ⏱️ Latency: 3.02ms\r\n"] |
|
[16.390777, "o", "2026-05-23 20:31:02,826 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='finish the level-up' -> matched=True (score=1.000) | ⏱️ Latency: 3.22ms\r\n"] |
|
[16.393756, "o", "2026-05-23 20:31:02,829 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='complete level up' -> matched=True (score=1.000) | ⏱️ Latency: 2.94ms\r\n"] |
|
[16.396903, "o", "2026-05-23 20:31:02,832 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='done with level up' -> matched=True (score=1.000) | ⏱️ Latency: 3.02ms\r\n"] |
|
[16.40004, "o", "2026-05-23 20:31:02,835 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='wrap up the level up' -> matched=True (score=0.930) | ⏱️ Latency: 3.03ms\r\n"] |
|
[16.403347, "o", "2026-05-23 20:31:02,838 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='return to game after level up' -> matched=True (score=0.950) | ⏱️ Latency: 3.20ms\r\n"] |
|
[16.406401, "o", "2026-05-23 20:31:02,841 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='choose a feat' -> matched=False (score=0.637) | ⏱️ Latency: 2.81ms\r\n"] |
|
[16.409166, "o", "2026-05-23 20:31:02,844 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='choose fighting style' -> matched=False (score=0.550) | ⏱️ Latency: 2.84ms\r\n"] |
|
[16.412401, "o", "2026-05-23 20:31:02,847 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='increase my hp' -> matched=False (score=0.657) | ⏱️ Latency: 3.13ms\r\n"] |
|
[16.415387, "o", "2026-05-23 20:31:02,850 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='roll for hit points' -> matched=False (score=0.631) | ⏱️ Latency: 2.86ms\r\n"] |
|
[16.418912, "o", "2026-05-23 20:31:02,854 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='what level do I get fireball' -> matched=False (score=0.716) | ⏱️ Latency: 3.35ms\r\n"] |
|
[16.422304, "o", "2026-05-23 20:31:02,857 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='when do I level up' -> matched=False (score=0.851) | ⏱️ Latency: 3.34ms\r\n"] |
|
[16.425557, "o", "2026-05-23 20:31:02,861 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='how close am I to leveling up' -> matched=False (score=0.827) | ⏱️ Latency: 3.16ms\r\n"] |
|
[16.428378, "o", "2026-05-23 20:31:02,863 - root - INFO - 🧠 LEVEL_UP_EXIT_CLASSIFIER: Input='continue the story after level...' -> matched=False (score=0.846) | ⏱️ Latency: 2.75ms\r\n"] |
|
[18.075219, "o", "2026-05-23 20:31:04,510 - root - INFO - llm_response_cache MISS: user_input='I want to create my character' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[28.529457, "o", "2026-05-23 20:31:14,964 - root - INFO - llm_response_cache process_action total_ms=10454 user_input='I want to create my character'\r\n2026-05-23 20:31:14,965 - root - INFO - llm_response_cache MISS: user_input='I want to use the Standard D&D method.' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[46.383336, "o", "2026-05-23 20:31:32,818 - root - INFO - llm_response_cache process_action total_ms=17853 user_input='I want to use the Standard D&D method.'\r\n"] |
|
[46.383901, "o", "2026-05-23 20:31:32,819 - root - INFO - llm_response_cache MISS: user_input='Human' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[60.567884, "o", "2026-05-23 20:31:47,003 - root - INFO - llm_response_cache process_action total_ms=14184 user_input='Human'\r\n2026-05-23 20:31:47,004 - root - INFO - llm_response_cache MISS: user_input='Paladin' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[76.463871, "o", "2026-05-23 20:32:02,888 - root - INFO - llm_response_cache process_action total_ms=15872 user_input='Paladin'\r\n2026-05-23 20:32:02,896 - root - INFO - llm_response_cache MISS: user_input='Use Standard Array - STR 15, DEX 10, CON 14, INT 8, WIS 12, ' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[108.820219, "o", "2026-05-23 20:32:35,256 - root - INFO - llm_response_cache process_action total_ms=32360 user_input='Use Standard Array - STR 15, DEX 10, CON 14, INT 8, WIS 12, '\r\n"] |
|
[108.821558, "o", "2026-05-23 20:32:35,257 - root - INFO - llm_response_cache MISS: user_input=\"My character's name is Mira.\" mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[119.188199, "o", "2026-05-23 20:32:45,624 - root - INFO - llm_response_cache process_action total_ms=10367 user_input=\"My character's name is Mira.\"\r\n"] |
|
[119.189026, "o", "2026-05-23 20:32:45,625 - root - INFO - llm_response_cache MISS: user_input='Noble background.' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[134.254363, "o", "2026-05-23 20:33:00,688 - root - INFO - llm_response_cache process_action total_ms=15063 user_input='Noble background.'\r\n2026-05-23 20:33:00,690 - root - INFO - llm_response_cache MISS: user_input='CHOICE:finish_character_creation_start_game' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[159.260605, "o", "2026-05-23 20:33:25,693 - root - INFO - llm_response_cache process_action total_ms=25001 user_input='CHOICE:finish_character_creation_start_game'\r\n"] |
|
[159.88276, "o", "2026-05-23 20:33:26,320 - root - INFO - llm_response_cache MISS: user_input='GOD MODE: This campaign is an accelerated training gauntlet.' mode=god hits=0 misses=0 lookup_ms=0\r\n"] |
|
[172.189367, "o", "2026-05-23 20:33:38,625 - root - INFO - llm_response_cache process_action total_ms=12305 user_input='GOD MODE: This campaign is an accelerated training gauntlet.'\r\n"] |
|
[172.76351, "o", "2026-05-23 20:33:39,201 - root - INFO - llm_response_cache MISS: user_input='I take the next demanding gauntlet challenge and roll whatev' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[198.960469, "o", "2026-05-23 20:34:05,397 - root - INFO - llm_response_cache process_action total_ms=26196 user_input='I take the next demanding gauntlet challenge and roll whatev'\r\n"] |
|
[199.294826, "o", "2026-05-23 20:34:05,733 - root - INFO - llm_response_cache MISS: user_input='I take the next demanding gauntlet challenge and roll whatev' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[237.298038, "o", "2026-05-23 20:34:43,732 - root - INFO - llm_response_cache process_action total_ms=37998 user_input='I take the next demanding gauntlet challenge and roll whatev'\r\n"] |
|
[237.632288, "o", "2026-05-23 20:34:44,070 - root - INFO - llm_response_cache MISS: user_input='CHOICE:level_up_now' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[256.194041, "o", "2026-05-23 20:35:02,631 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[256.504585, "o", "2026-05-23 20:35:02,943 - root - INFO - llm_response_cache process_action total_ms=18872 user_input='CHOICE:level_up_now'\r\n"] |
|
[256.812634, "o", "2026-05-23 20:35:03,251 - root - INFO - llm_response_cache MISS: user_input='Change my recommended fighting style to Dueling, keep every ' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[273.623726, "o", "2026-05-23 20:35:20,062 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[273.837917, "o", "2026-05-23 20:35:20,277 - root - INFO - llm_response_cache process_action total_ms=17025 user_input='Change my recommended fighting style to Dueling, keep every '\r\n"] |
|
[274.074273, "o", "2026-05-23 20:35:20,513 - root - INFO - llm_response_cache MISS: user_input='I try to leave the level-up modal and continue the adventure' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[287.490921, "o", "2026-05-23 20:35:33,929 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[287.762277, "o", "2026-05-23 20:35:34,201 - root - INFO - llm_response_cache process_action total_ms=13688 user_input='I try to leave the level-up modal and continue the adventure'\r\n"] |
|
[288.098852, "o", "2026-05-23 20:35:34,538 - root - INFO - llm_response_cache MISS: user_input='CHOICE:level_up_fighting_style_defense' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[300.858945, "o", "2026-05-23 20:35:47,298 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[301.232981, "o", "2026-05-23 20:35:47,672 - root - INFO - llm_response_cache process_action total_ms=13135 user_input='CHOICE:level_up_fighting_style_defense'\r\n"] |
|
[301.53346, "o", "2026-05-23 20:35:47,973 - root - INFO - llm_response_cache MISS: user_input='CHOICE:level_up_fighting_style_dueling' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[317.755883, "o", "2026-05-23 20:36:04,194 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[318.146903, "o", "2026-05-23 20:36:04,586 - root - INFO - llm_response_cache process_action total_ms=16613 user_input='CHOICE:level_up_fighting_style_dueling'\r\n"] |
|
[318.369403, "o", "2026-05-23 20:36:04,809 - root - INFO - llm_response_cache MISS: user_input='CHOICE:finish_level_up_return_to_game' mode=character hits=0 misses=0 lookup_ms=0\r\n"] |
|
[351.234974, "o", "2026-05-23 20:36:37,670 - campaign_utils - WARNING - LLM omitted world_events on living world turn 3. Attempting Firestore fallback. If fallback fails, invariant check will flag this.\r\n"] |
|
[351.562003, "o", "2026-05-23 20:36:38,002 - root - INFO - llm_response_cache process_action total_ms=33192 user_input='CHOICE:finish_level_up_return_to_game'\r\n"] |
|
[355.079429, "o", " ✅ Captured campaign snapshot for avafxHQ5\r\n"] |
|
[355.138232, "o", "Tmux video artifact finalized (.cast).\r\n"] |
|
[355.858638, "o", "\r\n================================================================================\r\n📦 EVIDENCE BUNDLE CREATED\r\n================================================================================\r\n📁 Evidence Directory:\r\n /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n\r\n📋 Bundle Metadata:\r\n Run ID: test_level_up_organic-008-20260524T033641\r\n Iteration: 8\r\n Bundle Version: 1.2.0\r\n 📁 Evidence directory: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n 📁 Latest iteration: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n\r\n📥 Downloading 1 test campaigns (workers=1)...\r\n"] |
|
[360.082366, "o", "Downloading to: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008/campaigns\r\nFormat: txt\r\n============================================================\r\nDownloading: avafxHQ50msKBdKQKmI5...\r\n Saved story: Organic Level-Up Progression Test_avafxHQ5.txt\r\n Saved game state: Organic Level-Up Progression Test_avafxHQ5_game_state.json\r\n Entries: 36, Story size: 24.6 KB, Game state size: 9.7 KB\r\n============================================================\r\nDownloaded 1/1 campaigns\r\n stderr: 2026-05-23 20:36:42,506 - root - INFO - Unified logging configured: /var/folders/j0/byd1z6px50v88lf679bgt0h00000gn/T/worldarchitect.ai/pr6958-zfc-evidence-followups/app.log\r\n stderr: 2026-05-23 20:36:42,506 - root - INFO - Applied clock skew patch: adjusting time by -720 seconds\r\n stderr: 2026-05-23 20:36:43,573 - root - INFO - Firebase not initialized - attempting to initialize now\r\n stderr: 2026-05-23 20:36:43,574 - root - INFO - Loading service account from file: /Users/jleechan/ser"] |
|
[360.082901, "o", "viceAccountKey.json\r\n stderr: 2026-05-23 20:36:43,575 - root - INFO - ✅ Successfully loaded credentials from file: /Users/jleechan/serviceAccountKey.json\r\n stderr: 2026-05-23 20:36:43,575 - root - INFO - Successfully loaded service account credentials\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 📖 FETCHED STORY ENTRIES: user=test-test_level_up_organic-1779593448, campaign=avafxHQ50msKBdKQKmI5, total_entries=36\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 📊 STORY BREAKDOWN: user_entries=18, ai_entries=18, other_entries=0\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 🔍 RECENT ENTRIES (last 5):\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 1. [gemini] character | Midday (12:15:00) at the Sparring Floor I—the divi... | 2026-05-24 03:35:46.698357+00:00\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 2. [user] character | Change Fighting Style: Dueling - Switch back to th... | 2026-05-24 03:36:03.049206+00:00\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 3. [gemini"] |
|
[360.08312, "o", "] character | Midday (12:15:00) at the Sparring Floor I—the radi... | 2026-05-24 03:36:03.394854+00:00\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 4. [user] character | Apply Recommended Options and Return to Game - Fin... | 2026-05-24 03:36:36.424193+00:00\r\n stderr: 2026-05-23 20:36:44,164 - root - INFO - 5. [gemini] character | The golden embers swirling around you finally coal... | 2026-05-24 03:36:36.861885+00:00\r\n stderr: 2026-05-23 20:36:44,339 - root - WARNING - ⚠️ ⚠️ COMBAT_STATE_MISMATCH: combatants has keys not in initiative_order: {'npc_construct_beta_001', 'pc_mira_001'}. These combatants won't have a turn.\r\n ✅ Downloaded campaign avafxHQ5... (36 entries)\r\n ✅ Downloaded campaign avafxHQ5... (36 entries, user_id=test-test_level_up_organic-1779593448)\r\n📦 Downloaded 1/1 campaigns to:\r\n /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008/campaigns\r\n"] |
|
[360.084526, "o", "ℹ️ Reconciled campaign_capture_status with exported campaign artifacts.\r\n"] |
|
[360.086049, "o", "\r\n================================================================================\r\n✅ TEST EVIDENCE SUMMARY\r\n================================================================================\r\n📁 Evidence Location: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n"] |
|
[360.086068, "o", "📥 Campaigns Location: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008/campaigns\r\n"] |
|
[360.086152, "o", "🔗 Latest Symlink: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/latest\r\n================================================================================\r\n\r\n"] |
|
[360.094188, "o", "📎 Iteration artifact captured: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008/scenario_results_checkpoint.json\r\n"] |
|
[360.095093, "o", "📁 Final evidence iteration directory: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008\r\n"] |
|
[360.110207, "o", "\r\n======================================================================\r\nSUMMARY\r\n======================================================================\r\nTotal scenarios: 3\r\nPassed: 3\r\nFailed: 0\r\nPass rate: 3/3 (100%)\r\n\r\n📦 Evidence bundle created: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic\r\n Files: 22 with checksums\r\n"] |
|
[360.110709, "o", "📝 Console output saved: /tmp/worldarchitect.ai/pr6958-zfc-evidence-followups/test_level_up_organic/iteration_008/test_console_output.txt\r\n\r\nStopping local server...\r\n"] |
|
[363.741838, "o", "\r\n"] |
|
[363.741983, "o", "━━━━━━━ 5. POST-TEST SHA VERIFICATION ━━━━━━━\r\n"] |
|
[363.75459, "o", "Pre-test SHA: 1b6b29797c28ad0a25ef7161c4e229f916a65c83\r\nPost-test SHA: 1b6b29797c28ad0a25ef7161c4e229f916a65c83\r\nSHA MATCH\r\n"] |