2026-10-14T13:51:33.420Z Diffinery runner: job e2e (End-to-end (git, PRs, Actions)) for codician/diffinery@35a9b8a4cc99
2026-10-14T13:51:33.441Z Runner: image diffinery-runner:7d76ed7e2bbe8f5431f60bdc, in ord07, ENAM, container b298afc18315dbb9efb8dc187dba2b8c95795e18ec7168d4b2447c7637c213c6
2026-10-14T13:51:33.441Z Workspace: /workspace/diffinery
2026-10-14T13:51:33.678Z ##[group]Run actions/checkout@v4
2026-10-14T13:51:33.678Z ##[endgroup]
2026-10-14T13:51:33.686Z Syncing repository: codician/diffinery
2026-10-14T13:51:33.812Z Fetching the repository (depth 1)
2026-10-14T13:51:35.234Z remote: Enumerating objects: 584, done.        
2026-10-14T13:51:35.966Z Receiving objects:   0% (1/584)
Receiving objects:   1% (6/584)
Receiving objects:   2% (12/584)
Receiving objects:   3% (18/584)
Receiving objects:   4% (24/584)
Receiving objects:   5% (30/584)
Receiving objects:   6% (36/584)
Receiving objects:   7% (41/584)
Receiving objects:   8% (47/584)
Receiving objects:   9% (53/584)
Receiving objects:  10% (59/584)
Receiving objects:  11% (65/584)
Receiving objects:  12% (71/584)
Receiving objects:  13% (76/584)
Receiving objects:  14% (82/584)
Receiving objects:  15% (88/584)
Receiving objects:  16% (94/584)
Receiving objects:  17% (100/584)
Receiving objects:  18% (106/584)
Receiving objects:  19% (111/584)
Receiving objects:  20% (117/584)
Receiving objects:  21% (123/584)
Receiving objects:  22% (129/584)
Receiving objects:  23% (135/584)
Receiving objects:  24% (141/584)
Receiving objects:  25% (146/584)
Receiving objects:  26% (152/584)
Receiving objects:  27% (158/584)
Receiving objects:  28% (164/584)
Receiving objects:  29% (170/584)
Receiving objects:  30% (176/584)
Receiving objects:  31% (182/584)
Receiving objects:  32% (187/584)
Receiving objects:  33% (193/584)
Receiving objects:  34% (199/584)
Receiving objects:  35% (205/584)
Receiving objects:  36% (211/584)
Receiving objects:  37% (217/584)
Receiving objects:  38% (222/584)
Receiving objects:  39% (228/584)
Receiving objects:  40% (234/584)
Receiving objects:  41% (240/584)
Receiving objects:  42% (246/584)
Receiving objects:  43% (252/584)
Receiving objects:  44% (257/584)
Receiving objects:  45% (263/584)
Receiving objects:  46% (269/584)
Receiving objects:  47% (275/584)
Receiving objects:  48% (281/584)
Receiving objects:  49% (287/584)
Receiving objects:  50% (292/584)
Receiving objects:  51% (298/584)
Receiving objects:  52% (304/584)
Receiving objects:  53% (310/584)
Receiving objects:  54% (316/584)
Receiving objects:  55% (322/584)
Receiving objects:  56% (328/584)
Receiving objects:  57% (333/584)
Receiving objects:  58% (339/584)
Receiving objects:  59% (345/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  60% (351/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  61% (357/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  62% (363/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  63% (368/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  64% (374/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  65% (380/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  66% (386/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  67% (392/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  68% (398/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  69% (403/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  70% (409/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  71% (415/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  72% (421/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  73% (427/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  74% (433/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  75% (438/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  76% (444/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  77% (450/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  78% (456/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  79% (462/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  80% (468/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  81% (474/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  82% (479/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  83% (485/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  84% (491/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  85% (497/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  86% (503/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  87% (509/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  88% (514/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  89% (520/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  90% (526/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  91% (532/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  92% (538/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  93% (544/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  94% (549/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  95% (555/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  96% (561/584), 1.50 MiB | 2.87 MiB/s
remote: Total 584 (delta 0), reused 584 (delta 0)        
2026-10-14T13:51:35.969Z Receiving objects:  97% (567/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  98% (573/584), 1.50 MiB | 2.87 MiB/s
Receiving objects:  99% (579/584), 1.50 MiB | 2.87 MiB/s
Receiving objects: 100% (584/584), 1.50 MiB | 2.87 MiB/s
Receiving objects: 100% (584/584), 2.38 MiB | 3.45 MiB/s, done.
2026-10-14T13:51:35.984Z From https://diffinery.com/codician/diffinery
2026-10-14T13:51:35.984Z  * [new ref]         35a9b8a4cc99d85eaba50e500243243df6b8cc16 -> origin/diffinery-checkout
2026-10-14T13:51:36.068Z Note: switching to '35a9b8a4cc99d85eaba50e500243243df6b8cc16'.
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z You are in 'detached HEAD' state. You can look around, make experimental
2026-10-14T13:51:36.068Z changes and commit them, and you can discard any commits you make in this
2026-10-14T13:51:36.068Z state without impacting any branches by switching back to a branch.
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z If you want to create a new branch to retain commits you create, you may
2026-10-14T13:51:36.068Z do so (now or later) by using -c with the switch command. Example:
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z   git switch -c <new-branch-name>
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z Or undo this operation with:
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z   git switch -
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z Turn off this advice by setting config variable advice.detachedHead to false
2026-10-14T13:51:36.068Z 
2026-10-14T13:51:36.068Z HEAD is now at 35a9b8a Merge 346fd069ad46a20f9a4e98ac4d63a5f4b2feb585 into ec73e4444df45c559747eec0d1e4db8dcb842582
2026-10-14T13:51:36.074Z HEAD is now at 35a9b8a4cc99d85eaba50e500243243df6b8cc16
2026-10-14T13:51:36.405Z Download action repository 'pnpm/action-setup@v4'
2026-10-14T13:51:37.241Z ##[group]Run pnpm/action-setup@v4
2026-10-14T13:51:37.241Z with:
2026-10-14T13:51:37.241Z   dest: ~/setup-pnpm
2026-10-14T13:51:37.241Z   run_install: null
2026-10-14T13:51:37.241Z   cache: false
2026-10-14T13:51:37.241Z   cache_dependency_path: pnpm-lock.yaml
2026-10-14T13:51:37.241Z   package_json_file: package.json
2026-10-14T13:51:37.241Z   standalone: false
2026-10-14T13:51:37.241Z ##[endgroup]
2026-10-14T13:51:37.674Z ##[group]Running self-installer...
2026-10-14T13:51:39.465Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-14T13:51:39.520Z Packages: +1
2026-10-14T13:51:39.520Z +
2026-10-14T13:51:40.966Z Progress: resolved 1, reused 0, downloaded 1, added 0
2026-10-14T13:51:41.184Z Progress: resolved 1, reused 0, downloaded 1, added 1, done
2026-10-14T13:51:41.243Z 
2026-10-14T13:51:41.243Z dependencies:
2026-10-14T13:51:41.243Z + pnpm 10.28.0 (12.11.2 is available)
2026-10-14T13:51:41.243Z 
2026-10-14T13:51:41.253Z Done in 2.9s
2026-10-14T13:51:41.297Z ##[endgroup]
2026-10-14T13:51:41.297Z Installation Completed!
2026-10-14T13:51:41.782Z ##[group]Run actions/setup-node@v4
2026-10-14T13:51:41.783Z with:
2026-10-14T13:51:41.783Z   node-version: 22
2026-10-14T13:51:41.783Z   cache: pnpm
2026-10-14T13:51:41.783Z ##[endgroup]
2026-10-14T13:51:41.793Z Found in cache @ 22.22.0 (pre-installed node satisfies '22')
2026-10-14T13:51:42.507Z pnpm cache is not found
2026-10-14T13:51:42.807Z ##[group]Run pnpm install --frozen-lockfile
2026-10-14T13:51:42.807Z ##[endgroup]
2026-10-14T13:51:43.217Z Scope: all 7 workspace projects
2026-10-14T13:51:43.347Z Lockfile is up to date, resolution step is skipped
2026-10-14T13:51:43.565Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-14T13:51:43.618Z Packages: +248
2026-10-14T13:51:43.618Z ++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2026-10-14T13:51:44.568Z Progress: resolved 248, reused 0, downloaded 4, added 0
2026-10-14T13:51:45.570Z Progress: resolved 248, reused 0, downloaded 15, added 2
2026-10-14T13:51:46.576Z Progress: resolved 248, reused 0, downloaded 53, added 12
2026-10-14T13:51:47.575Z Progress: resolved 248, reused 0, downloaded 122, added 37
2026-10-14T13:51:48.579Z Progress: resolved 248, reused 0, downloaded 139, added 44
2026-10-14T13:51:49.583Z Progress: resolved 248, reused 0, downloaded 142, added 44
2026-10-14T13:51:51.015Z Progress: resolved 248, reused 0, downloaded 143, added 44
2026-10-14T13:51:52.022Z Progress: resolved 248, reused 0, downloaded 154, added 48
2026-10-14T13:51:53.025Z Progress: resolved 248, reused 0, downloaded 164, added 48
2026-10-14T13:51:54.027Z Progress: resolved 248, reused 0, downloaded 171, added 52
2026-10-14T13:51:55.028Z Progress: resolved 248, reused 0, downloaded 178, added 52
2026-10-14T13:51:56.194Z Progress: resolved 248, reused 0, downloaded 182, added 56
2026-10-14T13:51:57.200Z Progress: resolved 248, reused 0, downloaded 205, added 65
2026-10-14T13:51:58.217Z Progress: resolved 248, reused 0, downloaded 210, added 69
2026-10-14T13:51:59.213Z Progress: resolved 248, reused 0, downloaded 216, added 69
2026-10-14T13:52:00.218Z Progress: resolved 248, reused 0, downloaded 222, added 73
2026-10-14T13:52:01.222Z Progress: resolved 248, reused 0, downloaded 226, added 73
2026-10-14T13:52:02.223Z Progress: resolved 248, reused 0, downloaded 236, added 77
2026-10-14T13:52:03.228Z Progress: resolved 248, reused 0, downloaded 242, added 145
2026-10-14T13:52:04.229Z Progress: resolved 248, reused 0, downloaded 242, added 242
2026-10-14T13:52:04.244Z Progress: resolved 248, reused 0, downloaded 242, added 248, done
2026-10-14T13:52:04.496Z .../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js
2026-10-14T13:52:04.498Z .../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js
2026-10-14T13:52:04.499Z .../node_modules/workerd postinstall$ node install.js
2026-10-14T13:52:04.500Z .../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js
2026-10-14T13:52:04.501Z .../node_modules/workerd postinstall$ node install.js
2026-10-14T13:52:04.750Z .../esbuild@0.25.12/node_modules/esbuild postinstall: Done
2026-10-14T13:52:07.580Z .../esbuild@0.28.1/node_modules/esbuild postinstall: Done
2026-10-14T13:52:09.925Z .../node_modules/workerd postinstall: Done
2026-10-14T13:52:10.300Z .../esbuild@0.25.11/node_modules/esbuild postinstall: Done
2026-10-14T13:52:10.438Z .../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js
2026-10-14T13:52:10.474Z .../node_modules/workerd postinstall: Done
2026-10-14T13:52:10.570Z .../esbuild@0.28.2/node_modules/esbuild postinstall: Done
2026-10-14T13:52:11.793Z 
2026-10-14T13:52:11.793Z devDependencies:
2026-10-14T13:52:11.793Z + turbo 2.11.7
2026-10-14T13:52:11.793Z + typescript 5.9.3
2026-10-14T13:52:11.793Z 
2026-10-14T13:52:12.264Z Done in 29.4s using pnpm v10.28.0
2026-10-14T13:52:12.635Z ##[group]Run pnpm -r --if-present build
2026-10-14T13:52:12.635Z ##[endgroup]
2026-10-14T13:52:13.513Z Scope: 6 of 7 workspace projects
2026-10-14T13:52:13.522Z ##[group]@diffinery/cli@0.1.0 : build apps/cli
2026-10-14T13:52:13.529Z 
2026-10-14T13:52:13.529Z > @diffinery/cli@0.1.0 build /workspace/diffinery/apps/cli
2026-10-14T13:52:13.529Z > esbuild src/bin.ts --bundle --platform=node --target=node22 --format=esm --outfile=dist/diffinery.mjs "--banner:js=#!/usr/bin/env node
2026-10-14T13:52:13.529Z import { createRequire as __diffineryCreateRequire } from 'node:module'; const require = __diffineryCreateRequire(import.meta.url);"
2026-10-14T13:52:13.529Z 
2026-10-14T13:52:13.720Z 
2026-10-14T13:52:13.720Z   dist/diffinery.mjs  428.7kb
2026-10-14T13:52:13.720Z 
2026-10-14T13:52:13.720Z ⚡ Done in 165ms
2026-10-14T13:52:13.725Z ##[endgroup]
2026-10-14T13:52:13.726Z ##[group]@diffinery/app@0.1.0 : build apps/diffinery
2026-10-14T13:52:13.728Z 
2026-10-14T13:52:13.728Z > @diffinery/app@0.1.0 build /workspace/diffinery/apps/diffinery
2026-10-14T13:52:13.728Z > node islands/build.mjs && node scripts/build-docs.mjs
2026-10-14T13:52:13.728Z 
2026-10-14T13:52:16.516Z islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KB
2026-10-14T13:52:16.980Z docs: 61 pages (+2 generated at runtime), CLI 0.1.0 (222 KiB)
2026-10-14T13:52:16.991Z ##[endgroup]
2026-10-14T13:52:16.992Z ##[group]@diffinery/runner@0.1.0 : build containers/runner
2026-10-14T13:52:16.993Z 
2026-10-14T13:52:16.993Z > @diffinery/runner@0.1.0 build /workspace/diffinery/containers/runner
2026-10-14T13:52:16.993Z > esbuild src/main.ts --bundle --platform=node --target=node22 --format=esm --outfile=dist/agent.mjs --external:bufferutil --external:utf-8-validate "--banner:js=import { createRequire as __diffineryCreateRequire } from 'node:module'; const require = __diffineryCreateRequire(import.meta.url);"
2026-10-14T13:52:16.993Z 
2026-10-14T13:52:17.127Z 
2026-10-14T13:52:17.127Z   dist/agent.mjs  657.2kb
2026-10-14T13:52:17.127Z 
2026-10-14T13:52:17.127Z ⚡ Done in 123ms
2026-10-14T13:52:17.131Z ##[endgroup]
2026-10-14T13:52:17.788Z ##[group]Run # Shards of similar length; a new test file runs in "rest" unless it's added to another.
2026-10-14T13:52:17.788Z core='/e2e\.test\.mjs$'
2026-10-14T13:52:17.788Z agents='/(agentic|review|tasks)\.test\.mjs$'
2026-10-14T13:52:17.788Z security='/(security|status)\.test\.mjs$'
2026-10-14T13:52:17.788Z # The core file's real histories and large pushes take minutes each (jquery's alone 2 to 3 on
2026-10-14T13:52:17.788Z # Diffinery's runners): two shards of their own, so no part of the file runs into node's
2026-10-14T13:52:17.788Z # per-file timeout, which is the --test-timeout here.
2026-10-14T13:52:17.788Z histories='^real histories:'
2026-10-14T13:52:17.788Z large='^(large files|large pushes):'
2026-10-14T13:52:17.788Z opts=(--test-timeout=600000)
2026-10-14T13:52:17.788Z case "core" in
2026-10-14T13:52:17.788Z   core) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-skip-pattern="$histories" --test-skip-pattern="$large") ;;
2026-10-14T13:52:17.788Z   histories) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts=(--test-timeout=900000 --test-name-pattern="$histories") ;;
2026-10-14T13:52:17.788Z   large) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-name-pattern="$large") ;;
2026-10-14T13:52:17.788Z   agents) files=$(ls test/e2e/*.test.mjs | grep -E "$agents") ;;
2026-10-14T13:52:17.788Z   security) files=$(ls test/e2e/*.test.mjs | grep -E "$security") ;;
2026-10-14T13:52:17.788Z   *) files=$(ls test/e2e/*.test.mjs | grep -vE "$core|$agents|$security") ;;
2026-10-14T13:52:17.788Z esac
2026-10-14T13:52:17.788Z echo "$files"
2026-10-14T13:52:17.788Z node --test --test-concurrency=1 "${opts[@]}" $files
2026-10-14T13:52:17.788Z ##[endgroup]
2026-10-14T13:52:17.814Z test/e2e/e2e.test.mjs
2026-10-14T13:52:17.867Z TAP version 13
2026-10-14T13:52:50.018Z # Subtest: scheduled workflows: a push to the default branch registers the schedule
2026-10-14T13:52:50.021Z ok 1 - scheduled workflows: a push to the default branch registers the schedule
2026-10-14T13:52:50.021Z   ---
2026-10-14T13:52:50.021Z   duration_ms: 29105.324445
2026-10-14T13:52:50.021Z   type: 'test'
2026-10-14T13:52:50.021Z   ...
2026-10-14T13:52:56.927Z # 1 file checked: no errors, 0 warnings
2026-10-14T13:52:56.954Z # Subtest: git hosting, Actions, protected PR flow and MCP
2026-10-14T13:52:56.957Z ok 2 - git hosting, Actions, protected PR flow and MCP
2026-10-14T13:52:56.958Z   ---
2026-10-14T13:52:56.958Z   duration_ms: 6939.252376
2026-10-14T13:52:56.958Z   type: 'test'
2026-10-14T13:52:56.958Z   ...
2026-10-14T13:52:58.656Z # Subtest: reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-14T13:52:58.657Z ok 3 - reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-14T13:52:58.658Z   ---
2026-10-14T13:52:58.658Z   duration_ms: 1702.865929
2026-10-14T13:52:58.658Z   type: 'test'
2026-10-14T13:52:58.658Z   ...
2026-10-14T13:53:04.439Z # Subtest: job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-14T13:53:04.443Z ok 4 - job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-14T13:53:04.443Z   ---
2026-10-14T13:53:04.443Z   duration_ms: 5780.598695
2026-10-14T13:53:04.443Z   type: 'test'
2026-10-14T13:53:04.443Z   ...
2026-10-14T13:53:09.059Z # Subtest: re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-14T13:53:09.059Z ok 5 - re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-14T13:53:09.059Z   ---
2026-10-14T13:53:09.059Z   duration_ms: 4620.813965
2026-10-14T13:53:09.059Z   type: 'test'
2026-10-14T13:53:09.059Z   ...
2026-10-14T13:53:10.687Z # Subtest: workflow_run: a workflow follows another one on the default branch
2026-10-14T13:53:10.688Z ok 6 - workflow_run: a workflow follows another one on the default branch
2026-10-14T13:53:10.692Z   ---
2026-10-14T13:53:10.692Z   duration_ms: 1630.401993
2026-10-14T13:53:10.692Z   type: 'test'
2026-10-14T13:53:10.692Z   ...
2026-10-14T13:53:15.982Z # Subtest: triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-14T13:53:15.982Z ok 7 - triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-14T13:53:15.982Z   ---
2026-10-14T13:53:15.982Z   duration_ms: 5291.538274
2026-10-14T13:53:15.982Z   type: 'test'
2026-10-14T13:53:15.982Z   ...
2026-10-14T13:53:24.704Z # Subtest: pull requests: test merge commits, pull_request_target and the merge queue
2026-10-14T13:53:24.707Z ok 8 - pull requests: test merge commits, pull_request_target and the merge queue
2026-10-14T13:53:24.708Z   ---
2026-10-14T13:53:24.708Z   duration_ms: 8725.18633
2026-10-14T13:53:24.708Z   type: 'test'
2026-10-14T13:53:24.708Z   ...
2026-10-14T13:53:30.639Z # Subtest: workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-14T13:53:30.640Z ok 9 - workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-14T13:53:30.640Z   ---
2026-10-14T13:53:30.640Z   duration_ms: 5928.826687
2026-10-14T13:53:30.640Z   type: 'test'
2026-10-14T13:53:30.640Z   ...