Diffinery runner: job e2e (End-to-end (git, PRs, Actions)) for codician/diffinery@666ab0ca8ae5Runner: image diffinery-runner:4d3bf17f06575e64ab4155b3, in ams21, WEUR, container 24c128b76bcf425e0dbfcde02819dd749f5ee9153cb3691373f3bc846b23aaafRunner 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 sizeHost: AMD EPYC (family 25, model 17), 4 vCPUs, 2546 MHzWorkspace: /workspace/diffineryHost: 12% of the vCPUs' time went to other work on the host (steal)Job completed with conclusion: successResources: 1.0 of 4 vCPUs busy on average (1.6 at the 95th percentile), peak memory 2.9 GiB of 11.9 GiB, peak disk 4.4 GB of 19.2 GB

##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 774, done.        Receiving objects:   0% (1/774)
Receiving objects:   1% (8/774)
Receiving objects:   2% (16/774)
Receiving objects:   3% (24/774)
Receiving objects:   4% (31/774)
Receiving objects:   5% (39/774)
Receiving objects:   6% (47/774)
Receiving objects:   7% (55/774)
Receiving objects:   8% (62/774)
Receiving objects:   9% (70/774)
Receiving objects:  10% (78/774)
Receiving objects:  11% (86/774)
Receiving objects:  12% (93/774)
Receiving objects:  13% (101/774)
Receiving objects:  14% (109/774)
Receiving objects:  15% (117/774)
Receiving objects:  16% (124/774)
Receiving objects:  17% (132/774)
Receiving objects:  18% (140/774)
Receiving objects:  19% (148/774)
Receiving objects:  20% (155/774)
Receiving objects:  21% (163/774)
Receiving objects:  22% (171/774)
Receiving objects:  23% (179/774)
Receiving objects:  24% (186/774)
Receiving objects:  25% (194/774)
Receiving objects:  26% (202/774)
Receiving objects:  27% (209/774)
Receiving objects:  28% (217/774)
Receiving objects:  29% (225/774)
Receiving objects:  30% (233/774)
Receiving objects:  31% (240/774)
Receiving objects:  32% (248/774)
Receiving objects:  33% (256/774)
Receiving objects:  34% (264/774)
Receiving objects:  35% (271/774)
Receiving objects:  36% (279/774)
Receiving objects:  37% (287/774)
Receiving objects:  38% (295/774)
Receiving objects:  39% (302/774)
Receiving objects:  40% (310/774)
Receiving objects:  41% (318/774)
Receiving objects:  42% (326/774)
Receiving objects:  43% (333/774)
Receiving objects:  44% (341/774)
Receiving objects:  45% (349/774)
Receiving objects:  46% (357/774)
Receiving objects:  47% (364/774)
Receiving objects:  48% (372/774)
Receiving objects:  49% (380/774)
Receiving objects:  50% (387/774)
Receiving objects:  51% (395/774)
Receiving objects:  52% (403/774)
Receiving objects:  53% (411/774)
Receiving objects:  54% (418/774)
Receiving objects:  55% (426/774)
Receiving objects:  56% (434/774)
Receiving objects:  57% (442/774)
Receiving objects:  58% (449/774)
Receiving objects:  59% (457/774)
Receiving objects:  60% (465/774)
Receiving objects:  61% (473/774)
Receiving objects:  62% (480/774)
Receiving objects:  63% (488/774)
Receiving objects:  64% (496/774)
Receiving objects:  65% (504/774)
Receiving objects:  66% (511/774)
Receiving objects:  67% (519/774)
Receiving objects:  68% (527/774)
Receiving objects:  69% (535/774)
Receiving objects:  70% (542/774)
Receiving objects:  71% (550/774)
Receiving objects:  72% (558/774)
Receiving objects:  73% (566/774)
Receiving objects:  74% (573/774)
Receiving objects:  75% (581/774)
Receiving objects:  76% (589/774)
Receiving objects:  77% (596/774)
Receiving objects:  78% (604/774)
Receiving objects:  79% (612/774)
Receiving objects:  80% (620/774)
Receiving objects:  81% (627/774)
Receiving objects:  82% (635/774)
Receiving objects:  83% (643/774)
Receiving objects:  84% (651/774)
Receiving objects:  85% (658/774)
Receiving objects:  86% (666/774)
Receiving objects:  87% (674/774)
Receiving objects:  88% (682/774)
Receiving objects:  89% (689/774)
Receiving objects:  90% (697/774)
Receiving objects:  91% (705/774)
Receiving objects:  92% (713/774)
Receiving objects:  93% (720/774)
Receiving objects:  94% (728/774)
Receiving objects:  95% (736/774)
Receiving objects:  96% (744/774)
Receiving objects:  97% (751/774)
Receiving objects:  98% (759/774)
Receiving objects:  99% (767/774)
Receiving objects: 100% (774/774)
Receiving objects: 100% (774/774), 3.55 MiB | 13.49 MiB/s, done.remote: Total 774 (delta 0), reused 774 (delta 0)        From https://diffinery.com/codician/diffinery * [new ref]         666ab0ca8ae50e42c8f275938b9e5c8637bdeb1b -> origin/diffinery-checkoutNote: switching to '666ab0ca8ae50e42c8f275938b9e5c8637bdeb1b'.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 666ab0c Merge 15f7685c149f9f5e77383ee79cad1364255285d5 into f454e336a7030237a80392a92ff01d71581b0cd0HEAD is now at 666ab0ca8ae50e42c8f275938b9e5c8637bdeb1b

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.15.0 is available)Done in 1.8s##[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 76Progress: resolved 250, reused 244, downloaded 0, added 194Progress: resolved 250, reused 244, downloaded 0, added 250, done.../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js.../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js.../esbuild@0.25.12/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js.../esbuild@0.28.1/node_modules/esbuild postinstall: Done.../node_modules/workerd postinstall: Done.../node_modules/workerd postinstall: Done.../esbuild@0.25.11/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall: DonedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 5.7s 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  460.5kbapps/cli build: ⚡ Done in 86msapps/cli build: Donecontainers/runner build:   dist/agent.mjs  684.1kbcontainers/runner build: ⚡ Done in 103mscontainers/runner build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/diffinery build: docs: 74 pages (+2 generated at runtime), 10 site pages, 11 images, CLI 0.1.0 (245 KiB), editor extension 0.1.1 (20 KiB), JetBrains plugin 0.1.0 (64 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.test.mjs, security-*.test.mjs (security-txt's too) and status.test.mjs.security='/(security(-[a-z-]+)?|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"# Two files at a time: each starts its own local server on its own port, database and# directory, so they don't share state, and a file's server mostly keeps one core busy.node --test --test-concurrency=2 "${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: 31264.801578  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: 9835.620721  type: 'test'  ...# Subtest: reusable workflows: inputs, secrets, outputs, nesting and skipped callsok 3 - reusable workflows: inputs, secrets, outputs, nesting and skipped calls  ---  duration_ms: 2492.241942  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: 6925.898109  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: 4133.487034  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: 2328.01439  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: 5620.335125  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: 10683.690941  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: 7197.473148  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: 12105.350971  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: 1287.159021  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: 617.47026  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: 1594.729689  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: 9614.008879  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: 43025.367874  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: 26556.944883  type: 'test'  ...# Subtest: D1 sessions: bookmarks for token clients and browsersok 17 - D1 sessions: bookmarks for token clients and browsers  ---  duration_ms: 402.267423  type: 'test'  ...# GET /repos/dev/compat/contents/missing.txt - 404 with id UNKNOWN in 17ms# PUT /repos/dev/compat/contents/README.md - 409 with id UNKNOWN in 28ms# POST /repos/dev/compat/git/refs - 422 with id UNKNOWN in 27ms# POST /repos/dev/compat/statuses/aca92208d158e294cbc22fd8cb823a21074dff36 - 422 with id UNKNOWN in 25ms# POST http://127.0.0.1:43245/api/uploads/repos/dev/compat/releases/1/assets?name=hello.txt& - 422 with id UNKNOWN in 27ms# GET /repos/dev/compat/releases/2 - 404 with id UNKNOWN in 23ms# POST /repos/dev/compat/releases - 403 with id UNKNOWN in 17ms# GET /repos/dev/compat/releases/tags/v2.0.0-rc.1 - 404 with id UNKNOWN in 15ms# POST /repos/dev/compat/labels - 422 with id UNKNOWN in 18ms# GET /repos/dev/compat/issues/comments/3 - 404 with id UNKNOWN in 24ms# 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: 5220.241802  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: 1621.125884  type: 'test'  ...# Subtest: profile pictures: upload, resize, serve, cache headers and removalok 20 - profile pictures: upload, resize, serve, cache headers and removal  ---  duration_ms: 911.635825  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: 20448.419173  type: 'test'  ...# Subtest: scheduled workflows: the schedule fires without a cron triggerok 22 - scheduled workflows: the schedule fires without a cron trigger  ---  duration_ms: 241.529217  type: 'test'  ...1..22# tests 22# suites 0# pass 22# fail 0# cancelled 0# skipped 0# todo 0# duration_ms 209725.677477

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

Pruning is unnecessary.

Removing persisted credentials