:54.973Z [DEBUG] [API:request] Creating client, ANTHROPIC_CUSTOM_HEADERS present: false, has Authorization header: false
2026-02-20T14:30:54.973Z [DEBUG] [API:auth] OAuth token check starting
2026-02-20T14:30:54.974Z [DEBUG] [API:auth] OAuth token check complete
2026-02-20T14:30:54.979Z [DEBUG] Writing to temp file: /home/josie/.claude.json.tmp.70456.1771597854979
2026-02-20T14:30:54.979Z [DEBUG] Preserving file permissions: 100644
2026-02-20T14:30:54.979Z [DEBUG] Temp file written successfully, size: 140581 bytes
2026-02-20T14:30:54.979Z [DEBUG] Applied original permissions to temp file
2026-02-20T14:30:54.979Z [DEBUG] Renaming /home/josie/.claude.json.tmp.70456.1771597854979 to /home/josie/.claude.json
2026-02-20T14:30:54.979Z [DEBUG] File /home/josie/.claude.json written atomically
2026-02-20T14:30:54.982Z [DEBUG] Tool search disabled via experiment (tengu_tst_kx7): below threshold, deferred tools present [source: query]
2026-02-20T14:30:54.986Z [DEBUG] Writing to temp file: /home/josie/.claude.json.tmp.70456.1771597854986
2026-02-20T14:30:54.986Z [DEBUG] Preserving file permissions: 100644
2026-02-20T14:30:54.986Z [DEBUG] Temp file written successfully, size: 140581 bytes
2026-02-20T14:30:54.986Z [DEBUG] Applied original permissions to temp file
2026-02-20T14:30:54.986Z [DEBUG] Renaming /home/josie/.claude.json.tmp.70456.1771597854986 to /home/josie/.claude.json
2026-02-20T14:30:54.988Z [DEBUG] File /home/josie/.claude.json written atomically
2026-02-20T14:30:54.992Z [DEBUG] attribution header x-anthropic-billing-header: cc_version=2.1.49.994; cc_entrypoint=cli; cch=00000;
2026-02-20T14:30:54.992Z [DEBUG] [API:request] Creating client, ANTHROPIC_CUSTOM_HEADERS present: false, has Authorization header: false
2026-02-20T14:30:54.992Z [DEBUG] [API:auth] OAuth token check starting
2026-02-20T14:30:54.992Z [DEBUG] [API:auth] OAuth token check complete
2026-02-20T14:30:55.002Z [DEBUG] MCP server "ide": Tool 'closeAllDiffTabs' completed successfully in 31ms
2026-02-20T14:30:55.003Z [DEBUG] [useDeferredValue] Messages deferred by 3 (361→364)
2026-02-20T14:30:55.584Z [DEBUG] Stream started - received first chunk
2026-02-20T14:30:58.778Z [DEBUG] Stream started - received first chunk
2026-02-20T14:30:58.783Z [DEBUG] [useDeferredValue] Messages deferred by 1 (364→365)
2026-02-20T14:30:58.790Z [DEBUG] [useDeferredValue] Messages deferred by 1 (364→365)
2026-02-20T14:30:59.583Z [DEBUG] [useDeferredValue] Messages deferred by 1 (365→366)
2026-02-20T14:30:59.587Z [DEBUG] [useDeferredValue] Messages deferred by 1 (365→366)
2026-02-20T14:31:00.034Z [DEBUG] [useDeferredValue] Messages deferred by 1 (366→367)
2026-02-20T14:31:00.039Z [DEBUG] [useDeferredValue] Messages deferred by 1 (366→367)
2026-02-20T14:31:00.212Z [DEBUG] High write ratio: blit=0, write=77357 (100.0% writes), screen=1204x113
2026-02-20T14:31:01.544Z [DEBUG] executePreToolHooks called for tool: Edit
2026-02-20T14:31:01.545Z [DEBUG] Getting matching hook commands for PreToolUse with query: Edit
2026-02-20T14:31:01.545Z [DEBUG] Found 1 hook matchers in settings
2026-02-20T14:31:01.545Z [DEBUG] Matched 1 unique hooks for query "Edit" (1 before deduplication)
2026-02-20T14:31:01.549Z [DEBUG] [useDeferredValue] Messages deferred by 1 (367→368)
2026-02-20T14:31:01.701Z [DEBUG] High write ratio: blit=0, write=77357 (100.0% writes), screen=1204x113
2026-02-20T14:31:01.705Z [DEBUG] Hooks: Checking initial response for async: {}
2026-02-20T14:31:01.705Z [DEBUG] Hooks: Parsed initial response: {}
2026-02-20T14:31:01.705Z [DEBUG] Hooks: Initial response is not async, continuing normal processing
2026-02-20T14:31:01.706Z [DEBUG] [useDeferredValue] Messages deferred by 2 (367→369)
2026-02-20T14:31:01.717Z [DEBUG] Successfully parsed and validated hook JSON output
2026-02-20T14:31:01.717Z [DEBUG] Hook PreToolUse:Edit (PreToolUse) success:
{}
2026-02-20T14:31:01.719Z [DEBUG] Permission suggestions for Edit: [
  {
    "type": "setMode",
    "mode": "acceptEdits",
    "destination": "session"
  }
]
2026-02-20T14:31:01.720Z [DEBUG] executePermissionRequestHooks called for tool: Edit
2026-02-20T14:31:01.721Z [DEBUG] Getting matching hook commands for PermissionRequest with query: Edit
2026-02-20T14:31:01.721Z [DEBUG] Found 0 hook matchers in settings
2026-02-20T14:31:01.721Z [DEBUG] Matched 0 unique hooks for query "Edit" (0 before deduplication)
2026-02-20T14:31:01.725Z [DEBUG] [useDeferredValue] Messages deferred by 2 (367→369)
2026-02-20T14:31:01.741Z [DEBUG] MCP server "ide": Calling MCP tool: openDiff
2026-02-20T14:31:01.742Z [DEBUG] [useDeferredValue] Messages deferred by 2 (367→369)
2026-02-20T14:31:13.745Z [DEBUG] Getting matching hook commands for Notification with query: permission_prompt
2026-02-20T14:31:13.745Z [DEBUG] Found 0 hook matchers in settings
2026-02-20T14:31:13.745Z [DEBUG] Matched 0 unique hooks for query "permission_prompt" (0 before deduplication)
2026-02-20T14:31:31.741Z [DEBUG] MCP server "ide": Tool 'openDiff' still running (30s elapsed)
2026-02-20T14:31:31.890Z [DEBUG] MCP server "ide": Calling MCP tool: close_tab
2026-02-20T14:31:31.891Z [DEBUG] Aborting: tool=Edit isAbort=undefined hasFeedback=false isSubagent=false
2026-02-20T14:31:31.891Z [DEBUG] MCP server "ide": Calling MCP tool: close_tab
2026-02-20T14:31:31.891Z [DEBUG] Edit tool permission denied
2026-02-20T14:31:31.893Z [DEBUG] MCP server "ide": Tool 'openDiff' completed successfully in 30s
2026-02-20T14:31:31.893Z [DEBUG] MCP server "ide": Calling MCP tool: close_tab
2026-02-20T14:31:31.894Z [DEBUG] [useDeferredValue] Messages deferred by 2 (369→371)
2026-02-20T14:31:31.912Z [DEBUG] AutoUpdaterWrapper: Installation type: npm-global
2026-02-20T14:31:31.912Z [DEBUG] MCP server "ide": Tool 'close_tab' completed successfully in 22ms
2026-02-20T14:31:31.937Z [DEBUG] MCP server "ide": Tool 'close_tab' completed successfully in 46ms
2026-02-20T14:31:31.937Z [DEBUG] MCP server "ide": Tool 'close_tab' completed successfully in 44ms
2026-02-20T14:31:50.622Z [DEBUG] MCP server "ide": Calling MCP tool: getDiagnostics
2026-02-20T14:31:50.622Z [DEBUG] LSP Diagnostics: getLSPDiagnosticAttachments called
2026-02-20T14:31:50.622Z [DEBUG] LSP Diagnostics: Checking registry - 0 pending
2026-02-20T14:31:50.622Z [DEBUG] Hooks: Found 0 total hooks in registry
2026-02-20T14:31:50.622Z [DEBUG] Hooks: checkForNewResponses returning 0 responses
2026-02-20T14:31:50.630Z [DEBUG] MCP server "ide": Tool 'getDiagnostics' completed successfully in 8ms
2026-02-20T14:31:50.632Z [DEBUG] Getting matching hook commands for UserPromptSubmit with query: undefined
2026-02-20T14:31:50.632Z [DEBUG] Found 1 hook matchers in settings
2026-02-20T14:31:50.632Z [DEBUG] Matched 1 unique hooks for query "no match query" (1 before deduplication)
2026-02-20T14:31:50.664Z [DEBUG] Hooks: Checking initial response for async: {}
2026-02-20T14:31:50.664Z [DEBUG] Hooks: Parsed initial response: {}
2026-02-20T14:31:50.664Z [DEBUG] Hooks: Initial response is not async, continuing normal processing
2026-02-20T14:31:50.669Z [DEBUG] Successfully parsed and validated hook JSON output
2026-02-20T14:31:50.670Z [DEBUG] Hook UserPromptSubmit (UserPromptSubmit) success:
{}
2026-02-20T14:31:50.670Z [DEBUG] FileHistory: Making snapshot for message 781f6132-f085-4730-be51-a5176a2bcd52
2026-02-20T14:31:50.670Z [DEBUG] FileHistory: Added snapshot for 781f6132-f085-4730-be51-a5176a2bcd52, tracking 11 files
2026-02-20T14:31:50.671Z [DEBUG] [useDeferredValue] Messages deferred by 3 (371→374)
2026-02-20T14:31:50.835Z [DEBUG] High write ratio: blit=0, write=77923 (100.0% writes), screen=1212x113
2026-02-20T14:31:50.836Z [DEBUG] MCP server "ide": Calling MCP tool: closeAllDiffTabs
2026-02-20T14:31:50.838Z [DEBUG] Tool search disabled for model 'claude-haiku-4-5-20251001': model does not support tool_reference blocks. This feature is only available on Claude Sonnet 4+, Opus 4+, and newer models.
2026-02-20T14:31:50.838Z [DEBUG] [SystemPrompt] path=simple proactive=false
2026-02-20T14:31:50.839Z [DEBUG] attribution header x-anthropic-billing-header: cc_version=2.1.49.964; cc_entrypoint=cli; cch=00000;
2026-02-20T14:31:50.839Z [DEBUG] [API:request] Creating client, AN