# B3 after runtime recording

Revision: [e039e17308](https://git.cafe/pingdotgg/t3code/commit/e039e17308b32c280903c5dd4cd82f2457e0d8f0)

Environment: Linux-6.1.102-x86_64-with-glibc2.39, Node v26.13.0. Production-runtime harness, synthetic config and stub connector. Real CloudManagedEndpointRuntime and Node spawner (passive exit-result observer). Not a real Cloudflare tunnel.

A/B: NodeRuntime.runMain, group signal. C2/C3: Effect.runPromise host intentionally survives parent-only OS signals, explicit runtime scope closure.

Stub registration is an age-based model only: <2000ms stop takes 2300ms, otherwise 15ms. “past-registering-window” is synthetic, never Cloudflare readiness. Runner gates use events, not guessed readiness sleeps. The predecessor/backoff/stub timers are deliberate fixture behavior.

AI-assisted; verified with the tests and tools listed above.

## Measured result

```json
{
  "row": "B3",
  "side": "after",
  "sha": "e039e17308b32c280903c5dd4cd82f2457e0d8f0",
  "stopMs": 1641,
  "failure": null,
  "output": "/tmp/lead-33628-r1/capture-1/B3-after-20261110T013013.047604Z",
  "scriptSha256": {
    "driver.ts": "ec3fc57d6aae729c9d28d06370977a052e66acf71e633e9786dd552b091ee423",
    "cloudflared-stub.sh": "d6bece305c6bdc22b6b9511fc2e5210801777f54445f659e9d242f1732ad5f99",
    "cloudflared-stub.mjs": "4f0cb55a5a434d6a0c2148455c58683eba0f8d81993785ff34ffca3503e780df",
    "runner.py": "88a0c74d1385c4454291076b74a7c8a8ba4ab4a7ec06e337be788f5d23c5c402",
    "run.sh": "dc4d7379c91708d38ae3a6d3db279e254b71ad67901cd3e703addc66248fd879"
  },
  "recoveryRequests": [
    {
      "timestamp": "2026-11-10T01:30:14.679Z",
      "source": "driver",
      "event": "recovery-request",
      "phase": "ordinary",
      "count": 1,
      "config": {
        "providerKind": "cloudflare_tunnel",
        "connectorToken": "synthetic-token",
        "tunnelId": "tunnel-1"
      }
    }
  ],
  "listeners": [
    {
      "timestamp": "2026-11-10T01:30:14.486Z",
      "source": "driver",
      "event": "listeners",
      "phase": "before-build",
      "identities": {
        "SIGINT": [
          1
        ],
        "SIGTERM": [
          2
        ]
      },
      "counts": {
        "SIGINT": 1,
        "SIGTERM": 1
      },
      "baselineRestored": true
    },
    {
      "timestamp": "2026-11-10T01:30:14.561Z",
      "source": "driver",
      "event": "listeners",
      "phase": "ordinary:after-build",
      "identities": {
        "SIGINT": [
          1,
          3,
          4
        ],
        "SIGTERM": [
          2,
          3,
          4
        ]
      },
      "counts": {
        "SIGINT": 3,
        "SIGTERM": 3
      },
      "baselineRestored": false
    }
  ],
  "scopeStops": [],
  "relayCounts": {
    "Relay client process started; waiting for tunnel connection": 2,
    "Relay client exited; restarting": 1,
    "Relay client stopped": 2,
    "Relay client is crash-looping; delaying restart": 1
  },
  "exitResults": [
    {
      "timestamp": "2026-11-10T01:30:14.668Z",
      "source": "driver",
      "event": "child-exit-observed",
      "pid": 1534264,
      "exitCode": 1
    },
    {
      "timestamp": "2026-11-10T01:30:14.723Z",
      "source": "driver",
      "event": "child-exit-observed",
      "pid": 1534271,
      "exitCode": 1
    }
  ]
}
```

## Runner milestones

```text
{"timestamp": "2026-11-10T01:30:13.061+00:00", "source": "runner", "event": "environment", "row": "B3", "side": "after", "sha": "e039e17308b32c280903c5dd4cd82f2457e0d8f0", "os": "Linux-6.1.102-x86_64-with-glibc2.39", "node": "v26.13.0", "harness": "real CloudManagedEndpointRuntime + real Node spawner with passive exit observer + stub cloudflared; not a real Cloudflare tunnel", "attribution": "AI-assisted; verified with the tests and tools listed above.", "slowMs": 1600}
{"timestamp": "2026-11-10T01:30:13.062+00:00", "source": "runner", "event": "spawned-driver", "pid": 1534226, "pgid": 1534226}
{"timestamp": "2026-11-10T01:30:14.604+00:00", "source": "runner", "event": "gate-satisfied", "gate": "runtime applied; no server signal", "observed": {"timestamp": "2026-11-10T01:30:14.604Z", "source": "driver", "event": "driver-ready", "row": "B3"}}
{"timestamp": "2026-11-10T01:30:14.655+00:00", "source": "runner", "event": "gate-satisfied", "gate": "stub attempt 1 started", "observed": {"timestamp": "2026-11-10T01:30:14.655Z", "source": "stub", "event": "file-line", "line": "{\"timestamp\":\"2026-11-10T01:30:14.654Z\",\"source\":\"stub\",\"event\":\"started\",\"pid\":1534264,\"attempt\":1,\"ageMs\":1}", "record": {"timestamp": "2026-11-10T01:30:14.654Z", "source": "stub", "event": "started", "pid": 1534264, "attempt": 1, "ageMs": 1}}}
{"timestamp": "2026-11-10T01:30:14.656+00:00", "source": "runner", "event": "send-child-only-signal", "pid": 1534264, "signal": "SIGUSR1", "purpose": "controlled nonzero exit 1, no server signal"}
{"timestamp": "2026-11-10T01:30:14.679+00:00", "source": "runner", "event": "gate-satisfied", "gate": "first crash recovery establishes next backoff", "observed": {"timestamp": "2026-11-10T01:30:14.679Z", "source": "driver", "event": "recovery-request", "phase": "ordinary", "count": 1, "config": {"providerKind": "cloudflare_tunnel", "connectorToken": "synthetic-token", "tunnelId": "tunnel-1"}}}
{"timestamp": "2026-11-10T01:30:14.715+00:00", "source": "runner", "event": "gate-satisfied", "gate": "stub attempt 2 started", "observed": {"timestamp": "2026-11-10T01:30:14.714Z", "source": "stub", "event": "file-line", "line": "{\"timestamp\":\"2026-11-10T01:30:14.714Z\",\"source\":\"stub\",\"event\":\"started\",\"pid\":1534271,\"attempt\":2,\"ageMs\":1}", "record": {"timestamp": "2026-11-10T01:30:14.714Z", "source": "stub", "event": "started", "pid": 1534271, "attempt": 2, "ageMs": 1}}}
{"timestamp": "2026-11-10T01:30:14.715+00:00", "source": "runner", "event": "send-child-only-signal", "pid": 1534271, "signal": "SIGUSR1", "purpose": "controlled nonzero exit 1, no server signal"}
{"timestamp": "2026-11-10T01:30:14.724+00:00", "source": "runner", "event": "gate-satisfied", "gate": "recorded positive crash-loop backoff", "observed": {"timestamp": "2026-11-10T01:30:14.723Z", "source": "relay", "event": "file-line", "line": "{\"message\":[\"Relay client is crash-looping; delaying restart\",{\"pid\":1534271,\"uptimeMillis\":45,\"restartDelayMillis\":1000,\"tunnelId\":\"tunnel-1\"}],\"level\":\"WARN\",\"timestamp\":\"2026-11-10T01:30:14.723Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#37\"}", "record": {"message": ["Relay client is crash-looping; delaying restart", {"pid": 1534271, "uptimeMillis": 45, "restartDelayMillis": 1000, "tunnelId": "tunnel-1"}], "level": "WARN", "timestamp": "2026-11-10T01:30:14.723Z", "annotations": {}, "spans": {}, "fiberId": "#37"}}}
{"timestamp": "2026-11-10T01:30:14.724+00:00", "source": "runner", "event": "signal-during-recorded-backoff", "delayRecord": {"message": ["Relay client is crash-looping; delaying restart", {"pid": 1534271, "uptimeMillis": 45, "restartDelayMillis": 1000, "tunnelId": "tunnel-1"}], "level": "WARN", "timestamp": "2026-11-10T01:30:14.723Z", "annotations": {}, "spans": {}, "fiberId": "#37"}, "predecessorMs": 1600}
{"timestamp": "2026-11-10T01:30:14.724+00:00", "source": "runner", "event": "send-group-signal", "pid": 1534226, "pgid": 1534226, "signal": "SIGTERM"}
{"timestamp": "2026-11-10T01:30:16.365+00:00", "source": "runner", "event": "backend-stopped", "stopMs": 1641, "returncode": 130}
{"timestamp": "2026-11-10T01:30:16.374+00:00", "source": "runner", "event": "tracked-process-group-cleanup", "members": []}
```

## Driver and forwarded timestamped relay/stub events

```text
{"timestamp":"2026-11-10T01:30:14.483Z","source":"driver","event":"actual-node-version","node":"v26.13.0","executable":"/home/ubuntu/.local/share/vite-plus/js_runtime/node/26.13.0/bin/node"}
{"timestamp":"2026-11-10T01:30:14.486Z","source":"driver","event":"listeners","phase":"before-build","identities":{"SIGINT":[1],"SIGTERM":[2]},"counts":{"SIGINT":1,"SIGTERM":1},"baselineRestored":true}
{"timestamp":"2026-11-10T01:30:14.561Z","source":"driver","event":"listeners","phase":"ordinary:after-build","identities":{"SIGINT":[1,3,4],"SIGTERM":[2,3,4]},"counts":{"SIGINT":3,"SIGTERM":3},"baselineRestored":false}
{"timestamp":"2026-11-10T01:30:14.595Z","source":"driver","event":"real-child-spawned","pid":1534264}
[01:30:14.596] INFO (#1): Relay client process started; waiting for tunnel connection {
  pid: 1534264,
  source: 'path',
  version: '2026.10.4',
  protocol: 'auto',
  tunnelId: 'tunnel-1',
  tunnelName: undefined
}
{"timestamp":"2026-11-10T01:30:14.603Z","source":"driver","event":"connector-applied","phase":"ordinary","status":{"status":"running","providerKind":"cloudflare_tunnel","pid":1534264,"tunnelId":"tunnel-1"}}
{"timestamp":"2026-11-10T01:30:14.604Z","source":"driver","event":"driver-ready","row":"B3"}
{"timestamp":"2026-11-10T01:30:14.625Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client process started; waiting for tunnel connection\",{\"pid\":1534264,\"source\":\"path\",\"version\":\"2026.10.4\",\"protocol\":\"auto\",\"tunnelId\":\"tunnel-1\"}],\"level\":\"INFO\",\"timestamp\":\"2026-11-10T01:30:14.596Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#1\"}"}
{"timestamp":"2026-11-10T01:30:14.655Z","source":"stub","event":"file-line","line":"{\"timestamp\":\"2026-11-10T01:30:14.654Z\",\"source\":\"stub\",\"event\":\"started\",\"pid\":1534264,\"attempt\":1,\"ageMs\":1}"}
{"timestamp":"2026-11-10T01:30:14.658Z","source":"stub","event":"file-line","line":"{\"timestamp\":\"2026-11-10T01:30:14.656Z\",\"source\":\"stub\",\"event\":\"controlled-crash\",\"pid\":1534264,\"attempt\":1,\"ageMs\":2,\"exitCode\":1}"}
{"timestamp":"2026-11-10T01:30:14.668Z","source":"driver","event":"child-exit-observed","pid":1534264,"exitCode":1}
[01:30:14.670] INFO (#29): Relay client stopped { pid: 1534264 }
[01:30:14.671] WARN (#29): Relay client exited; restarting {
  pid: 1534264,
  exitCode: 1,
  tunnelId: 'tunnel-1',
  tunnelName: undefined
}
{"timestamp":"2026-11-10T01:30:14.678Z","source":"driver","event":"real-child-spawned","pid":1534271}
[01:30:14.678] INFO (#29): Relay client process started; waiting for tunnel connection {
  pid: 1534271,
  source: 'path',
  version: '2026.10.4',
  protocol: 'auto',
  tunnelId: 'tunnel-1',
  tunnelName: undefined
}
{"timestamp":"2026-11-10T01:30:14.679Z","source":"driver","event":"recovery-request","phase":"ordinary","count":1,"config":{"providerKind":"cloudflare_tunnel","connectorToken":"synthetic-token","tunnelId":"tunnel-1"}}
{"timestamp":"2026-11-10T01:30:14.680Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client stopped\",{\"pid\":1534264}],\"level\":\"INFO\",\"timestamp\":\"2026-11-10T01:30:14.670Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#29\"}"}
{"timestamp":"2026-11-10T01:30:14.680Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client exited; restarting\",{\"pid\":1534264,\"exitCode\":1,\"tunnelId\":\"tunnel-1\"}],\"level\":\"WARN\",\"timestamp\":\"2026-11-10T01:30:14.671Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#29\"}"}
{"timestamp":"2026-11-10T01:30:14.680Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client process started; waiting for tunnel connection\",{\"pid\":1534271,\"source\":\"path\",\"version\":\"2026.10.4\",\"protocol\":\"auto\",\"tunnelId\":\"tunnel-1\"}],\"level\":\"INFO\",\"timestamp\":\"2026-11-10T01:30:14.678Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#29\"}"}
{"timestamp":"2026-11-10T01:30:14.714Z","source":"stub","event":"file-line","line":"{\"timestamp\":\"2026-11-10T01:30:14.714Z\",\"source\":\"stub\",\"event\":\"started\",\"pid\":1534271,\"attempt\":2,\"ageMs\":1}"}
{"timestamp":"2026-11-10T01:30:14.715Z","source":"stub","event":"file-line","line":"{\"timestamp\":\"2026-11-10T01:30:14.715Z\",\"source\":\"stub\",\"event\":\"controlled-crash\",\"pid\":1534271,\"attempt\":2,\"ageMs\":2,\"exitCode\":1}"}
{"timestamp":"2026-11-10T01:30:14.723Z","source":"driver","event":"child-exit-observed","pid":1534271,"exitCode":1}
[01:30:14.723] WARN (#37): Relay client is crash-looping; delaying restart {
  pid: 1534271,
  uptimeMillis: 45,
  restartDelayMillis: 1000,
  tunnelId: 'tunnel-1',
  tunnelName: undefined
}
{"timestamp":"2026-11-10T01:30:14.723Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client is crash-looping; delaying restart\",{\"pid\":1534271,\"uptimeMillis\":45,\"restartDelayMillis\":1000,\"tunnelId\":\"tunnel-1\"}],\"level\":\"WARN\",\"timestamp\":\"2026-11-10T01:30:14.723Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#37\"}"}
{"timestamp":"2026-11-10T01:30:14.724Z","source":"driver","event":"host-signal-received","signal":"SIGTERM","signals":1}
{"timestamp":"2026-11-10T01:30:14.724Z","source":"driver","event":"shutdown-started","recoveryCount":1}
{"timestamp":"2026-11-10T01:30:14.724Z","source":"driver","event":"predecessor-finalizer-start","delayMs":1600,"recoveryCount":1}
[01:30:15.727] INFO (#37): Relay client stopped { pid: 1534271 }
{"timestamp":"2026-11-10T01:30:15.728Z","source":"relay","event":"file-line","line":"{\"message\":[\"Relay client stopped\",{\"pid\":1534271}],\"level\":\"INFO\",\"timestamp\":\"2026-11-10T01:30:15.727Z\",\"annotations\":{},\"spans\":{},\"fiberId\":\"#37\"}"}
{"timestamp":"2026-11-10T01:30:16.325Z","source":"driver","event":"predecessor-finalizer-end-relay-next","recoveryCount":1}
{"timestamp":"2026-11-10T01:30:16.328Z","source":"driver","event":"process-exit","code":130,"recoveryCount":1,"signals":1}
```

## Full raw relay-client log

```text
{"message":["Relay client process started; waiting for tunnel connection",{"pid":1534264,"source":"path","version":"2026.10.4","protocol":"auto","tunnelId":"tunnel-1"}],"level":"INFO","timestamp":"2026-11-10T01:30:14.596Z","annotations":{},"spans":{},"fiberId":"#1"}
{"message":["Relay client stopped",{"pid":1534264}],"level":"INFO","timestamp":"2026-11-10T01:30:14.670Z","annotations":{},"spans":{},"fiberId":"#29"}
{"message":["Relay client exited; restarting",{"pid":1534264,"exitCode":1,"tunnelId":"tunnel-1"}],"level":"WARN","timestamp":"2026-11-10T01:30:14.671Z","annotations":{},"spans":{},"fiberId":"#29"}
{"message":["Relay client process started; waiting for tunnel connection",{"pid":1534271,"source":"path","version":"2026.10.4","protocol":"auto","tunnelId":"tunnel-1"}],"level":"INFO","timestamp":"2026-11-10T01:30:14.678Z","annotations":{},"spans":{},"fiberId":"#29"}
{"message":["Relay client is crash-looping; delaying restart",{"pid":1534271,"uptimeMillis":45,"restartDelayMillis":1000,"tunnelId":"tunnel-1"}],"level":"WARN","timestamp":"2026-11-10T01:30:14.723Z","annotations":{},"spans":{},"fiberId":"#37"}
{"message":["Relay client stopped",{"pid":1534271}],"level":"INFO","timestamp":"2026-11-10T01:30:15.727Z","annotations":{},"spans":{},"fiberId":"#37"}
```

## Full raw stub log

```text
{"timestamp":"2026-11-10T01:30:14.654Z","source":"stub","event":"started","pid":1534264,"attempt":1,"ageMs":1}
{"timestamp":"2026-11-10T01:30:14.656Z","source":"stub","event":"controlled-crash","pid":1534264,"attempt":1,"ageMs":2,"exitCode":1}
{"timestamp":"2026-11-10T01:30:14.714Z","source":"stub","event":"started","pid":1534271,"attempt":2,"ageMs":1}
{"timestamp":"2026-11-10T01:30:14.715Z","source":"stub","event":"controlled-crash","pid":1534271,"attempt":2,"ageMs":2,"exitCode":1}
```