2026-11-10T11:27:49.312+00:00 +0.001435 MANIFEST {"id": "P14", "case": "mixed-W", "side": "after", "sha": "965b08b3060575186415df240c898a50c8736c5d", "environment": "Ubuntu 24.04.4 LTS Linux x86_64; kernel 6.8.0-117-generic; dash 0.5.12-6ubuntu5 or bash 5.2.21 --posix; curl 8.5.0; GNU wget 1.21.4; BusyBox 1.36.1; Node v26.12.1; PowerShell 7.4.6 Core on Linux (helpers only)", "selected": {"surface": "P", "shell": null, "transport": null, "path": null, "mech": "W", "pty": false}, "selected_transport_version": "curl 8.5.0", "command": "/tmp/lead-32913-r1/evidence-capture/powershell-7.4.6/pwsh -NoLogo -NoProfile -File /tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/observe.ps1", "env": {"HOME": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/home", "T3CODE_HOME": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/home/t3", "T3CODE_INSTALL_BIN_DIR": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/bin", "TMPDIR": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/tmp", "TMP": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/tmp", "TEMP": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/tmp", "TERM": "dumb", "LANG": "C.UTF-8", "LC_ALL": "C.UTF-8", "NO_COLOR": "1", "CAPTURE_TRANSPORT": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/transport.jsonl", "T3CODE_VERSION": "1.2.3", "T3CODE_RELEASE_BASE_URL": "http://127.0.0.1:34863", "PROCESSOR_ARCHITECTURE": "AMD64", "DOTNET_CLI_HOME": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/home", "POWERSHELL_TELEMETRY_OPTOUT": "1", "PATH": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/path", "CAPTURE_STAGING": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/helper-staging", "CAPTURE_URL": "http://127.0.0.1:34863/v1.2.3/SHA256SUMS", "CAPTURE_DEST": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/downloaded", "CAPTURE_SCRIPT": "/tmp/lead-32913-r1/evidence-capture-2/same-revision-20261110T112746.614134Z/P14-mixed-W/after/install.ps1"}, "original_source_sha256": "d24dd0357bd107d3643aeeb1e80eaebf2cb8d84928a5bbed3682a9a6b491f92c", "executed_source_sha256": "35c733673fcde6543a22ff0ac0dcc202f1ba36554e54797c9abfeaa7a21b2d15", "transforms": ["Set-PSDebug -Trace 1 observes execution of exact helper source, including disposal and request commands", "verbatim prologue and helper slice; real-HTTP synthetic caller; discovery origins only remapped"], "steps": "Start fixture; run command; deliver terminal Ctrl-C only when specified precondition is observed; capture exit, requests, install state, tracked PIDs."}
2026-11-10T11:27:49.313+00:00 +0.002065 SPAWN {"pid": 663220, "pty": false, "stdin": "noninteractive"}
2026-11-10T11:27:49.818+00:00 +0.507559 OUTPUT "DEBUG:    2+  >>>> & $env:CAPTURE_SCRIPT\n\n"
2026-11-10T11:27:49.878+00:00 +0.567211 OUTPUT "DEBUG:   16+  >>>> $ErrorActionPreference = \"Stop\"\n\n"
2026-11-10T11:27:49.878+00:00 +0.567345 OUTPUT "DEBUG:   17+  >>>> [Net.ServicePointManager]::SecurityProtocol = [Net.SecurityProtocolType]::Tls12\n"
2026-11-10T11:27:49.878+00:00 +0.567368 OUTPUT "\n"
2026-11-10T11:27:49.883+00:00 +0.572370 OUTPUT "DEBUG:   19+  >>>> $repo = \"pingdotgg/t3code\"\n\n"
2026-11-10T11:27:49.883+00:00 +0.572462 OUTPUT "DEBUG:   20+  >>>> $baseUrl = if ($env:T3CODE_RELEASE_BASE_URL) { $env:T3CODE_RELEASE_BASE_URL.TrimEnd(\"/\") } else { \"http://127.0.0.1:34863/$repo/releases/download\" }\n\nDEBUG:   20+ $baseUrl = if ( >>>> $env:T3CODE_RELEASE_BASE_URL) { $env:T3CODE_RELEASE_BASE_URL.TrimEnd(\"/\") } else { \"http://127.0.0.1:34863/$repo/releases/download\" }\n\n"
2026-11-10T11:27:49.885+00:00 +0.574091 OUTPUT "DEBUG:   20+ $baseUrl = if ($env:T3CODE_RELEASE_BASE_URL) {  >>>> $env:T3CODE_RELEASE_BASE_URL.TrimEnd(\"/\") } else { \"http://127.0.0.1:34863/$repo/releases/download\" }\n\n"
2026-11-10T11:27:49.890+00:00 +0.579643 OUTPUT "DEBUG:   21+  >>>> $t3Home = if ($env:T3CODE_HOME) { $env:T3CODE_HOME } else { Join-Path $HOME \".t3\" }\n\n"
2026-11-10T11:27:49.890+00:00 +0.579795 OUTPUT "DEBUG:   21+ $t3Home = if ( >>>> $env:T3CODE_HOME) { $env:T3CODE_HOME } else { Join-Path $HOME \".t3\" }\n"
2026-11-10T11:27:49.890+00:00 +0.579814 OUTPUT "\n"
2026-11-10T11:27:49.890+00:00 +0.579894 OUTPUT "DEBUG:   21+ $t3Home = if ($env:T3CODE_HOME) {  >>>> $env:T3CODE_HOME } else { Join-Path $HOME \".t3\" }\n"
2026-11-10T11:27:49.891+00:00 +0.579909 OUTPUT "\n"
2026-11-10T11:27:49.891+00:00 +0.579968 OUTPUT "DEBUG:   22+  >>>> $binDir = if ($env:T3CODE_INSTALL_BIN_DIR) { $env:T3CODE_INSTALL_BIN_DIR } else { Join-Path $HOME \".local\\bin\" }\n"
2026-11-10T11:27:49.891+00:00 +0.579984 OUTPUT "\nDEBUG:   22+ $binDir = if ( >>>> $env:T3CODE_INSTALL_BIN_DIR) { $env:T3CODE_INSTALL_BIN_DIR } else { Join-Path $HOME \".local\\bin\" }\n\n"
2026-11-10T11:27:49.891+00:00 +0.580006 OUTPUT "DEBUG:   22+ $binDir = if ($env:T3CODE_INSTALL_BIN_DIR) {  >>>> $env:T3CODE_INSTALL_BIN_DIR } else { Join-Path $HOME \".local\\bin\" }\n"
2026-11-10T11:27:49.891+00:00 +0.580020 OUTPUT "\n"
2026-11-10T11:27:49.891+00:00 +0.580034 OUTPUT "DEBUG:   24+  >>>> $binDir = $ExecutionContext.SessionState.Path.GetUnresolvedProviderPathFromPSPath($binDir)\n\n"
2026-11-10T11:27:49.895+00:00 +0.584346 OUTPUT "DEBUG:   31+  >>>> $terminal = -not [Console]::IsErrorRedirected -and $env:TERM -ne \"dumb\"\n\n"
2026-11-10T11:27:49.896+00:00 +0.585251 OUTPUT "DEBUG:   32+  >>>> $interactive = $terminal -and $Host.UI.SupportsVirtualTerminal\n"
2026-11-10T11:27:49.896+00:00 +0.585278 OUTPUT "\nDEBUG:   33+ if ( >>>> $interactive) {\n\nDEBUG:   39+  >>>> $esc = [char]27\n\n"
2026-11-10T11:27:49.896+00:00 +0.585681 OUTPUT "DEBUG:   40+  >>>> $reset = $bold = $muted = $accent = $green = \"\"\n\nDEBUG:   40+ $reset =  >>>> $bold = $muted = $accent = $green = \"\"\n\n"
2026-11-10T11:27:49.896+00:00 +0.585718 OUTPUT "DEBUG:   40+ $reset = $bold =  >>>> $muted = $accent = $green = \"\"\n\nDEBUG:   40+ $reset = $bold = $muted =  >>>> $accent = $green = \"\"\n\nDEBUG:   40+ $reset = $bold = $muted = $accent =  >>>> $green = \"\"\n\nDEBUG:   41+ if ( >>>> $interactive -and -not $env:NO_COLOR) {\n\n"
2026-11-10T11:27:49.896+00:00 +0.585769 OUTPUT "DEBUG:  120+  >>>> [Console]::Error.WriteLine(\"CAPTURE_DISPATCH terminal=$terminal interactive=$interactive mechanism=W encoding=$([Console]::Error.Encoding.WebName)\")\n\n"
2026-11-10T11:27:49.897+00:00 +0.586551 OUTPUT "DEBUG:  120+ [Console]::Error.WriteLine(\"CAPTURE_DISPATCH terminal=$terminal interactive=$interactive mechanism=W encoding=$( >>>> [Console]::Error.Encoding.WebName)\")\n\n"
2026-11-10T11:27:49.905+00:00 +0.594321 OUTPUT "CAPTURE_DISPATCH terminal=False interactive=False mechanism=W encoding=utf-8\n"
2026-11-10T11:27:49.905+00:00 +0.594566 OUTPUT "DEBUG:  122+  >>>> Fetch $env:CAPTURE_URL $env:CAPTURE_DEST\n"
2026-11-10T11:27:49.905+00:00 +0.594599 OUTPUT "\n"
2026-11-10T11:27:49.914+00:00 +0.603548 OUTPUT "DEBUG:   80+ function Fetch([string] $uri, [string] $destination, [switch] $progress)  >>>> {\n\nDEBUG:   81+   if ( >>>> -not $progress -or -not $interactive) {\n\n"
2026-11-10T11:27:49.915+00:00 +0.604191 OUTPUT "DEBUG:   82+      >>>> $ProgressPreference = if ($progress -and $terminal) { \"Continue\" } else { \"SilentlyContinue\" }\n"
2026-11-10T11:27:49.915+00:00 +0.604215 OUTPUT "\nDEBUG:   82+     $ProgressPreference = if ( >>>> $progress -and $terminal) { \"Continue\" } else { \"SilentlyContinue\" }\n\n"
2026-11-10T11:27:49.915+00:00 +0.604818 OUTPUT "DEBUG:   82+     $ProgressPreference = if ($progress -and $terminal) { \"Continue\" } else {  >>>> \"SilentlyContinue\" }\n"
2026-11-10T11:27:49.915+00:00 +0.604858 OUTPUT "\nDEBUG:   83+      >>>> Invoke-Retrying { Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n\n"
2026-11-10T11:27:49.917+00:00 +0.605994 OUTPUT "DEBUG:   74+ function Invoke-Retrying([scriptblock] $request)  >>>> {\n"
2026-11-10T11:27:49.917+00:00 +0.606033 OUTPUT "\nDEBUG:   75+   for ( >>>> $attempt = 1; ; $attempt++) {\n\nDEBUG:   76+     try { return  >>>> & $request }\n\n"
2026-11-10T11:27:49.917+00:00 +0.606333 OUTPUT "DEBUG:   83+     Invoke-Retrying  >>>> { Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n"
2026-11-10T11:27:49.917+00:00 +0.606354 OUTPUT "\nDEBUG:   83+     Invoke-Retrying {  >>>> Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n\n"
2026-11-10T11:27:50.106+00:00 +0.795076 SERVER {"request_t": 0.794998, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 1, "status": "DROP_PREHEADER", "behavior": "drop", "accept": null}
2026-11-10T11:27:50.106+00:00 +0.795267 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:50.111+00:00 +0.800119 SERVER {"request_t": 0.800059, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 2, "status": "DROP_PREHEADER", "behavior": "drop", "accept": null}
2026-11-10T11:27:50.111+00:00 +0.800230 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:50.112+00:00 +0.801065 SERVER {"request_t": 0.800998, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 3, "status": "DROP_PREHEADER", "behavior": "drop", "accept": null}
2026-11-10T11:27:50.112+00:00 +0.801216 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:50.112+00:00 +0.801879 SERVER {"request_t": 0.801828, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 4, "status": "DROP_PREHEADER", "behavior": "drop", "accept": null}
2026-11-10T11:27:50.113+00:00 +0.801962 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:50.138+00:00 +0.827807 OUTPUT "DEBUG:   77+     catch { if ( >>>> -not (Wait-Retry ([int]$_.Exception.Response.StatusCode) $attempt)) { throw } }\n\n"
2026-11-10T11:27:50.145+00:00 +0.834540 OUTPUT "DEBUG:   69+ function Wait-Retry([int] $status, [int] $attempt)  >>>> {\n\nDEBUG:   70+   if ( >>>> $attempt -ge 4 -or ($status -ge 400 -and $status -lt 500 -and $status -ne 408 -and $status -ne 429)) { return $false }\n\n"
2026-11-10T11:27:50.147+00:00 +0.836245 OUTPUT "DEBUG:   71+    >>>> Start-Sleep -Seconds ([Math]::Pow(2, $attempt - 1))\n\n"
2026-11-10T11:27:51.153+00:00 +1.842067 OUTPUT "DEBUG:   72+   return  >>>> $true\n\n"
2026-11-10T11:27:51.153+00:00 +1.842206 OUTPUT "DEBUG:   73+  >>>> }\n\n"
2026-11-10T11:27:51.154+00:00 +1.843123 OUTPUT "DEBUG:   75+   for ($attempt = 1; ;  >>>> $attempt++) {\n\n"
2026-11-10T11:27:51.154+00:00 +1.843768 OUTPUT "DEBUG:   76+     try { return  >>>> & $request }\n\n"
2026-11-10T11:27:51.155+00:00 +1.844037 OUTPUT "DEBUG:   83+     Invoke-Retrying  >>>> { Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n\n"
2026-11-10T11:27:51.155+00:00 +1.844088 OUTPUT "DEBUG:   83+     Invoke-Retrying {  >>>> Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n\n"
2026-11-10T11:27:51.170+00:00 +1.859588 SERVER {"request_t": 1.85952, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 5, "status": 504, "behavior": 504, "accept": null}
2026-11-10T11:27:51.170+00:00 +1.859851 SERVER {"event": "body_complete", "endpoint": "sums", "bytes": 19}
2026-11-10T11:27:51.171+00:00 +1.859909 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:51.212+00:00 +1.901318 OUTPUT "DEBUG:   77+     catch { if ( >>>> -not (Wait-Retry ([int]$_.Exception.Response.StatusCode) $attempt)) { throw } }\n\n"
2026-11-10T11:27:51.214+00:00 +1.903649 OUTPUT "DEBUG:   69+ function Wait-Retry([int] $status, [int] $attempt)  >>>> {\n"
2026-11-10T11:27:51.214+00:00 +1.903680 OUTPUT "\nDEBUG:   70+   if ( >>>> $attempt -ge 4 -or ($status -ge 400 -and $status -lt 500 -and $status -ne 408 -and $status -ne 429)) { return $false }\n\n"
2026-11-10T11:27:51.215+00:00 +1.904075 OUTPUT "DEBUG:   71+    >>>> Start-Sleep -Seconds ([Math]::Pow(2, $attempt - 1))\n"
2026-11-10T11:27:51.215+00:00 +1.904099 OUTPUT "\n"
2026-11-10T11:27:53.216+00:00 +3.905004 OUTPUT "DEBUG:   72+   return  >>>> $true\n\n"
2026-11-10T11:27:53.216+00:00 +3.905158 OUTPUT "DEBUG:   73+  >>>> }\n\nDEBUG:   75+   for ($attempt = 1; ;  >>>> $attempt++) {\n\n"
2026-11-10T11:27:53.216+00:00 +3.905226 OUTPUT "DEBUG:   76+     try { return  >>>> & $request }\n\n"
2026-11-10T11:27:53.216+00:00 +3.905496 OUTPUT "DEBUG:   83+     Invoke-Retrying  >>>> { Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n"
2026-11-10T11:27:53.216+00:00 +3.905529 OUTPUT "\nDEBUG:   83+     Invoke-Retrying {  >>>> Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing }\n\n"
2026-11-10T11:27:53.218+00:00 +3.907078 SERVER {"request_t": 3.907026, "event": "request", "path": "/v1.2.3/SHA256SUMS", "endpoint": "sums", "attempt": 6, "status": 200, "behavior": 200, "accept": null}
2026-11-10T11:27:53.218+00:00 +3.907242 SERVER {"event": "body_complete", "endpoint": "sums", "bytes": 181}
2026-11-10T11:27:53.218+00:00 +3.907268 SERVER {"event": "request_handler_end", "endpoint": "sums"}
2026-11-10T11:27:53.220+00:00 +3.909897 OUTPUT "DEBUG:   83+     Invoke-Retrying { Invoke-WebRequest -Uri $uri -OutFile $destination -UseBasicParsing  >>>> }\n\n"
2026-11-10T11:27:53.221+00:00 +3.909968 OUTPUT "DEBUG:   79+  >>>> }\n\n"
2026-11-10T11:27:53.221+00:00 +3.909998 OUTPUT "DEBUG:   84+      >>>> return\n"
2026-11-10T11:27:53.221+00:00 +3.910012 OUTPUT "\nDEBUG:  119+  >>>> }\n"
2026-11-10T11:27:53.221+00:00 +3.910025 OUTPUT "\n"
2026-11-10T11:27:53.221+00:00 +3.910048 OUTPUT "DEBUG:  123+  >>>> Write-Output \"DEST_LENGTH=$((Get-Item $env:CAPTURE_DEST).Length)\"\n"
2026-11-10T11:27:53.221+00:00 +3.910063 OUTPUT "\n"
2026-11-10T11:27:53.221+00:00 +3.910076 OUTPUT "DEBUG:  123+ Write-Output \"DEST_LENGTH=$( >>>> (Get-Item $env:CAPTURE_DEST).Length)\"\n"
2026-11-10T11:27:53.221+00:00 +3.910090 OUTPUT "\n"
2026-11-10T11:27:53.248+00:00 +3.937292 OUTPUT "DEST_LENGTH=181\n"
2026-11-10T11:27:53.248+00:00 +3.937415 OUTPUT "DEBUG:  124+  >>>> Write-Output \"DEST_SHA256=$((Get-FileHash $env:CAPTURE_DEST -Algorithm SHA256).Hash)\"\n\nDEBUG:  124+ Write-Output \"DEST_SHA256=$( >>>> (Get-FileHash $env:CAPTURE_DEST -Algorithm SHA256).Hash)\"\n\n"
2026-11-10T11:27:53.261+00:00 +3.950692 OUTPUT "DEST_SHA256=2619CFDA7B569ECA69659520FD8B41350468966121F17DA7D25015C1E72404F8\n"
2026-11-10T11:27:53.261+00:00 +3.950801 OUTPUT "DEBUG:  125+  >>>> Write-Output \"CAPTURE_SUCCESS\"\n\n"
2026-11-10T11:27:53.261+00:00 +3.950881 OUTPUT "CAPTURE_SUCCESS"
2026-11-10T11:27:53.262+00:00 +3.950910 OUTPUT "\n"
2026-11-10T11:27:53.262+00:00 +3.950933 OUTPUT "DEBUG:  132+ } finally {  >>>> [Console]::Error.WriteLine(\"CAPTURE_CALLER_FINALLY\") }\n"
2026-11-10T11:27:53.262+00:00 +3.950948 OUTPUT "\n"
2026-11-10T11:27:53.263+00:00 +3.952084 OUTPUT "CAPTURE_CALLER_FINALLY\n"
2026-11-10T11:27:53.307+00:00 +3.996113 SERVER_STATE_BEFORE_DRIVER_CLEANUP {"active_handlers": 0}
2026-11-10T11:27:53.308+00:00 +3.997213 RESULT {"exit_code": 0, "elapsed_seconds": 3.996051, "requests": 6, "interrupt_sent": false, "timeout": false, "state": {"marker": false, "files": [{"path": "home/.cache/powershell/StartupProfileData-NonInteractive", "bytes": 96836, "symlink": null}], "helper_outputs": [{"path": "downloaded", "bytes": 181}], "staging": [], "sidecars": [], "tracked_downloader_pids": [], "remaining_tracked_downloaders": []}, "symlink_executable_check": null}
