End-to-end (real histories)
took 2m 0s Raw logs
Matrix: name: real histories, shard: histories
Set up job
Diffinery runner: job e2e (End-to-end (real histories)) for codician/diffinery@d19f1c4b9527Runner: image diffinery-runner:4d3bf17f06575e64ab4155b3, in muc01, WEUR, container 5ee6863d48ee65bff65b67c101d65d954ec4607919698fd6153abf5175249962Runner 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, 2550 MHzWorkspace: /workspace/diffineryHost: 0% of the vCPUs' time went to other work on the host (steal)Job completed with conclusion: successResources: 2.0 of 4 vCPUs busy on average (3.4 at the 95th percentile), peak memory 7.4 GiB of 11.9 GiB, peak disk 3.1 GB of 19.2 GB
Run actions/checkout@v42s
##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 785, done. 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), 771.75 KiB | 1.36 MiB/s Receiving objects: 17% (134/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 18% (142/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 19% (150/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 20% (157/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 21% (165/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 22% (173/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 23% (181/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 24% (189/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 25% (197/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 26% (205/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 27% (212/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 28% (220/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 29% (228/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 30% (236/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 31% (244/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 32% (252/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 33% (260/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 34% (267/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 35% (275/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 36% (283/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 37% (291/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 38% (299/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 39% (307/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 40% (314/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 41% (322/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 42% (330/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 43% (338/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 44% (346/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 45% (354/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 46% (362/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 47% (369/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 48% (377/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 49% (385/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 50% (393/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 51% (401/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 52% (409/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 53% (417/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 54% (424/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 55% (432/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 56% (440/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 57% (448/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 58% (456/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 59% (464/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 60% (471/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 61% (479/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 62% (487/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 63% (495/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 64% (503/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 65% (511/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 66% (519/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 67% (526/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 68% (534/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 69% (542/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 70% (550/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 71% (558/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 72% (566/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 73% (574/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 74% (581/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 75% (589/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 76% (597/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 77% (605/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 78% (613/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 79% (621/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 80% (628/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 81% (636/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 82% (644/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 83% (652/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 84% (660/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 85% (668/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 86% (676/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 87% (683/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 88% (691/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 89% (699/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 90% (707/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 91% (715/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 92% (723/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 93% (731/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 94% (738/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 95% (746/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 96% (754/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 97% (762/785), 771.75 KiB | 1.36 MiB/s remote: Total 785 (delta 0), reused 785 (delta 0) Receiving objects: 98% (770/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 99% (778/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 100% (785/785), 771.75 KiB | 1.36 MiB/s Receiving objects: 100% (785/785), 3.59 MiB | 4.59 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref] d19f1c4b95274805580d96e212e395bf29860774 -> origin/diffinery-checkoutNote: switching to 'd19f1c4b95274805580d96e212e395bf29860774'.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 d19f1c4 Merge 306868e278d8bb6c9efd37fd81cb1793aa6f3835 into 58bd6ecb146a555bf1b6ef1a4968fa53859f8566HEAD is now at d19f1c4b95274805580d96e212e395bf29860774
Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b12s
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 875ms##[endgroup]Installation Completed!
Run actions/setup-node@v45s
##[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 (226934503 B)Cache restored from key: node-cache-Linux-x64-pnpm-42d02c0263a3b5f911ed6ae8e9210922b97166ca02e60b2c70c55dfa1f00371b
Run pnpm install --frozen-lockfile3s
##[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: +251++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++Progress: resolved 251, reused 245, downloaded 0, added 250Progress: resolved 251, reused 245, downloaded 0, added 251, done.../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$ 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: Done.../esbuild@0.28.1/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall$ node install.js.../esbuild@0.25.11/node_modules/esbuild postinstall: Done.../esbuild@0.25.12/node_modules/esbuild postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall: Done.../node_modules/workerd postinstall: DonedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 2.6s using pnpm v10.28.0
Run pnpm -r --if-present build1s
##[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 465.9kbapps/cli build: ⚡ Done in 59mscontainers/runner build: dist/agent.mjs 684.1kbcontainers/runner build: ⚡ Done in 59mscontainers/runner build: Doneapps/cli build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/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.1apps/diffinery build: Done
Run pnpm --filter @diffinery/app exec playwright install --with-deps chromium
Run as_root() { if [ "$(id -u)" = 0 ]; then "$@"; else sudo "$@"; fi; }
Run the shard's tests1m 44s
##[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 ok 1 - real histories: jquery's whole history goes in one push and clones back intact --- duration_ms: 59995.343287 type: 'test' ... # Subtest: real histories: tornado's whole history goes in one push and clones back intact ok 2 - real histories: tornado's whole history goes in one push and clones back intact --- duration_ms: 40271.807435 type: 'test' ... # Subtest: real histories: flask's whole history goes in one push and clones back intact ok 3 - real histories: flask's whole history goes in one push and clones back intact --- duration_ms: 31975.412154 type: 'test' ... # Subtest: real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small push ok 4 - real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small push --- duration_ms: 25609.543589 type: 'test' ... 1..4ok 1 - real histories: whole projects, side by side --- duration_ms: 100452.42242 type: 'suite' ...1..1# tests 4# suites 1# pass 4# fail 0# cancelled 0# skipped 0# todo 0# duration_ms 104065.04081
Post Run actions/setup-node@v40s
Cache hit occurred on the primary key node-cache-Linux-x64-pnpm-42d02c0263a3b5f911ed6ae8e9210922b97166ca02e60b2c70c55dfa1f00371b, not saving cache.Post Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b10s
Pruning is unnecessary.Post Run actions/checkout@v41s
Removing persisted credentials