Diffinery runner: job e2e (End-to-end (real histories)) for codician/diffinery@666ab0ca8ae5Runner: image diffinery-runner:4d3bf17f06575e64ab4155b3, in ams13, WEUR, container 5cbec4e0ee05e7a5829dfc199e06b9154e06e1fd55a1902baf04cde6cc7af692Runner 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 1), 4 vCPUs, 2000 MHzWorkspace: /workspace/diffineryHost: 6% of the vCPUs' time went to other work on the host (steal)Job completed with conclusion: failureResources: 0.5 of 4 vCPUs busy on average (1.7 at the 95th percentile), peak memory 1.2 GiB of 11.9 GiB, peak disk 2.1 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)
remote: Total 774 (delta 0), reused 774 (delta 0)        Receiving objects:  98% (759/774)
Receiving objects:  99% (767/774)
Receiving objects: 100% (774/774)
Receiving objects: 100% (774/774), 3.55 MiB | 12.39 MiB/s, done.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 2.1s##[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 159, downloaded 0, added 0Progress: resolved 250, reused 244, downloaded 0, added 157Progress: resolved 250, reused 244, downloaded 0, added 186Progress: resolved 250, reused 244, downloaded 0, added 250, done.../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js.../esbuild@0.28.1/node_modules/esbuild postinstall$ node install.js.../esbuild@0.25.12/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../node_modules/workerd postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js.../esbuild@0.25.11/node_modules/esbuild postinstall: Done.../node_modules/workerd postinstall: Done.../esbuild@0.28.1/node_modules/esbuild postinstall: Done.../esbuild@0.25.12/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall: DonedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 10.8s using pnpm v10.28.0

##[group]Run pnpm -r --if-present build##[endgroup]Scope: 7 of 8 workspace projectsapps/diffinery build$ node islands/build.mjs && node scripts/build-docs.mjsapps/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);"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);"apps/cli build:   dist/diffinery.mjs  460.5kbapps/cli build: ⚡ Done in 238msapps/cli build: Donecontainers/runner build:   dist/agent.mjs  684.1kbcontainers/runner build: ⚡ Done in 257mscontainers/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 "histories" 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: real histories: whole projects, side by side    # Subtest: real histories: jquery's whole history goes in one push and clones back intact    not ok 1 - real histories: jquery's whole history goes in one push and clones back intact      ---      duration_ms: 0      type: 'test'      location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2935:5'      failureType: 'cancelledByParent'      error: 'test did not finish before its parent and was cancelled'      code: 'ERR_TEST_FAILURE'      ...    # Subtest: real histories: tornado's whole history goes in one push and clones back intact    not ok 2 - real histories: tornado's whole history goes in one push and clones back intact      ---      duration_ms: 0      type: 'test'      location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2935:5'      failureType: 'cancelledByParent'      error: 'test did not finish before its parent and was cancelled'      code: 'ERR_TEST_FAILURE'      ...    # Subtest: real histories: flask's whole history goes in one push and clones back intact    not ok 3 - real histories: flask's whole history goes in one push and clones back intact      ---      duration_ms: 0      type: 'test'      location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2935:5'      failureType: 'cancelledByParent'      error: 'test did not finish before its parent and was cancelled'      code: 'ERR_TEST_FAILURE'      ...    # Subtest: real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small push    not ok 4 - real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small push      ---      duration_ms: 0      type: 'test'      location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2942:3'      failureType: 'cancelledByParent'      error: 'test did not finish before its parent and was cancelled'      code: 'ERR_TEST_FAILURE'      ...    1..4not ok 1 - real histories: whole projects, side by side  ---  duration_ms: 165661.917664  type: 'suite'  location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2927:1'  failureType: 'hookFailed'  error: |-    timed out waiting for wrangler dev    --- wrangler log tail ---    dflare/workerd-linux-64/bin/workerd@5ad15fe /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@21b5ca6 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5a404cd /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2159d90 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@215cd18 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@21430f2 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143108 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5b18586 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143154 /lib/x86_64-linux-gnu/libc.so.6@2a1c9 /lib/x86_64-linux-gnu/libc.so.6@2a28a /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143024        ✘ [ERROR] The Workers runtime failed to start. There was likely a problem with the workerd binary or your configuration.          Runtime stderr:      *** Fatal uncaught kj::Exception: rust/cxx/kj-rs-io/ffi.rs:209: failed: bind(): Address already in use (os error 98)      stack: /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@22abd7b /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@21b780b /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5ad181e /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5ad15fe /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@21b5ca6 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5a404cd /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2159d90 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@215cd18 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@21430f2 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143108 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@5b18586 /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143154 /lib/x86_64-linux-gnu/libc.so.6@2a1c9 /lib/x86_64-linux-gnu/libc.so.6@2a28a /workspace/diffinery/node_modules/.pnpm/@cloudflare+workerd-linux-64@1.20261006.1/node_modules/@cloudflare/workerd-linux-64/bin/workerd@2143024            If you think this is a bug then please create an issue at https://github.com/cloudflare/workers-sdk/issues/new/choose    Note that there is a newer version of Wrangler available (4.152.0). Consider checking whether upgrading resolves this error.    🪵  Logs were written to "/tmp/diffinery-e2e-3YdvKv/wrangler-debug.log"      code: 'ERR_ASSERTION'  name: 'AssertionError'  operator: 'fail'  stack: |-    startServer (file:///workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:203:34)    process.processTicksAndRejections (node:internal/process/task_queues:105:5)    async TestContext.<anonymous> (file:///workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:231:30)    async TestHook.run (node:internal/test_runner/test:1054:7)  ...1..1# tests 4# suites 1# pass 0# fail 0# cancelled 4# skipped 0# todo 0# duration_ms 169453.106821##[error]Process completed with exit code 1.

Pruning is unnecessary.

Removing persisted credentials