End-to-end (real histories)
took 4m 12s Raw logs
Matrix: name: real histories, shard: histories
Set up job
Diffinery runner: job e2e (End-to-end (real histories)) for codician/diffinery@92ce491cb536Runner: image diffinery-runner:0d9b89e0a449e5faecf2b19c, in mrs04, WEUR, container 10cf76ac589768fd5c98e1932b86b1573fa993090ffe2366d95096598068a306Runner 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 sizeHost: AMD EPYC (family 25, model 17), 4 vCPUs, 2546 MHzWorkspace: /workspace/diffineryHost: 2% 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 (1.9 at the 95th percentile), peak memory 3.7 GiB of 11.9 GiB, peak disk 3.0 GB of 19.3 GB
Run actions/checkout@v42s
##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 627, done. Receiving objects: 0% (1/627) Receiving objects: 1% (7/627) Receiving objects: 2% (13/627) Receiving objects: 3% (19/627) Receiving objects: 4% (26/627) Receiving objects: 5% (32/627) Receiving objects: 6% (38/627) Receiving objects: 7% (44/627) Receiving objects: 8% (51/627) Receiving objects: 9% (57/627) Receiving objects: 10% (63/627) Receiving objects: 11% (69/627) Receiving objects: 12% (76/627) Receiving objects: 13% (82/627) Receiving objects: 14% (88/627) Receiving objects: 15% (95/627) Receiving objects: 16% (101/627) Receiving objects: 17% (107/627) Receiving objects: 18% (113/627) Receiving objects: 19% (120/627) Receiving objects: 20% (126/627) Receiving objects: 21% (132/627) Receiving objects: 22% (138/627) Receiving objects: 23% (145/627) Receiving objects: 24% (151/627) Receiving objects: 25% (157/627) Receiving objects: 26% (164/627) Receiving objects: 27% (170/627) Receiving objects: 28% (176/627) Receiving objects: 29% (182/627) Receiving objects: 30% (189/627) Receiving objects: 31% (195/627) Receiving objects: 32% (201/627) Receiving objects: 33% (207/627) Receiving objects: 34% (214/627) Receiving objects: 35% (220/627) Receiving objects: 36% (226/627) Receiving objects: 37% (232/627) Receiving objects: 38% (239/627) Receiving objects: 39% (245/627) Receiving objects: 40% (251/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 41% (258/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 42% (264/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 43% (270/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 44% (276/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 45% (283/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 46% (289/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 47% (295/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 48% (301/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 49% (308/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 50% (314/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 51% (320/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 52% (327/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 53% (333/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 54% (339/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 55% (345/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 56% (352/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 57% (358/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 58% (364/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 59% (370/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 60% (377/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 61% (383/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 62% (389/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 63% (396/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 64% (402/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 65% (408/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 66% (414/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 67% (421/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 68% (427/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 69% (433/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 70% (439/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 71% (446/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 72% (452/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 73% (458/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 74% (464/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 75% (471/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 76% (477/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 77% (483/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 78% (490/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 79% (496/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 80% (502/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 81% (508/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 82% (515/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 83% (521/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 84% (527/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 85% (533/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 86% (540/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 87% (546/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 88% (552/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 89% (559/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 90% (565/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 91% (571/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 92% (577/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 93% (584/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 94% (590/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 95% (596/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 96% (602/627), 1.07 MiB | 1.78 MiB/s remote: Total 627 (delta 0), reused 627 (delta 0) Receiving objects: 97% (609/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 98% (615/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 99% (621/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 100% (627/627), 1.07 MiB | 1.78 MiB/s Receiving objects: 100% (627/627), 2.56 MiB | 2.89 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref] 92ce491cb5366d59a6ab82284184ece981420cd7 -> origin/diffinery-checkoutNote: switching to '92ce491cb5366d59a6ab82284184ece981420cd7'.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 92ce491 Merge 8e4e0a29ee8b25f1f890486cccf22e1ad0a9835b into 166eba04023f72985ad8b85f14a9fc9195d25bc7HEAD is now at 92ce491cb5366d59a6ab82284184ece981420cd7
Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b13s
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.5s##[endgroup]Installation Completed!
Run actions/setup-node@v419s
##[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 (226515969 B)Cache restored from key: node-cache-Linux-x64-pnpm-aa519d0d5d7e5a224fb440987e5331e1cb7b3a95e67805db372d6def9572f2b0
Run pnpm install --frozen-lockfile15s
##[group]Run pnpm install --frozen-lockfile##[endgroup]Scope: all 7 workspace projectsLockfile is up to date, resolution step is skippedProgress: resolved 1, reused 0, downloaded 0, added 0Packages: +249++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++Progress: resolved 249, reused 243, downloaded 0, added 113Progress: resolved 249, reused 243, downloaded 0, added 249, donedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 14.4s using pnpm v10.28.0
Run pnpm -r --if-present build2s
##[group]Run pnpm -r --if-present build##[endgroup]Scope: 6 of 7 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);"containers/runner build: dist/agent.mjs 666.9kbcontainers/runner build: ⚡ Done in 90mscontainers/runner build: Doneapps/cli build: dist/diffinery.mjs 444.7kbapps/cli build: ⚡ Done in 89msapps/cli build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/diffinery build: docs: 65 pages (+2 generated at runtime), CLI 0.1.0 (234 KiB)apps/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 tests3m 30s
##[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 "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"node --test --test-concurrency=1 "${opts[@]}" $files##[endgroup]test/e2e/e2e.test.mjsTAP version 13# Subtest: real histories: jquery's whole history goes in one push and clones back intactok 1 - real histories: jquery's whole history goes in one push and clones back intact --- duration_ms: 90842.741101 type: 'test' ...# Subtest: real histories: tornado's whole history goes in one push and clones back intactok 2 - real histories: tornado's whole history goes in one push and clones back intact --- duration_ms: 43177.677733 type: 'test' ...# Subtest: real histories: flask's whole history goes in one push and clones back intactok 3 - real histories: flask's whole history goes in one push and clones back intact --- duration_ms: 36252.928788 type: 'test' ...# Subtest: real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small pushok 4 - real histories: a 2.6 MB lockfile's 60 versions, a chain of deltas, go in one small push --- duration_ms: 33064.289822 type: 'test' ...1..4# tests 4# suites 0# pass 4# fail 0# cancelled 0# skipped 0# todo 0# duration_ms 206513.881134
Post Run actions/setup-node@v40s
Cache hit occurred on the primary key node-cache-Linux-x64-pnpm-aa519d0d5d7e5a224fb440987e5331e1cb7b3a95e67805db372d6def9572f2b0, not saving cache.Post Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b10s
Pruning is unnecessary.Post Run actions/checkout@v40s
Removing persisted credentials