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@a706b5429a82Runner: image diffinery-runner:2a3052eff7a82a483a7fde51, in lhr18, WEUR, container 22c4c0e4d41f62c6a700dd4c08d5ff72394b3a239e78b77e1e609b94ab61d56fWorkspace: /workspace/diffineryJob completed with conclusion: success
Run actions/checkout@v42s
##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 597, done. Receiving objects: 0% (1/597) Receiving objects: 1% (6/597) Receiving objects: 2% (12/597) Receiving objects: 3% (18/597) Receiving objects: 4% (24/597) Receiving objects: 5% (30/597) Receiving objects: 6% (36/597) Receiving objects: 7% (42/597) Receiving objects: 8% (48/597) Receiving objects: 9% (54/597) Receiving objects: 10% (60/597) Receiving objects: 11% (66/597) Receiving objects: 12% (72/597) Receiving objects: 13% (78/597) Receiving objects: 14% (84/597) Receiving objects: 15% (90/597) Receiving objects: 16% (96/597) Receiving objects: 17% (102/597) Receiving objects: 18% (108/597) Receiving objects: 19% (114/597) Receiving objects: 20% (120/597) Receiving objects: 21% (126/597) Receiving objects: 22% (132/597) Receiving objects: 23% (138/597) Receiving objects: 24% (144/597) Receiving objects: 25% (150/597) Receiving objects: 26% (156/597) Receiving objects: 27% (162/597) Receiving objects: 28% (168/597) Receiving objects: 29% (174/597) Receiving objects: 30% (180/597) Receiving objects: 31% (186/597) Receiving objects: 32% (192/597) Receiving objects: 33% (198/597) Receiving objects: 34% (203/597) Receiving objects: 35% (209/597) Receiving objects: 36% (215/597) Receiving objects: 37% (221/597) Receiving objects: 38% (227/597) Receiving objects: 39% (233/597) Receiving objects: 40% (239/597) Receiving objects: 41% (245/597) Receiving objects: 42% (251/597) Receiving objects: 43% (257/597) Receiving objects: 44% (263/597) Receiving objects: 45% (269/597) Receiving objects: 46% (275/597) Receiving objects: 47% (281/597) Receiving objects: 48% (287/597) Receiving objects: 49% (293/597) Receiving objects: 50% (299/597) Receiving objects: 51% (305/597) Receiving objects: 52% (311/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 53% (317/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 54% (323/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 55% (329/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 56% (335/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 57% (341/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 58% (347/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 59% (353/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 60% (359/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 61% (365/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 62% (371/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 63% (377/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 64% (383/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 65% (389/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 66% (395/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 67% (400/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 68% (406/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 69% (412/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 70% (418/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 71% (424/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 72% (430/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 73% (436/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 74% (442/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 75% (448/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 76% (454/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 77% (460/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 78% (466/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 79% (472/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 80% (478/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 81% (484/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 82% (490/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 83% (496/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 84% (502/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 85% (508/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 86% (514/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 87% (520/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 88% (526/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 89% (532/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 90% (538/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 91% (544/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 92% (550/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 93% (556/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 94% (562/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 95% (568/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 96% (574/597), 1.25 MiB | 1.65 MiB/s remote: Total 597 (delta 0), reused 597 (delta 0) Receiving objects: 97% (580/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 98% (586/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 99% (592/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 100% (597/597), 1.25 MiB | 1.65 MiB/s Receiving objects: 100% (597/597), 2.43 MiB | 2.59 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref] a706b5429a82be32d32fd2a4070a3c268c4d088f -> origin/diffinery-checkoutNote: switching to 'a706b5429a82be32d32fd2a4070a3c268c4d088f'.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 a706b54 Merge c6478ec8450fcdc03d500404098eb1d9593040d4 into b79522c9667f13a86441e4f02ce583bd74559fbeHEAD is now at a706b5429a82be32d32fd2a4070a3c268c4d088f
Run pnpm/action-setup@v42s
Download action repository 'pnpm/action-setup@v4'##[group]Run pnpm/action-setup@v4with: 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!
Run actions/setup-node@v411s
##[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: ~215 MB (225870423 B)Cache restored from key: node-cache-Linux-x64-pnpm-4b94436b86798d88b931ea24b5b847697aebf45520d6ef384cb382ce6c1f1e08
Run pnpm install --frozen-lockfile14s
##[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: +248++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++Progress: resolved 248, reused 242, downloaded 0, added 247Progress: resolved 248, reused 242, downloaded 0, added 248, donedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 13.3s 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);"apps/cli build: dist/diffinery.mjs 439.5kbapps/cli build: ⚡ Done in 68msapps/cli build: Donecontainers/runner build: dist/agent.mjs 657.3kbcontainers/runner build: ⚡ Done in 69mscontainers/runner build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/diffinery build: docs: 62 pages (+2 generated at runtime), CLI 0.1.0 (230 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 38s
##[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: 96622.866766 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: 44165.048754 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: 37852.223713 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: 35257.704192 type: 'test' ...1..4# tests 4# suites 0# pass 4# fail 0# cancelled 0# skipped 0# todo 0# duration_ms 218126.795799
Post Run actions/setup-node@v40s
Cache hit occurred on the primary key node-cache-Linux-x64-pnpm-4b94436b86798d88b931ea24b5b847697aebf45520d6ef384cb382ce6c1f1e08, not saving cache.Post Run pnpm/action-setup@v40s
Pruning is unnecessary.Post Run actions/checkout@v40s
Removing persisted credentials