2026-10-24T11:41:57.644Z Diffinery runner: job e2e (End-to-end (git, PRs, Actions)) for codician/diffinery@e3341927abfa
2026-10-24T11:41:57.656Z Runner: image diffinery-runner:4d3bf17f06575e64ab4155b3, in muc01, WEUR, container cbc2b52fe5af29c55039b6fb0485a7ef20d63f7f250392a94db80fae5e4e24da
2026-10-24T11:41:57.656Z Runner size: large (4 vCPU, 12 GiB of memory, 20 GB of disk), an earlier run of this job wasn't measured; runs-on: diffinery-large (or -medium, -small, -tiny) sets a size
2026-10-24T11:41:57.656Z Host: AMD EPYC (family 25, model 17), 4 vCPUs, 2550 MHz
2026-10-24T11:41:57.657Z Workspace: /workspace/diffinery
2026-10-24T11:41:57.722Z ##[group]Run actions/checkout@v4
2026-10-24T11:41:57.723Z ##[endgroup]
2026-10-24T11:41:57.724Z Syncing repository: codician/diffinery
2026-10-24T11:41:57.766Z Fetching the repository (depth 1)
2026-10-24T11:41:58.405Z remote: Enumerating objects: 785, done.        
2026-10-24T11:41:58.687Z Receiving objects:   0% (1/785)
Receiving objects:   1% (8/785)
Receiving objects:   2% (16/785)
Receiving objects:   3% (24/785)
Receiving objects:   4% (32/785)
Receiving objects:   5% (40/785)
Receiving objects:   6% (48/785)
Receiving objects:   7% (55/785)
Receiving objects:   8% (63/785)
Receiving objects:   9% (71/785)
Receiving objects:  10% (79/785)
Receiving objects:  11% (87/785)
Receiving objects:  12% (95/785)
Receiving objects:  13% (103/785)
Receiving objects:  14% (110/785)
Receiving objects:  15% (118/785)
Receiving objects:  16% (126/785)
Receiving objects:  17% (134/785)
Receiving objects:  18% (142/785)
Receiving objects:  19% (150/785)
Receiving objects:  20% (157/785)
Receiving objects:  21% (165/785)
Receiving objects:  22% (173/785)
Receiving objects:  23% (181/785)
Receiving objects:  24% (189/785)
Receiving objects:  25% (197/785)
Receiving objects:  26% (205/785)
Receiving objects:  27% (212/785)
Receiving objects:  28% (220/785)
Receiving objects:  29% (228/785)
Receiving objects:  30% (236/785)
Receiving objects:  31% (244/785)
Receiving objects:  32% (252/785)
Receiving objects:  33% (260/785)
Receiving objects:  34% (267/785)
Receiving objects:  35% (275/785)
Receiving objects:  36% (283/785)
Receiving objects:  37% (291/785)
Receiving objects:  38% (299/785)
Receiving objects:  39% (307/785)
Receiving objects:  40% (314/785)
Receiving objects:  41% (322/785)
Receiving objects:  42% (330/785)
Receiving objects:  43% (338/785)
Receiving objects:  44% (346/785)
Receiving objects:  45% (354/785)
Receiving objects:  46% (362/785)
Receiving objects:  47% (369/785)
Receiving objects:  48% (377/785)
Receiving objects:  49% (385/785)
Receiving objects:  50% (393/785)
Receiving objects:  51% (401/785)
Receiving objects:  52% (409/785)
Receiving objects:  53% (417/785)
Receiving objects:  54% (424/785)
Receiving objects:  55% (432/785)
Receiving objects:  56% (440/785)
Receiving objects:  57% (448/785)
Receiving objects:  58% (456/785)
Receiving objects:  59% (464/785)
Receiving objects:  60% (471/785)
Receiving objects:  61% (479/785)
Receiving objects:  62% (487/785)
Receiving objects:  63% (495/785)
Receiving objects:  64% (503/785)
Receiving objects:  65% (511/785)
Receiving objects:  66% (519/785)
Receiving objects:  67% (526/785)
Receiving objects:  68% (534/785)
Receiving objects:  69% (542/785)
Receiving objects:  70% (550/785)
Receiving objects:  71% (558/785)
Receiving objects:  72% (566/785)
Receiving objects:  73% (574/785)
Receiving objects:  74% (581/785)
Receiving objects:  75% (589/785)
Receiving objects:  76% (597/785)
Receiving objects:  77% (605/785)
Receiving objects:  78% (613/785)
Receiving objects:  79% (621/785)
Receiving objects:  80% (628/785)
Receiving objects:  81% (636/785)
Receiving objects:  82% (644/785)
Receiving objects:  83% (652/785)
Receiving objects:  84% (660/785)
Receiving objects:  85% (668/785)
Receiving objects:  86% (676/785)
Receiving objects:  87% (683/785)
Receiving objects:  88% (691/785)
Receiving objects:  89% (699/785)
Receiving objects:  90% (707/785)
Receiving objects:  91% (715/785)
Receiving objects:  92% (723/785)
Receiving objects:  93% (731/785)
Receiving objects:  94% (738/785)
Receiving objects:  95% (746/785)
Receiving objects:  96% (754/785)
Receiving objects:  97% (762/785)
remote: Total 785 (delta 0), reused 785 (delta 0)        
2026-10-24T11:41:58.689Z Receiving objects:  98% (770/785)
Receiving objects:  99% (778/785)
Receiving objects: 100% (785/785)
Receiving objects: 100% (785/785), 3.59 MiB | 13.04 MiB/s, done.
2026-10-24T11:41:58.707Z From https://diffinery.com/codician/diffinery
2026-10-24T11:41:58.707Z  * [new ref]         e3341927abfa418a134b053860d307ed4dea5f29 -> origin/main
2026-10-24T11:41:58.790Z Switched to a new branch 'main'
2026-10-24T11:41:58.794Z HEAD is now at e3341927abfa418a134b053860d307ed4dea5f29
2026-10-24T11:41:58.928Z Download action repository 'pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1'
2026-10-24T11:41:59.297Z ##[group]Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1
2026-10-24T11:41:59.297Z with:
2026-10-24T11:41:59.297Z   dest: ~/setup-pnpm
2026-10-24T11:41:59.297Z   run_install: null
2026-10-24T11:41:59.297Z   cache: false
2026-10-24T11:41:59.297Z   cache_dependency_path: pnpm-lock.yaml
2026-10-24T11:41:59.297Z   package_json_file: package.json
2026-10-24T11:41:59.297Z   standalone: false
2026-10-24T11:41:59.297Z ##[endgroup]
2026-10-24T11:41:59.456Z ##[group]Running self-installer...
2026-10-24T11:41:59.987Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-24T11:41:59.995Z Packages: +1
2026-10-24T11:41:59.995Z +
2026-10-24T11:42:00.428Z Progress: resolved 1, reused 0, downloaded 1, added 1, done
2026-10-24T11:42:00.455Z 
2026-10-24T11:42:00.455Z dependencies:
2026-10-24T11:42:00.455Z + pnpm 10.28.0 (12.15.0 is available)
2026-10-24T11:42:00.455Z 
2026-10-24T11:42:00.457Z Done in 805ms
2026-10-24T11:42:00.474Z ##[endgroup]
2026-10-24T11:42:00.474Z Installation Completed!
2026-10-24T11:42:00.592Z ##[group]Run actions/setup-node@v4
2026-10-24T11:42:00.592Z with:
2026-10-24T11:42:00.592Z   node-version: 22
2026-10-24T11:42:00.592Z   cache: pnpm
2026-10-24T11:42:00.592Z ##[endgroup]
2026-10-24T11:42:00.597Z Found in cache @ 22.22.0 (pre-installed node satisfies '22')
2026-10-24T11:42:01.876Z Cache Size: ~216 MB (226934503 B)
2026-10-24T11:42:06.153Z Cache restored from key: node-cache-Linux-x64-pnpm-42d02c0263a3b5f911ed6ae8e9210922b97166ca02e60b2c70c55dfa1f00371b
2026-10-24T11:42:06.236Z ##[group]Run pnpm install --frozen-lockfile
2026-10-24T11:42:06.236Z ##[endgroup]
2026-10-24T11:42:06.542Z Scope: all 8 workspace projects
2026-10-24T11:42:06.587Z Lockfile is up to date, resolution step is skipped
2026-10-24T11:42:06.627Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-24T11:42:06.668Z Packages: +251
2026-10-24T11:42:06.668Z ++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2026-10-24T11:42:07.628Z Progress: resolved 251, reused 245, downloaded 0, added 250
2026-10-24T11:42:07.704Z Progress: resolved 251, reused 245, downloaded 0, added 251, done
2026-10-24T11:42:07.795Z .../node_modules/workerd postinstall$ node install.js
2026-10-24T11:42:07.796Z .../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js
2026-10-24T11:42:07.797Z .../node_modules/workerd postinstall$ node install.js
2026-10-24T11:42:07.797Z .../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js
2026-10-24T11:42:07.798Z .../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js
2026-10-24T11:42:07.860Z .../esbuild@0.25.12/node_modules/esbuild postinstall: Done
2026-10-24T11:42:07.865Z .../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js
2026-10-24T11:42:07.873Z .../esbuild@0.28.1/node_modules/esbuild postinstall: Done
2026-10-24T11:42:08.011Z .../node_modules/workerd postinstall: Done
2026-10-24T11:42:08.061Z .../node_modules/workerd postinstall: Done
2026-10-24T11:42:08.061Z .../esbuild@0.25.11/node_modules/esbuild postinstall: Done
2026-10-24T11:42:08.067Z .../esbuild@0.28.2/node_modules/esbuild postinstall: Done
2026-10-24T11:42:08.447Z 
2026-10-24T11:42:08.447Z devDependencies:
2026-10-24T11:42:08.447Z + turbo 2.11.7
2026-10-24T11:42:08.447Z + typescript 5.9.3
2026-10-24T11:42:08.447Z 
2026-10-24T11:42:08.835Z Done in 2.5s using pnpm v10.28.0
2026-10-24T11:42:08.939Z ##[group]Run pnpm -r --if-present build
2026-10-24T11:42:08.939Z ##[endgroup]
2026-10-24T11:42:09.207Z Scope: 7 of 8 workspace projects
2026-10-24T11:42:09.210Z apps/cli build$ esbuild src/bin.ts --bundle --platform=node --target=node22 --format=esm --outfile=dist/diffinery.mjs "--banner:js=#!/usr/bin/env node
2026-10-24T11:42:09.210Z import { createRequire as __diffineryCreateRequire } from 'node:module'; const require = __diffineryCreateRequire(import.meta.url);"
2026-10-24T11:42:09.210Z apps/diffinery build$ node islands/build.mjs && node scripts/build-docs.mjs
2026-10-24T11:42:09.211Z containers/runner build$ 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-24T11:42:09.276Z apps/cli build:   dist/diffinery.mjs  465.9kb
2026-10-24T11:42:09.276Z apps/cli build: ⚡ Done in 50ms
2026-10-24T11:42:09.279Z apps/cli build: Done
2026-10-24T11:42:09.282Z containers/runner build:   dist/agent.mjs  684.1kb
2026-10-24T11:42:09.282Z containers/runner build: ⚡ Done in 57ms
2026-10-24T11:42:09.284Z containers/runner build: Done
2026-10-24T11:42:09.895Z apps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KB
2026-10-24T11:42:10.116Z apps/diffinery build: docs: 75 pages (+2 generated at runtime), 10 site pages, 11 images, CLI 0.1.0 (248 KiB), editor extension 0.1.1 (20 KiB), JetBrains plugin 0.1.0 (64 KiB), Claude Code plugins diffinery 0.1.1, diffinery-ci 0.2.1
2026-10-24T11:42:10.124Z apps/diffinery build: Done
2026-10-24T11:42:10.299Z ##[group]Run # Shards of similar length; a new test file runs in "rest" unless it's added to another.
2026-10-24T11:42:10.299Z core='/e2e\.test\.mjs$'
2026-10-24T11:42:10.299Z agents='/(agentic|review|tasks)\.test\.mjs$'
2026-10-24T11:42:10.299Z # security.test.mjs, security-*.test.mjs (security-txt's too) and status.test.mjs.
2026-10-24T11:42:10.299Z security='/(security(-[a-z-]+)?|status)\.test\.mjs$'
2026-10-24T11:42:10.299Z # The core file's real histories and large pushes take minutes each (jquery's alone 2 to 3 on
2026-10-24T11:42:10.299Z # Diffinery's runners): two shards of their own, so no part of the file runs into node's
2026-10-24T11:42:10.299Z # per-file timeout, which is the --test-timeout here.
2026-10-24T11:42:10.299Z histories='^real histories:'
2026-10-24T11:42:10.299Z large='^(large files|large pushes):'
2026-10-24T11:42:10.299Z opts=(--test-timeout=600000)
2026-10-24T11:42:10.299Z case "core" in
2026-10-24T11:42:10.299Z   core) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-skip-pattern="$histories" --test-skip-pattern="$large") ;;
2026-10-24T11:42:10.299Z   histories) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts=(--test-timeout=900000 --test-name-pattern="$histories") ;;
2026-10-24T11:42:10.299Z   large) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-name-pattern="$large") ;;
2026-10-24T11:42:10.299Z   agents) files=$(ls test/e2e/*.test.mjs | grep -E "$agents") ;;
2026-10-24T11:42:10.299Z   security) files=$(ls test/e2e/*.test.mjs | grep -E "$security") ;;
2026-10-24T11:42:10.299Z   *) files=$(ls test/e2e/*.test.mjs | grep -vE "$core|$agents|$security") ;;
2026-10-24T11:42:10.299Z esac
2026-10-24T11:42:10.299Z echo "$files"
2026-10-24T11:42:10.299Z # Two files at a time: each starts its own local server on its own port, database and
2026-10-24T11:42:10.299Z # directory, so they don't share state, and a file's server mostly keeps one core busy.
2026-10-24T11:42:10.299Z node --test --test-concurrency=2 "${opts[@]}" $files
2026-10-24T11:42:10.299Z ##[endgroup]
2026-10-24T11:42:10.314Z test/e2e/e2e.test.mjs
2026-10-24T11:42:10.352Z TAP version 13
2026-10-24T11:42:29.811Z # Subtest: scheduled workflows: a push to the default branch registers the schedule
2026-10-24T11:42:29.811Z ok 1 - scheduled workflows: a push to the default branch registers the schedule
2026-10-24T11:42:29.811Z   ---
2026-10-24T11:42:29.811Z   duration_ms: 15165.536057
2026-10-24T11:42:29.811Z   type: 'test'
2026-10-24T11:42:29.811Z   ...
2026-10-24T11:42:33.255Z # 1 file checked: no errors, 0 warnings
2026-10-24T11:42:33.268Z # Subtest: git hosting, Actions, protected PR flow and MCP
2026-10-24T11:42:33.268Z ok 2 - git hosting, Actions, protected PR flow and MCP
2026-10-24T11:42:33.268Z   ---
2026-10-24T11:42:33.268Z   duration_ms: 3458.712408
2026-10-24T11:42:33.268Z   type: 'test'
2026-10-24T11:42:33.268Z   ...
2026-10-24T11:42:34.032Z # Subtest: reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-24T11:42:34.032Z ok 3 - reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-24T11:42:34.032Z   ---
2026-10-24T11:42:34.032Z   duration_ms: 763.763101
2026-10-24T11:42:34.032Z   type: 'test'
2026-10-24T11:42:34.032Z   ...
2026-10-24T11:42:36.321Z # Subtest: job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-24T11:42:36.321Z ok 4 - job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-24T11:42:36.321Z   ---
2026-10-24T11:42:36.321Z   duration_ms: 2289.105901
2026-10-24T11:42:36.321Z   type: 'test'
2026-10-24T11:42:36.321Z   ...
2026-10-24T11:42:37.918Z # Subtest: re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-24T11:42:37.918Z ok 5 - re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-24T11:42:37.918Z   ---
2026-10-24T11:42:37.918Z   duration_ms: 1596.780441
2026-10-24T11:42:37.918Z   type: 'test'
2026-10-24T11:42:37.918Z   ...
2026-10-24T11:42:39.392Z # Subtest: workflow_run: a workflow follows another one on the default branch
2026-10-24T11:42:39.392Z ok 6 - workflow_run: a workflow follows another one on the default branch
2026-10-24T11:42:39.392Z   ---
2026-10-24T11:42:39.392Z   duration_ms: 1473.751996
2026-10-24T11:42:39.392Z   type: 'test'
2026-10-24T11:42:39.392Z   ...
2026-10-24T11:42:41.513Z # Subtest: triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-24T11:42:41.513Z ok 7 - triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-24T11:42:41.513Z   ---
2026-10-24T11:42:41.513Z   duration_ms: 2121.271418
2026-10-24T11:42:41.513Z   type: 'test'
2026-10-24T11:42:41.513Z   ...
2026-10-24T11:42:45.230Z # Subtest: pull requests: test merge commits, pull_request_target and the merge queue
2026-10-24T11:42:45.230Z ok 8 - pull requests: test merge commits, pull_request_target and the merge queue
2026-10-24T11:42:45.231Z   ---
2026-10-24T11:42:45.231Z   duration_ms: 3716.823618
2026-10-24T11:42:45.231Z   type: 'test'
2026-10-24T11:42:45.231Z   ...
2026-10-24T11:42:47.663Z # Subtest: workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-24T11:42:47.663Z ok 9 - workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-24T11:42:47.663Z   ---
2026-10-24T11:42:47.663Z   duration_ms: 2432.259513
2026-10-24T11:42:47.663Z   type: 'test'
2026-10-24T11:42:47.663Z   ...
2026-10-24T11:42:54.589Z # Subtest: caches are scoped to branches and pull requests; artifacts keep their retention-days
2026-10-24T11:42:54.589Z ok 10 - caches are scoped to branches and pull requests; artifacts keep their retention-days
2026-10-24T11:42:54.589Z   ---
2026-10-24T11:42:54.589Z   duration_ms: 6926.363404
2026-10-24T11:42:54.589Z   type: 'test'
2026-10-24T11:42:54.589Z   ...
2026-10-24T11:42:55.008Z # Subtest: an older runner's cache API is scoped the same way
2026-10-24T11:42:55.008Z ok 11 - an older runner's cache API is scoped the same way
2026-10-24T11:42:55.008Z   ---
2026-10-24T11:42:55.008Z   duration_ms: 418.627807
2026-10-24T11:42:55.008Z   type: 'test'
2026-10-24T11:42:55.008Z   ...
2026-10-24T11:42:55.207Z # Subtest: an older runner's artifact API needs the job's own token
2026-10-24T11:42:55.207Z ok 12 - an older runner's artifact API needs the job's own token
2026-10-24T11:42:55.207Z   ---
2026-10-24T11:42:55.207Z   duration_ms: 199.74157
2026-10-24T11:42:55.207Z   type: 'test'
2026-10-24T11:42:55.207Z   ...
2026-10-24T11:42:55.964Z # Subtest: an older runner's artifacts are listed, downloaded and deleted through the REST API
2026-10-24T11:42:55.964Z ok 13 - an older runner's artifacts are listed, downloaded and deleted through the REST API
2026-10-24T11:42:55.964Z   ---
2026-10-24T11:42:55.964Z   duration_ms: 756.948245
2026-10-24T11:42:55.964Z   type: 'test'
2026-10-24T11:42:55.964Z   ...
2026-10-24T11:43:02.037Z # Subtest: containers: a job container and service containers on a self-hosted runner
2026-10-24T11:43:02.037Z ok 14 - containers: a job container and service containers on a self-hosted runner
2026-10-24T11:43:02.037Z   ---
2026-10-24T11:43:02.037Z   duration_ms: 6072.927596
2026-10-24T11:43:02.037Z   type: 'test'
2026-10-24T11:43:02.037Z   ...