Diffinery runner: job e2e (End-to-end (git, PRs, Actions)) for codician/diffinery@3285cb5194c3Runner: image diffinery-runner:8a871c84f8ee3e93f0d40c7d, in cdg17, WEUR, container b3732df2ee56095e5054a5266b7f9d0f81c262af8ed88347bab4f2718871383aRunner size: large (4 vCPU, 12 GiB of memory, 20 GB of disk), an earlier run of this job wasn't measured closely enough (busy cores every quarter second); runs-on: diffinery-large (or -medium, -small, -tiny) sets a sizeHost: AMD EPYC (family 25, model 17), 4 vCPUs, 2550 MHzWorkspace: /workspace/diffineryHost: 1% of the vCPUs' time went to other work on the host (steal)Job completed with conclusion: successResources: 1.2 of 4 vCPUs busy on average (2.2 at the 95th percentile), peak memory 2.7 GiB of 11.9 GiB, peak disk 4.5 GB of 19.3 GB

##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 684, done.        Receiving objects:   0% (1/684)
Receiving objects:   1% (7/684)
Receiving objects:   2% (14/684)
Receiving objects:   3% (21/684)
Receiving objects:   4% (28/684)
Receiving objects:   5% (35/684)
Receiving objects:   6% (42/684)
Receiving objects:   7% (48/684)
Receiving objects:   8% (55/684)
Receiving objects:   9% (62/684)
Receiving objects:  10% (69/684)
Receiving objects:  11% (76/684)
Receiving objects:  12% (83/684)
Receiving objects:  13% (89/684)
Receiving objects:  14% (96/684)
Receiving objects:  15% (103/684)
Receiving objects:  16% (110/684)
Receiving objects:  17% (117/684)
Receiving objects:  18% (124/684)
Receiving objects:  19% (130/684)
Receiving objects:  20% (137/684)
Receiving objects:  21% (144/684)
Receiving objects:  22% (151/684)
Receiving objects:  23% (158/684)
Receiving objects:  24% (165/684)
Receiving objects:  25% (171/684)
Receiving objects:  26% (178/684)
Receiving objects:  27% (185/684)
Receiving objects:  28% (192/684)
Receiving objects:  29% (199/684)
Receiving objects:  30% (206/684)
Receiving objects:  31% (213/684)
Receiving objects:  32% (219/684)
Receiving objects:  33% (226/684)
Receiving objects:  34% (233/684)
Receiving objects:  35% (240/684)
Receiving objects:  36% (247/684)
Receiving objects:  37% (254/684)
Receiving objects:  38% (260/684)
Receiving objects:  39% (267/684)
Receiving objects:  40% (274/684)
Receiving objects:  41% (281/684)
Receiving objects:  42% (288/684)
Receiving objects:  43% (295/684)
Receiving objects:  44% (301/684)
Receiving objects:  45% (308/684)
Receiving objects:  46% (315/684)
Receiving objects:  47% (322/684)
Receiving objects:  48% (329/684)
Receiving objects:  49% (336/684)
Receiving objects:  50% (342/684)
Receiving objects:  51% (349/684)
Receiving objects:  52% (356/684)
Receiving objects:  53% (363/684)
Receiving objects:  54% (370/684)
Receiving objects:  55% (377/684)
Receiving objects:  56% (384/684)
Receiving objects:  57% (390/684)
Receiving objects:  58% (397/684)
Receiving objects:  59% (404/684)
Receiving objects:  60% (411/684)
Receiving objects:  61% (418/684)
Receiving objects:  62% (425/684)
Receiving objects:  63% (431/684)
Receiving objects:  64% (438/684)
Receiving objects:  65% (445/684)
Receiving objects:  66% (452/684)
Receiving objects:  67% (459/684)
Receiving objects:  68% (466/684)
Receiving objects:  69% (472/684)
Receiving objects:  70% (479/684)
Receiving objects:  71% (486/684)
Receiving objects:  72% (493/684)
Receiving objects:  73% (500/684)
Receiving objects:  74% (507/684)
Receiving objects:  75% (513/684)
Receiving objects:  76% (520/684)
Receiving objects:  77% (527/684)
Receiving objects:  78% (534/684)
Receiving objects:  79% (541/684)
Receiving objects:  80% (548/684)
Receiving objects:  81% (555/684)
Receiving objects:  82% (561/684)
Receiving objects:  83% (568/684)
Receiving objects:  84% (575/684)
Receiving objects:  85% (582/684)
Receiving objects:  86% (589/684)
Receiving objects:  87% (596/684)
Receiving objects:  88% (602/684)
Receiving objects:  89% (609/684)
Receiving objects:  90% (616/684)
Receiving objects:  91% (623/684)
Receiving objects:  92% (630/684)
Receiving objects:  93% (637/684)
Receiving objects:  94% (643/684)
Receiving objects:  95% (650/684)
Receiving objects:  96% (657/684)
Receiving objects:  97% (664/684)
remote: Total 684 (delta 0), reused 684 (delta 0)        Receiving objects:  98% (671/684)
Receiving objects:  99% (678/684)
Receiving objects: 100% (684/684)
Receiving objects: 100% (684/684), 3.04 MiB | 10.37 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref]         3285cb5194c3ef66adfd4daf88405afda366e582 -> origin/diffinery-checkoutNote: switching to '3285cb5194c3ef66adfd4daf88405afda366e582'.You are in 'detached HEAD' state. You can look around, make experimentalchanges and commit them, and you can discard any commits you make in thisstate without impacting any branches by switching back to a branch.If you want to create a new branch to retain commits you create, you maydo so (now or later) by using -c with the switch command. Example:  git switch -c <new-branch-name>Or undo this operation with:  git switch -Turn off this advice by setting config variable advice.detachedHead to falseHEAD is now at 3285cb5 Merge 11b484eb44bbbb78ee6e4bf36ac6e79ac0a23906 into 920d91b8132629a155b28c9eb283e6c4cc12e3e7HEAD is now at 3285cb5194c3ef66adfd4daf88405afda366e582

Download action repository 'pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1'##[group]Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b1with:  dest: ~/setup-pnpm  run_install: null  cache: false  cache_dependency_path: pnpm-lock.yaml  package_json_file: package.json  standalone: false##[endgroup]##[group]Running self-installer...Progress: resolved 1, reused 0, downloaded 0, added 0Packages: +1+Progress: resolved 1, reused 0, downloaded 1, added 1, donedependencies:+ pnpm 10.28.0 (12.14.0 is available)Done in 1.3s##[endgroup]Installation Completed!

##[group]Run actions/setup-node@v4with:  node-version: 22  cache: pnpm##[endgroup]Found in cache @ 22.22.0 (pre-installed node satisfies '22')Cache Size: ~216 MB (226493609 B)Cache restored from key: node-cache-Linux-x64-pnpm-a02ba8dce5cb7329b868883337d1a03f862819a15859861dae22d3a8b1092f41

##[group]Run pnpm install --frozen-lockfile##[endgroup]Scope: all 8 workspace projectsLockfile is up to date, resolution step is skippedProgress: resolved 1, reused 0, downloaded 0, added 0Packages: +250++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++Progress: resolved 250, reused 244, downloaded 0, added 249Progress: resolved 250, reused 244, downloaded 0, added 250, done.../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall: Done.../esbuild@0.25.12/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall: Done.../esbuild@0.25.11/node_modules/esbuild postinstall: Done.../esbuild@0.28.1/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall: DonedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 3.1s using pnpm v10.28.0

##[group]Run pnpm -r --if-present build##[endgroup]Scope: 7 of 8 workspace projectsapps/cli build$ esbuild src/bin.ts --bundle --platform=node --target=node22 --format=esm --outfile=dist/diffinery.mjs "--banner:js=#!/usr/bin/env nodeimport { createRequire as __diffineryCreateRequire } from 'node:module'; const require = __diffineryCreateRequire(import.meta.url);"apps/diffinery build$ node islands/build.mjs && node scripts/build-docs.mjscontainers/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);"apps/cli build:   dist/diffinery.mjs  446.1kbapps/cli build: ⚡ Done in 75mscontainers/runner build:   dist/agent.mjs  682.1kbcontainers/runner build: ⚡ Done in 72msapps/cli build: Donecontainers/runner build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/diffinery build: docs: 72 pages (+2 generated at runtime), 6 images, CLI 0.1.0 (235 KiB), editor extension 0.1.1 (20 KiB)apps/diffinery build: Done

##[group]Run # Shards of similar length; a new test file runs in "rest" unless it's added to another.core='/e2e\.test\.mjs$'agents='/(agentic|review|tasks)\.test\.mjs$'security='/(security|status)\.test\.mjs$'# The core file's real histories and large pushes take minutes each (jquery's alone 2 to 3 on# Diffinery's runners): two shards of their own, so no part of the file runs into node's# per-file timeout, which is the --test-timeout here.histories='^real histories:'large='^(large files|large pushes):'opts=(--test-timeout=600000)case "core" in  core) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-skip-pattern="$histories" --test-skip-pattern="$large") ;;  histories) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts=(--test-timeout=900000 --test-name-pattern="$histories") ;;  large) files=$(ls test/e2e/*.test.mjs | grep -E "$core"); opts+=(--test-name-pattern="$large") ;;  agents) files=$(ls test/e2e/*.test.mjs | grep -E "$agents") ;;  security) files=$(ls test/e2e/*.test.mjs | grep -E "$security") ;;  *) files=$(ls test/e2e/*.test.mjs | grep -vE "$core|$agents|$security") ;;esacecho "$files"node --test --test-concurrency=1 "${opts[@]}" $files##[endgroup]test/e2e/e2e.test.mjsTAP version 13# Subtest: scheduled workflows: a push to the default branch registers the scheduleok 1 - scheduled workflows: a push to the default branch registers the schedule  ---  duration_ms: 21019.843107  type: 'test'  ...# 1 file checked: no errors, 0 warnings# Subtest: git hosting, Actions, protected PR flow and MCPok 2 - git hosting, Actions, protected PR flow and MCP  ---  duration_ms: 8544.521933  type: 'test'  ...# Subtest: reusable workflows: inputs, secrets, outputs, nesting and skipped callsok 3 - reusable workflows: inputs, secrets, outputs, nesting and skipped calls  ---  duration_ms: 1082.051183  type: 'test'  ...# Subtest: job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloadsok 4 - job graph: needs-only scheduling, skip cascades, per-leg runs-on, continue-on-error, job concurrency and public payloads  ---  duration_ms: 3261.06806  type: 'test'  ...# Subtest: re-runs: failed jobs only keep what passed, and one job re-runs with what depends on itok 5 - re-runs: failed jobs only keep what passed, and one job re-runs with what depends on it  ---  duration_ms: 2199.517075  type: 'test'  ...# Subtest: workflow_run: a workflow follows another one on the default branchok 6 - workflow_run: a workflow follows another one on the default branch  ---  duration_ms: 1585.294541  type: 'test'  ...# Subtest: triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent'sok 7 - triggers from workflows: a job's repository_dispatch starts runs, a follower of agent code stays an agent's  ---  duration_ms: 3013.079478  type: 'test'  ...# Subtest: pull requests: test merge commits, pull_request_target and the merge queueok 8 - pull requests: test merge commits, pull_request_target and the merge queue  ---  duration_ms: 5002.646714  type: 'test'  ...# Subtest: workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agentok 9 - workflow tokens: read-only default, no approvals or workflow edits, agent code stays an agent  ---  duration_ms: 3443.389605  type: 'test'  ...# Subtest: caches are scoped to branches and pull requests; artifacts keep their retention-daysok 10 - caches are scoped to branches and pull requests; artifacts keep their retention-days  ---  duration_ms: 8473.388892  type: 'test'  ...# Subtest: an older runner's cache API is scoped the same wayok 11 - an older runner's cache API is scoped the same way  ---  duration_ms: 658.358191  type: 'test'  ...# Subtest: an older runner's artifact API needs the job's own tokenok 12 - an older runner's artifact API needs the job's own token  ---  duration_ms: 275.458444  type: 'test'  ...# Subtest: an older runner's artifacts are listed, downloaded and deleted through the REST APIok 13 - an older runner's artifacts are listed, downloaded and deleted through the REST API  ---  duration_ms: 812.548763  type: 'test'  ...# Subtest: containers: a job container and service containers on a self-hosted runnerok 14 - containers: a job container and service containers on a self-hosted runner  ---  duration_ms: 6956.509069  type: 'test'  ...# Subtest: official actions: checkout, cache, artifacts, github-script and setup-* run unmodifiedok 15 - official actions: checkout, cache, artifacts, github-script and setup-* run unmodified  ---  duration_ms: 31899.16725  type: 'test'  ...# Subtest: official actions: the second run hits every cache and reads the first run's artifactsok 16 - official actions: the second run hits every cache and reads the first run's artifacts  ---  duration_ms: 17463.884926  type: 'test'  ...# Subtest: D1 sessions: bookmarks for token clients and browsersok 17 - D1 sessions: bookmarks for token clients and browsers  ---  duration_ms: 226.608753  type: 'test'  ...# GET /repos/dev/compat/contents/missing.txt - 404 with id UNKNOWN in 18ms# PUT /repos/dev/compat/contents/README.md - 409 with id UNKNOWN in 15ms# POST /repos/dev/compat/git/refs - 422 with id UNKNOWN in 42ms# POST /repos/dev/compat/statuses/b33ceff1ba40d9773b539f1a325e99eea31633d0 - 422 with id UNKNOWN in 70ms# POST http://127.0.0.1:33875/api/uploads/repos/dev/compat/releases/1/assets?name=hello.txt& - 422 with id UNKNOWN in 16ms# GET /repos/dev/compat/releases/2 - 404 with id UNKNOWN in 11ms# POST /repos/dev/compat/releases - 403 with id UNKNOWN in 10ms# GET /repos/dev/compat/releases/tags/v2.0.0-rc.1 - 404 with id UNKNOWN in 14ms# POST /repos/dev/compat/labels - 422 with id UNKNOWN in 11ms# GET /repos/dev/compat/issues/comments/3 - 404 with id UNKNOWN in 28ms# Subtest: GitHub REST compatibility: Octokit against releases, statuses, git data, issues, deployments and searchok 18 - GitHub REST compatibility: Octokit against releases, statuses, git data, issues, deployments and search  ---  duration_ms: 3001.264208  type: 'test'  ...# Subtest: people and profiles: visibility, repository invitations, blank names and usernamesok 19 - people and profiles: visibility, repository invitations, blank names and usernames  ---  duration_ms: 729.075042  type: 'test'  ...# Subtest: profile pictures: upload, resize, serve, cache headers and removalok 20 - profile pictures: upload, resize, serve, cache headers and removal  ---  duration_ms: 747.782267  type: 'test'  ...# Subtest: import from GitHub: git data, issues and pull requests with their numbers, no side effectsok 21 - import from GitHub: git data, issues and pull requests with their numbers, no side effects  ---  duration_ms: 14119.625585  type: 'test'  ...# Subtest: scheduled workflows: the schedule fires without a cron triggerok 22 - scheduled workflows: the schedule fires without a cron trigger  ---  duration_ms: 111.287095  type: 'test'  ...1..22# tests 22# suites 0# pass 22# fail 0# cancelled 0# skipped 0# todo 0# duration_ms 140136.511855

Cache hit occurred on the primary key node-cache-Linux-x64-pnpm-a02ba8dce5cb7329b868883337d1a03f862819a15859861dae22d3a8b1092f41, not saving cache.

Pruning is unnecessary.

Removing persisted credentials