2026-10-16T15:58:53.490Z Diffinery runner: job e2e (End-to-end (git, PRs, Actions)) for codician/diffinery@57b3e12dd69b
2026-10-16T15:58:53.502Z Runner: image diffinery-runner:37562e84d735affd46302994, in lhr14, WEUR, container 4e615eb7d37d0eeada274565d29424e428332baf318e1cec178df14dd57d3e7d
2026-10-16T15:58:53.502Z Runner size: large (4 vCPU, 12 GiB of memory, 20 GB of disk), this job uses what a smaller runner doesn't have; runs-on: diffinery-large (or -medium, -small, -tiny) sets a size
2026-10-16T15:58:53.502Z Host: AMD EPYC (family 25, model 1), 4 vCPUs, 2000 MHz
2026-10-16T15:58:53.503Z Workspace: /workspace/diffinery
2026-10-16T15:58:53.568Z ##[group]Run actions/checkout@v4
2026-10-16T15:58:53.568Z ##[endgroup]
2026-10-16T15:58:53.571Z Syncing repository: codician/diffinery
2026-10-16T15:58:53.676Z Fetching the repository (depth 1)
2026-10-16T15:58:54.599Z remote: Enumerating objects: 639, done.        
2026-10-16T15:58:55.046Z Receiving objects:   0% (1/639)
Receiving objects:   1% (7/639)
Receiving objects:   2% (13/639)
Receiving objects:   3% (20/639)
Receiving objects:   4% (26/639)
Receiving objects:   5% (32/639)
Receiving objects:   6% (39/639)
Receiving objects:   7% (45/639)
Receiving objects:   8% (52/639)
Receiving objects:   9% (58/639)
Receiving objects:  10% (64/639)
Receiving objects:  11% (71/639)
Receiving objects:  12% (77/639)
Receiving objects:  13% (84/639)
Receiving objects:  14% (90/639)
Receiving objects:  15% (96/639)
Receiving objects:  16% (103/639)
Receiving objects:  17% (109/639)
Receiving objects:  18% (116/639)
Receiving objects:  19% (122/639)
Receiving objects:  20% (128/639)
Receiving objects:  21% (135/639)
Receiving objects:  22% (141/639)
Receiving objects:  23% (147/639)
Receiving objects:  24% (154/639)
Receiving objects:  25% (160/639)
Receiving objects:  26% (167/639)
Receiving objects:  27% (173/639)
Receiving objects:  28% (179/639)
Receiving objects:  29% (186/639)
Receiving objects:  30% (192/639)
Receiving objects:  31% (199/639)
Receiving objects:  32% (205/639)
Receiving objects:  33% (211/639)
Receiving objects:  34% (218/639)
Receiving objects:  35% (224/639)
Receiving objects:  36% (231/639)
Receiving objects:  37% (237/639)
Receiving objects:  38% (243/639)
Receiving objects:  39% (250/639)
Receiving objects:  40% (256/639)
Receiving objects:  41% (262/639)
Receiving objects:  42% (269/639)
Receiving objects:  43% (275/639)
Receiving objects:  44% (282/639)
Receiving objects:  45% (288/639)
Receiving objects:  46% (294/639)
Receiving objects:  47% (301/639)
Receiving objects:  48% (307/639)
Receiving objects:  49% (314/639)
Receiving objects:  50% (320/639)
Receiving objects:  51% (326/639)
Receiving objects:  52% (333/639)
Receiving objects:  53% (339/639)
Receiving objects:  54% (346/639)
Receiving objects:  55% (352/639)
Receiving objects:  56% (358/639)
Receiving objects:  57% (365/639)
Receiving objects:  58% (371/639)
Receiving objects:  59% (378/639)
Receiving objects:  60% (384/639)
Receiving objects:  61% (390/639)
Receiving objects:  62% (397/639)
Receiving objects:  63% (403/639)
Receiving objects:  64% (409/639)
Receiving objects:  65% (416/639)
Receiving objects:  66% (422/639)
Receiving objects:  67% (429/639)
Receiving objects:  68% (435/639)
Receiving objects:  69% (441/639)
Receiving objects:  70% (448/639)
Receiving objects:  71% (454/639)
Receiving objects:  72% (461/639)
Receiving objects:  73% (467/639)
Receiving objects:  74% (473/639)
Receiving objects:  75% (480/639)
Receiving objects:  76% (486/639)
Receiving objects:  77% (493/639)
Receiving objects:  78% (499/639)
Receiving objects:  79% (505/639)
Receiving objects:  80% (512/639)
Receiving objects:  81% (518/639)
Receiving objects:  82% (524/639)
Receiving objects:  83% (531/639)
Receiving objects:  84% (537/639)
Receiving objects:  85% (544/639)
Receiving objects:  86% (550/639)
Receiving objects:  87% (556/639)
Receiving objects:  88% (563/639)
Receiving objects:  89% (569/639)
Receiving objects:  90% (576/639)
Receiving objects:  91% (582/639)
Receiving objects:  92% (588/639)
Receiving objects:  93% (595/639)
Receiving objects:  94% (601/639)
Receiving objects:  95% (608/639)
Receiving objects:  96% (614/639)
remote: Total 639 (delta 0), reused 639 (delta 0)        
2026-10-16T15:58:55.047Z Receiving objects:  97% (620/639)
Receiving objects:  98% (627/639)
Receiving objects:  99% (633/639)
Receiving objects: 100% (639/639)
Receiving objects: 100% (639/639), 2.80 MiB | 6.42 MiB/s, done.
2026-10-16T15:58:55.065Z From https://diffinery.com/codician/diffinery
2026-10-16T15:58:55.065Z  * [new ref]         57b3e12dd69b96b3e43e2f09f18b39d43ca6df66 -> origin/diffinery-checkout
2026-10-16T15:58:55.173Z Note: switching to '57b3e12dd69b96b3e43e2f09f18b39d43ca6df66'.
2026-10-16T15:58:55.173Z 
2026-10-16T15:58:55.173Z You are in 'detached HEAD' state. You can look around, make experimental
2026-10-16T15:58:55.173Z changes and commit them, and you can discard any commits you make in this
2026-10-16T15:58:55.173Z state without impacting any branches by switching back to a branch.
2026-10-16T15:58:55.173Z 
2026-10-16T15:58:55.173Z If you want to create a new branch to retain commits you create, you may
2026-10-16T15:58:55.173Z do so (now or later) by using -c with the switch command. Example:
2026-10-16T15:58:55.173Z 
2026-10-16T15:58:55.173Z   git switch -c <new-branch-name>
2026-10-16T15:58:55.173Z 
2026-10-16T15:58:55.173Z Or undo this operation with:
2026-10-16T15:58:55.173Z 
2026-10-16T15:58:55.174Z   git switch -
2026-10-16T15:58:55.174Z 
2026-10-16T15:58:55.174Z Turn off this advice by setting config variable advice.detachedHead to false
2026-10-16T15:58:55.174Z 
2026-10-16T15:58:55.174Z HEAD is now at 57b3e12 Merge df2f813943fad550406470bcd6afc03de8e9d6a8 into 3acc94948309ec7d40bdda8fc744c81bae5c23f0
2026-10-16T15:58:55.180Z HEAD is now at 57b3e12dd69b96b3e43e2f09f18b39d43ca6df66
2026-10-16T15:58:55.358Z Download action repository 'pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1'
2026-10-16T15:58:55.839Z ##[group]Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1
2026-10-16T15:58:55.839Z with:
2026-10-16T15:58:55.839Z   dest: ~/setup-pnpm
2026-10-16T15:58:55.839Z   run_install: null
2026-10-16T15:58:55.839Z   cache: false
2026-10-16T15:58:55.839Z   cache_dependency_path: pnpm-lock.yaml
2026-10-16T15:58:55.839Z   package_json_file: package.json
2026-10-16T15:58:55.839Z   standalone: false
2026-10-16T15:58:55.839Z ##[endgroup]
2026-10-16T15:58:56.261Z ##[group]Running self-installer...
2026-10-16T15:58:57.866Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-16T15:58:57.880Z Packages: +1
2026-10-16T15:58:57.880Z +
2026-10-16T15:58:58.777Z Progress: resolved 1, reused 0, downloaded 1, added 1, done
2026-10-16T15:58:58.831Z 
2026-10-16T15:58:58.831Z dependencies:
2026-10-16T15:58:58.831Z + pnpm 10.28.0 (12.14.0 is available)
2026-10-16T15:58:58.831Z 
2026-10-16T15:58:58.836Z Done in 2s
2026-10-16T15:58:58.871Z ##[endgroup]
2026-10-16T15:58:58.871Z Installation Completed!
2026-10-16T15:58:59.674Z ##[group]Run actions/setup-node@v4
2026-10-16T15:58:59.674Z with:
2026-10-16T15:58:59.674Z   node-version: 22
2026-10-16T15:58:59.674Z   cache: pnpm
2026-10-16T15:58:59.674Z ##[endgroup]
2026-10-16T15:58:59.684Z Found in cache @ 22.22.0 (pre-installed node satisfies '22')
2026-10-16T15:59:04.095Z Cache Size: ~216 MB (226515969 B)
2026-10-16T15:59:09.953Z Cache restored from key: node-cache-Linux-x64-pnpm-aa519d0d5d7e5a224fb440987e5331e1cb7b3a95e67805db372d6def9572f2b0
2026-10-16T15:59:10.090Z ##[group]Run pnpm install --frozen-lockfile
2026-10-16T15:59:10.090Z ##[endgroup]
2026-10-16T15:59:10.969Z Scope: all 7 workspace projects
2026-10-16T15:59:11.095Z Lockfile is up to date, resolution step is skipped
2026-10-16T15:59:11.177Z Progress: resolved 1, reused 0, downloaded 0, added 0
2026-10-16T15:59:11.243Z Packages: +249
2026-10-16T15:59:11.243Z ++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
2026-10-16T15:59:12.177Z Progress: resolved 249, reused 243, downloaded 0, added 106
2026-10-16T15:59:12.861Z Progress: resolved 249, reused 243, downloaded 0, added 249, done
2026-10-16T15:59:13.096Z .../node_modules/workerd postinstall$ node install.js
2026-10-16T15:59:13.098Z .../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js
2026-10-16T15:59:13.100Z .../node_modules/workerd postinstall$ node install.js
2026-10-16T15:59:13.138Z .../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js
2026-10-16T15:59:13.142Z .../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js
2026-10-16T15:59:13.301Z .../esbuild@0.28.1/node_modules/esbuild postinstall: Done
2026-10-16T15:59:13.302Z .../esbuild@0.25.11/node_modules/esbuild postinstall: Done
2026-10-16T15:59:13.302Z .../esbuild@0.25.12/node_modules/esbuild postinstall: Done
2026-10-16T15:59:13.312Z .../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js
2026-10-16T15:59:13.496Z .../node_modules/workerd postinstall: Done
2026-10-16T15:59:13.754Z .../node_modules/workerd postinstall: Done
2026-10-16T15:59:13.754Z .../esbuild@0.28.2/node_modules/esbuild postinstall: Done
2026-10-16T15:59:14.494Z 
2026-10-16T15:59:14.495Z devDependencies:
2026-10-16T15:59:14.495Z + turbo 2.11.7
2026-10-16T15:59:14.495Z + typescript 5.9.3
2026-10-16T15:59:14.495Z 
2026-10-16T15:59:15.078Z Done in 4.9s using pnpm v10.28.0
2026-10-16T15:59:15.227Z ##[group]Run pnpm -r --if-present build
2026-10-16T15:59:15.227Z ##[endgroup]
2026-10-16T15:59:15.991Z Scope: 6 of 7 workspace projects
2026-10-16T15:59:16.009Z 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-16T15:59:16.009Z import { createRequire as __diffineryCreateRequire } from 'node:module'; const require = __diffineryCreateRequire(import.meta.url);"
2026-10-16T15:59:16.009Z apps/diffinery build$ node islands/build.mjs && node scripts/build-docs.mjs
2026-10-16T15:59:16.009Z 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-16T15:59:16.332Z apps/cli build:   dist/diffinery.mjs  446.1kb
2026-10-16T15:59:16.339Z apps/cli build: ⚡ Done in 232ms
2026-10-16T15:59:16.344Z containers/runner build:   dist/agent.mjs  674.0kb
2026-10-16T15:59:16.345Z containers/runner build: ⚡ Done in 200ms
2026-10-16T15:59:16.348Z apps/cli build: Done
2026-10-16T15:59:16.352Z containers/runner build: Done
2026-10-16T15:59:17.780Z apps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KB
2026-10-16T15:59:18.296Z apps/diffinery build: docs: 70 pages (+2 generated at runtime), 3 images, CLI 0.1.0 (235 KiB)
2026-10-16T15:59:18.315Z apps/diffinery build: Done
2026-10-16T15:59:18.738Z ##[group]Run # Shards of similar length; a new test file runs in "rest" unless it's added to another.
2026-10-16T15:59:18.738Z core='/e2e\.test\.mjs$'
2026-10-16T15:59:18.738Z agents='/(agentic|review|tasks)\.test\.mjs$'
2026-10-16T15:59:18.738Z security='/(security|status)\.test\.mjs$'
2026-10-16T15:59:18.738Z # The core file's real histories and large pushes take minutes each (jquery's alone 2 to 3 on
2026-10-16T15:59:18.738Z # Diffinery's runners): two shards of their own, so no part of the file runs into node's
2026-10-16T15:59:18.738Z # per-file timeout, which is the --test-timeout here.
2026-10-16T15:59:18.738Z histories='^real histories:'
2026-10-16T15:59:18.738Z large='^(large files|large pushes):'
2026-10-16T15:59:18.738Z opts=(--test-timeout=600000)
2026-10-16T15:59:18.738Z case "core" in
2026-10-16T15:59:18.738Z   core) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-skip-pattern="$histories" --test-skip-pattern="$large") ;;
2026-10-16T15:59:18.738Z   histories) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts=(--test-timeout=900000 --test-name-pattern="$histories") ;;
2026-10-16T15:59:18.738Z   large) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-name-pattern="$large") ;;
2026-10-16T15:59:18.738Z   agents) files=$(ls test/e2e/*.test.mjs | grep -E "$agents") ;;
2026-10-16T15:59:18.738Z   security) files=$(ls test/e2e/*.test.mjs | grep -E "$security") ;;
2026-10-16T15:59:18.738Z   *) files=$(ls test/e2e/*.test.mjs | grep -vE "$core|$agents|$security") ;;
2026-10-16T15:59:18.738Z esac
2026-10-16T15:59:18.738Z echo "$files"
2026-10-16T15:59:18.738Z node --test --test-concurrency=1 "${opts[@]}" $files
2026-10-16T15:59:18.738Z ##[endgroup]
2026-10-16T15:59:18.870Z test/e2e/e2e.test.mjs
2026-10-16T15:59:18.976Z TAP version 13
2026-10-16T15:59:54.692Z # Subtest: scheduled workflows: a push to the default branch registers the schedule
2026-10-16T15:59:54.693Z ok 1 - scheduled workflows: a push to the default branch registers the schedule
2026-10-16T15:59:54.693Z   ---
2026-10-16T15:59:54.693Z   duration_ms: 31749.71661
2026-10-16T15:59:54.693Z   type: 'test'
2026-10-16T15:59:54.693Z   ...
2026-10-16T16:00:03.379Z # 1 file checked: no errors, 0 warnings
2026-10-16T16:00:03.419Z # Subtest: git hosting, Actions, protected PR flow and MCP
2026-10-16T16:00:03.419Z ok 2 - git hosting, Actions, protected PR flow and MCP
2026-10-16T16:00:03.419Z   ---
2026-10-16T16:00:03.419Z   duration_ms: 8728.640162
2026-10-16T16:00:03.419Z   type: 'test'
2026-10-16T16:00:03.419Z   ...
2026-10-16T16:00:05.624Z # Subtest: reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-16T16:00:05.624Z ok 3 - reusable workflows: inputs, secrets, outputs, nesting and skipped calls
2026-10-16T16:00:05.624Z   ---
2026-10-16T16:00:05.624Z   duration_ms: 2203.939681
2026-10-16T16:00:05.624Z   type: 'test'
2026-10-16T16:00:05.624Z   ...
2026-10-16T16:00:11.959Z # Subtest: job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-16T16:00:11.960Z ok 4 - job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads
2026-10-16T16:00:11.960Z   ---
2026-10-16T16:00:11.960Z   duration_ms: 6336.815642
2026-10-16T16:00:11.960Z   type: 'test'
2026-10-16T16:00:11.960Z   ...
2026-10-16T16:00:16.241Z # Subtest: re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-16T16:00:16.242Z ok 5 - re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it
2026-10-16T16:00:16.242Z   ---
2026-10-16T16:00:16.242Z   duration_ms: 4281.594872
2026-10-16T16:00:16.242Z   type: 'test'
2026-10-16T16:00:16.242Z   ...
2026-10-16T16:00:18.869Z # Subtest: workflow_run: a workflow follows another one on the default branch
2026-10-16T16:00:18.869Z ok 6 - workflow_run: a workflow follows another one on the default branch
2026-10-16T16:00:18.870Z   ---
2026-10-16T16:00:18.870Z   duration_ms: 2627.029223
2026-10-16T16:00:18.870Z   type: 'test'
2026-10-16T16:00:18.870Z   ...
2026-10-16T16:00:24.629Z # Subtest: triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-16T16:00:24.630Z ok 7 - triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's
2026-10-16T16:00:24.630Z   ---
2026-10-16T16:00:24.630Z   duration_ms: 5759.907656
2026-10-16T16:00:24.630Z   type: 'test'
2026-10-16T16:00:24.630Z   ...
2026-10-16T16:00:35.493Z # Subtest: pull requests: test merge commits, pull_request_target and the merge queue
2026-10-16T16:00:35.493Z ok 8 - pull requests: test merge commits, pull_request_target and the merge queue
2026-10-16T16:00:35.493Z   ---
2026-10-16T16:00:35.493Z   duration_ms: 10861.399529
2026-10-16T16:00:35.493Z   type: 'test'
2026-10-16T16:00:35.493Z   ...
2026-10-16T16:00:42.881Z # Subtest: workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-16T16:00:42.881Z ok 9 - workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent
2026-10-16T16:00:42.881Z   ---
2026-10-16T16:00:42.881Z   duration_ms: 7387.863113
2026-10-16T16:00:42.881Z   type: 'test'
2026-10-16T16:00:42.881Z   ...
2026-10-16T16:00:57.186Z # Subtest: caches are scoped to branches and pull requests; artifacts keep their retention-days
2026-10-16T16:00:57.187Z ok 10 - caches are scoped to branches and pull requests; artifacts keep their retention-days
2026-10-16T16:00:57.187Z   ---
2026-10-16T16:00:57.187Z   duration_ms: 14307.469762
2026-10-16T16:00:57.187Z   type: 'test'
2026-10-16T16:00:57.187Z   ...
2026-10-16T16:00:58.989Z # Subtest: an older runner's cache API is scoped the same way
2026-10-16T16:00:58.989Z ok 11 - an older runner's cache API is scoped the same way
2026-10-16T16:00:58.989Z   ---
2026-10-16T16:00:58.989Z   duration_ms: 1799.678718
2026-10-16T16:00:58.989Z   type: 'test'
2026-10-16T16:00:58.989Z   ...
2026-10-16T16:00:59.774Z # Subtest: an older runner's artifact API needs the job's own token
2026-10-16T16:00:59.774Z ok 12 - an older runner's artifact API needs the job's own token
2026-10-16T16:00:59.774Z   ---
2026-10-16T16:00:59.774Z   duration_ms: 787.208306
2026-10-16T16:00:59.774Z   type: 'test'
2026-10-16T16:00:59.774Z   ...
2026-10-16T16:01:01.255Z # Subtest: an older runner's artifacts are listed, downloaded and deleted through the REST API
2026-10-16T16:01:01.255Z ok 13 - an older runner's artifacts are listed, downloaded and deleted through the REST API
2026-10-16T16:01:01.255Z   ---
2026-10-16T16:01:01.255Z   duration_ms: 1480.244746
2026-10-16T16:01:01.255Z   type: 'test'
2026-10-16T16:01:01.255Z   ...
2026-10-16T16:01:10.268Z # Subtest: containers: a job container and service containers on a self-hosted runner
2026-10-16T16:01:10.270Z not ok 14 - containers: a job container and service containers on a self-hosted runner
2026-10-16T16:01:10.271Z   ---
2026-10-16T16:01:10.271Z   duration_ms: 9008.911035
2026-10-16T16:01:10.271Z   type: 'test'
2026-10-16T16:01:10.271Z   location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:1524:1'
2026-10-16T16:01:10.271Z   failureType: 'testCodeFailure'
2026-10-16T16:01:10.271Z   error: |-
2026-10-16T16:01:10.271Z     runner agent exited 1:
2026-10-16T16:01:10.271Z     [diffinery-runner] job finished: failure
2026-10-16T16:01:10.271Z     
2026-10-16T16:01:10.271Z     --- job ---
2026-10-16T16:01:10.271Z     {
2026-10-16T16:01:10.272Z       "id": "794456c12ce84a7db7e90aea2c636de1",
2026-10-16T16:01:10.272Z       "runId": "53d118a4dd594fb48ac6b0b4bec42c33",
2026-10-16T16:01:10.272Z       "key": "boxed",
2026-10-16T16:01:10.272Z       "name": "boxed",
2026-10-16T16:01:10.272Z       "status": "completed",
2026-10-16T16:01:10.272Z       "conclusion": "failure",
2026-10-16T16:01:10.272Z       "matrix": {},
2026-10-16T16:01:10.272Z       "startedAt": "2026-10-16T16:01:02.025Z",
2026-10-16T16:01:10.272Z       "completedAt": "2026-10-16T16:01:09.996Z",
2026-10-16T16:01:10.272Z       "outputs": {},
2026-10-16T16:01:10.272Z       "steps": [],
2026-10-16T16:01:10.272Z       "failure": {
2026-10-16T16:01:10.272Z         "message": "Could not pull mirror.gcr.io/library/debian:bookworm-slim (docker pull exited with 1)."
2026-10-16T16:01:10.272Z       },
2026-10-16T16:01:10.272Z       "summary": null,
2026-10-16T16:01:10.272Z       "runnerName": "e2e-runner-17",
2026-10-16T16:01:10.272Z       "runner": {
2026-10-16T16:01:10.272Z         "location": "lhr14, WEUR",
2026-10-16T16:01:10.272Z         "instance": "4e615eb7d37d0eeada274565d29424e428332baf318e1cec178df14dd57d3e7d"
2026-10-16T16:01:10.272Z       },
2026-10-16T16:01:10.272Z       "carriedFrom": null,
2026-10-16T16:01:10.272Z       "placementTries": 0,
2026-10-16T16:01:10.272Z       "restarts": 0,
2026-10-16T16:01:10.272Z       "runnerSize": null,
2026-10-16T16:01:10.272Z       "usage": null,
2026-10-16T16:01:10.272Z       "run_id": "53d118a4dd594fb48ac6b0b4bec42c33",
2026-10-16T16:01:10.272Z       "run_url": "http://127.0.0.1:44927/api/v3/repos/dev/boxes/actions/runs/53d118a4dd594fb48ac6b0b4bec42c33",
2026-10-16T16:01:10.272Z       "run_attempt": 1,
2026-10-16T16:01:10.272Z       "node_id": "Sm9iOjc5NDQ1NmMxMmNlODRhN2RiN2U5MGFlYTJjNjM2ZGUx",
2026-10-16T16:01:10.272Z       "head_sha": "54f697994fd5d89b1e1341bd334778e38cd5b9cc",
2026-10-16T16:01:10.272Z       "head_branch": "main",
2026-10-16T16:01:10.272Z       "url": "http://127.0.0.1:44927/api/v3/repos/dev/boxes/actions/jobs/794456c12ce84a7db7e90aea2c636de1",
2026-10-16T16:01:10.272Z       "html_url": "http://127.0.0.1:44927/dev/boxes/actions/runs/53d118a4dd594fb48ac6b0b4bec42c33/job/794456c12ce84a7db7e90aea2c636de1",
2026-10-16T16:01:10.272Z       "started_at": "2026-10-16T16:01:02Z",
2026-10-16T16:01:10.272Z       "completed_at": "2026-10-16T16:01:09Z",
2026-10-16T16:01:10.272Z       "workflow_name": ".github/workflows/ci.yml",
2026-10-16T16:01:10.272Z       "check_run_url": "http://127.0.0.1:44927/api/v3/repos/dev/boxes/check-runs/794456c12ce84a7db7e90aea2c636de1",
2026-10-16T16:01:10.272Z       "labels": [],
2026-10-16T16:01:10.272Z       "runner_name": "e2e-runner-17",
2026-10-16T16:01:10.272Z       "runner_size": null
2026-10-16T16:01:10.272Z     }
2026-10-16T16:01:10.272Z     --- job log ---
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.063Z Diffinery runner: job boxed (boxed) for dev/boxes@54f697994fd5
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.063Z Runner: in lhr14, WEUR, container 4e615eb7d37d0eeada274565d29424e428332baf318e1cec178df14dd57d3e7d
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.063Z Workspace: /tmp/diffinery-e2e-HDqzok/job-794456c12ce84a7db7e90aea2c636de1/boxes
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.066Z ##[group]Initialize containers
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.147Z Docker 29.9.1
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.244Z 4b7371e1b55a3b446050c05e1826e41bc6d056394844670193fd4ed60638ba5c
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.249Z ##[command]docker pull mirror.gcr.io/library/redis:7-alpine
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.686Z 7-alpine: Pulling from library/redis
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 4eb14bae0e1d: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 9928009b15c8: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 4f4fb700ef54: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 7eb50503c2b0: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 1522f9c6f453: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.951Z 16333ee0c00f: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:02.952Z 83234986c742: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.193Z 4f4fb700ef54: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.193Z 4eb14bae0e1d: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.293Z 83234986c742: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.294Z 9928009b15c8: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.401Z 7eb50503c2b0: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.592Z 16333ee0c00f: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.593Z 54779914f171: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.691Z 1522f9c6f453: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.790Z 3beebc06c4ca: Download complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.793Z 83234986c742: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.795Z 16333ee0c00f: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:03.892Z 7eb50503c2b0: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.271Z 4f4fb700ef54: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.272Z 4eb14bae0e1d: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.273Z 9928009b15c8: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.274Z 1522f9c6f453: Pull complete
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.274Z Digest: sha256:858f009f9709ce576febc734aa78b8f6d624b82571f9ddb6bda4377c833b3499
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.274Z Status: Downloaded newer image for mirror.gcr.io/library/redis:7-alpine
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.276Z mirror.gcr.io/library/redis:7-alpine
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.281Z ##[command]docker run -d --name cache_085e268efd32 --network diffinery_794456c12ce84a7db7e90aea2c636de1_e3e328 --network-alias cache --health-cmd redis-cli ping --health-interval 1s --health-retries 30 mirror.gcr.io/library/redis:7-alpine
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.630Z 0ef1ff75bd64062f066e09c1877f4e6a430ed95abfc4e638185be51a14ca97a4
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.948Z starting
2026-10-16T16:01:10.272Z     2026-10-16T16:01:04.999Z running
2026-10-16T16:01:10.272Z     2026-10-16T16:01:05.003Z Waiting for cache to be healthy (starting)...
2026-10-16T16:01:10.272Z     2026-10-16T16:01:06.042Z healthy
2026-10-16T16:01:10.272Z     2026-10-16T16:01:06.047Z cache is healthy
2026-10-16T16:01:10.272Z     2026-10-16T16:01:06.100Z Service cache is running
2026-10-16T16:01:10.272Z     2026-10-16T16:01:06.100Z ##[command]docker pull mirror.gcr.io/library/debian:bookworm-slim
2026-10-16T16:01:10.272Z     2026-10-16T16:01:07.666Z bookworm-slim: Pulling from library/debian
2026-10-16T16:01:10.272Z     2026-10-16T16:01:08.165Z 7fd1ebe418b5: Pulling fs layer
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.302Z failed to copy: httpReadSeeker: failed open: could not fetch content descriptor sha256:251000be41e0896204474fa422654d03b92ad9fa4637760a8634477a7f45b953 (application/vnd.in-toto+json) from remote: not found
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.308Z ##[endgroup]
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.308Z ##[error]Could not pull mirror.gcr.io/library/debian:bookworm-slim (docker pull exited with 1).
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.403Z Stopping 1 container
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.953Z Job completed with conclusion: failure
2026-10-16T16:01:10.272Z     2026-10-16T16:01:09.954Z Resources: 0.7 of 4 vCPUs busy on average (1.0 at the 95th percentile), peak memory 2.2 GiB of 11.9 GiB, peak disk 2.3 GB of 19.3 GB
2026-10-16T16:01:10.272Z     --- wrangler log tail ---
2026-10-16T16:01:10.272Z     ctions/runs/1/artifacts 200 OK (19ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/legacy-rest/actions/runs/1/artifacts 200 OK (20ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/legacy-rest/actions/artifacts/2 200 OK (22ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/legacy-rest/actions/artifacts/2/zip 302 Found (22ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /_runtime/blob/2a49d0c7e98a4d4d93fd9315b6b11ef2/artifact/2/two.tar.gz 200 OK (15ms)
2026-10-16T16:01:10.272Z     [wrangler:info] DELETE /api/v3/repos/dev/legacy-rest/actions/artifacts/2 204 No Content (28ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/legacy-rest/actions/artifacts/2 404 Not Found (16ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /runner/jobs/6d90f52ee1834a5ab93e48b5ee3fc44f/artifacts/two 404 Not Found (12ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /runner/jobs/6d90f52ee1834a5ab93e48b5ee3fc44f/artifacts/one 200 OK (13ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/legacy-rest/actions/artifacts 200 OK (18ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/6d90f52ee1834a5ab93e48b5ee3fc44f/complete 200 OK (46ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/user 200 OK (27ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /api/v3/user/repos 201 Created (120ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /dev/boxes.git/info/refs 200 OK (19ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /dev/boxes.git/git-receive-pack 200 OK (72ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/boxes/actions/runs 200 OK (81ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /api/v3/repos/dev/boxes/actions/runners/registration-token 201 Created (18ms)
2026-10-16T16:01:10.272Z     [wrangler:info] QUEUE diffinery-events-dev 5/5 (54ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /api/v3/repos/dev/boxes/actions/runners/register 201 Created (70ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /api/v3/repos/dev/boxes/actions/runners/claim 200 OK (13ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /runner/jobs/794456c12ce84a7db7e90aea2c636de1 200 OK (12ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (10ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (11ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (12ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (9ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (20ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (10ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (10ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (9ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (16ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (14ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (17ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (24ms)
2026-10-16T16:01:10.272Z     [wrangler:info] POST /runner/jobs/794456c12ce84a7db7e90aea2c636de1/complete 200 OK (125ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/boxes/actions/jobs/794456c12ce84a7db7e90aea2c636de1/logs 200 OK (64ms)
2026-10-16T16:01:10.272Z     [wrangler:info] GET /api/v3/repos/dev/boxes/actions/jobs/794456c12ce84a7db7e90aea2c636de1 200 OK (41ms)
2026-10-16T16:01:10.272Z     
2026-10-16T16:01:10.272Z   code: 'ERR_ASSERTION'
2026-10-16T16:01:10.272Z   name: 'AssertionError'
2026-10-16T16:01:10.272Z   operator: 'fail'
2026-10-16T16:01:10.272Z   stack: |-
2026-10-16T16:01:10.272Z     runOneJob (file:///workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:171:12)
2026-10-16T16:01:10.272Z     process.processTicksAndRejections (node:internal/process/task_queues:105:5)
2026-10-16T16:01:10.272Z     async TestContext.<anonymous> (file:///workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:1558:17)
2026-10-16T16:01:10.272Z     async Test.run (node:internal/test_runner/test:1054:7)
2026-10-16T16:01:10.272Z     async Test.processPendingSubtests (node:internal/test_runner/test:744:7)
2026-10-16T16:01:10.272Z   ...
2026-10-16T16:01:59.658Z # Subtest: official actions: checkout, cache, artifacts, github-script and setup-* run unmodified
2026-10-16T16:01:59.658Z ok 15 - official actions: checkout, cache, artifacts, github-script and setup-* run unmodified
2026-10-16T16:01:59.658Z   ---
2026-10-16T16:01:59.658Z   duration_ms: 48891.214294
2026-10-16T16:01:59.658Z   type: 'test'
2026-10-16T16:01:59.658Z   ...
2026-10-16T16:02:36.084Z # Subtest: official actions: the second run hits every cache and reads the first run's artifacts
2026-10-16T16:02:36.084Z ok 16 - official actions: the second run hits every cache and reads the first run's artifacts
2026-10-16T16:02:36.084Z   ---
2026-10-16T16:02:36.084Z   duration_ms: 36928.579789
2026-10-16T16:02:36.084Z   type: 'test'
2026-10-16T16:02:36.084Z   ...
2026-10-16T16:02:36.515Z # Subtest: D1 sessions: bookmarks for token clients and browsers
2026-10-16T16:02:36.515Z ok 17 - D1 sessions: bookmarks for token clients and browsers
2026-10-16T16:02:36.515Z   ---
2026-10-16T16:02:36.515Z   duration_ms: 378.63203
2026-10-16T16:02:36.515Z   type: 'test'
2026-10-16T16:02:36.515Z   ...
2026-10-16T16:02:37.106Z # GET /repos/dev/compat/contents/missing.txt - 404 with id UNKNOWN in 79ms
2026-10-16T16:02:37.464Z # PUT /repos/dev/compat/contents/README.md - 409 with id UNKNOWN in 86ms
2026-10-16T16:02:38.199Z # POST /repos/dev/compat/git/refs - 422 with id UNKNOWN in 41ms
2026-10-16T16:02:38.943Z # POST /repos/dev/compat/statuses/251e6550ded401f3188be139045799f754b71675 - 422 with id UNKNOWN in 37ms
2026-10-16T16:02:40.477Z # POST http://127.0.0.1:44927/api/uploads/repos/dev/compat/releases/1/assets?name=hello.txt& - 422 with id UNKNOWN in 42ms
2026-10-16T16:02:41.084Z # GET /repos/dev/compat/releases/2 - 404 with id UNKNOWN in 31ms
2026-10-16T16:02:41.109Z # POST /repos/dev/compat/releases - 403 with id UNKNOWN in 24ms
2026-10-16T16:02:41.370Z # GET /repos/dev/compat/releases/tags/v2.0.0-rc.1 - 404 with id UNKNOWN in 30ms
2026-10-16T16:02:41.879Z # POST /repos/dev/compat/labels - 422 with id UNKNOWN in 41ms
2026-10-16T16:02:43.085Z # GET /repos/dev/compat/issues/comments/3 - 404 with id UNKNOWN in 21ms
2026-10-16T16:02:44.098Z # Subtest: GitHub REST compatibility: Octokit against releases, statuses, git data, issues, deployments and search
2026-10-16T16:02:44.098Z ok 18 - GitHub REST compatibility: Octokit against releases, statuses, git data, issues, deployments and search
2026-10-16T16:02:44.098Z   ---
2026-10-16T16:02:44.098Z   duration_ms: 7636.371012
2026-10-16T16:02:44.098Z   type: 'test'
2026-10-16T16:02:44.098Z   ...
2026-10-16T16:02:46.064Z # Subtest: people and profiles: visibility, repository invitations, blank names and usernames
2026-10-16T16:02:46.064Z ok 19 - people and profiles: visibility, repository invitations, blank names and usernames
2026-10-16T16:02:46.064Z   ---
2026-10-16T16:02:46.065Z   duration_ms: 1965.524407
2026-10-16T16:02:46.065Z   type: 'test'
2026-10-16T16:02:46.065Z   ...
2026-10-16T16:02:47.488Z # Subtest: profile pictures: upload, resize, serve, cache headers and removal
2026-10-16T16:02:47.491Z ok 20 - profile pictures: upload, resize, serve, cache headers and removal
2026-10-16T16:02:47.491Z   ---
2026-10-16T16:02:47.491Z   duration_ms: 1417.302396
2026-10-16T16:02:47.491Z   type: 'test'
2026-10-16T16:02:47.491Z   ...
2026-10-16T16:03:12.265Z # Subtest: import from GitHub: git data, issues and pull requests with their numbers, no side effects
2026-10-16T16:03:12.265Z ok 21 - import from GitHub: git data, issues and pull requests with their numbers, no side effects
2026-10-16T16:03:12.265Z   ---
2026-10-16T16:03:12.265Z   duration_ms: 24783.450578
2026-10-16T16:03:12.265Z   type: 'test'
2026-10-16T16:03:12.265Z   ...
2026-10-16T16:03:15.144Z # Subtest: scheduled workflows: the schedule fires without a cron trigger
2026-10-16T16:03:15.144Z ok 22 - scheduled workflows: the schedule fires without a cron trigger
2026-10-16T16:03:15.144Z   ---
2026-10-16T16:03:15.144Z   duration_ms: 249.589189
2026-10-16T16:03:15.144Z   type: 'test'
2026-10-16T16:03:15.144Z   ...
2026-10-16T16:03:15.182Z 1..22
2026-10-16T16:03:15.183Z # tests 22
2026-10-16T16:03:15.183Z # suites 0
2026-10-16T16:03:15.183Z # pass 21
2026-10-16T16:03:15.183Z # fail 1
2026-10-16T16:03:15.183Z # cancelled 0
2026-10-16T16:03:15.183Z # skipped 0
2026-10-16T16:03:15.183Z # todo 0
2026-10-16T16:03:15.183Z # duration_ms 236235.751736
2026-10-16T16:03:15.200Z ##[error]Process completed with exit code 1.
2026-10-16T16:03:15.761Z Pruning is unnecessary.
2026-10-16T16:03:15.877Z Removing persisted credentials
2026-10-16T16:03:15.946Z Host: 3% of the vCPUs' time went to other work on the host (steal)
2026-10-16T16:03:15.946Z Job completed with conclusion: failure
2026-10-16T16:03:15.948Z Resources: 1.3 of 4 vCPUs busy on average (1.9 at the 95th percentile), peak memory 2.6 GiB of 11.9 GiB, peak disk 4.3 GB of 19.3 GB