End-to-end (large pushes)
took 2m 55s Raw logs
Matrix: name: large pushes, shard: large
Failed at Run the shard's tests
Process completed with exit code 1.
ChildProcess.emit (node:events:519:28)
maybeClose (node:internal/child_process:1101:16)
ChildProcess._handle.onexit (node:internal/child_process:304:5)
...
# Subtest: large pushes: a 40 MB history of many files goes in one push, read from R2 in ranges, and is still checked
ok 3 - large pushes: a 40 MB history of many files goes in one push, read from R2 in ranges, and is still checked
---
duration_ms: 108093.833322
type: 'test'
...
1..3
# tests 3
# suites 0
# pass 2
# fail 1
# cancelled 0
# skipped 0
# todo 0
# duration_ms 158724.417656Set up job
Diffinery runner: job e2e (End-to-end (large pushes)) for codician/diffinery@a5c4d8e3d540Runner: image diffinery-runner:efee6389dfc1b5bd5a743d5e, in mad07, WEUR, container 1186735aabe7d8274d81f271ded145cb391b9d172eb2a83fc06925f77c2846c5Runner 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: 0% of the vCPUs' time went to other work on the host (steal)Job completed with conclusion: failureResources: 1.4 of 4 vCPUs busy on average (3.8 at the 95th percentile), peak memory 3.0 GiB of 11.9 GiB, peak disk 3.7 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: 686, done. Receiving objects: 0% (1/686) Receiving objects: 1% (7/686) Receiving objects: 2% (14/686) Receiving objects: 3% (21/686) Receiving objects: 4% (28/686) Receiving objects: 5% (35/686) Receiving objects: 6% (42/686) Receiving objects: 7% (49/686) Receiving objects: 8% (55/686) Receiving objects: 9% (62/686) Receiving objects: 10% (69/686) Receiving objects: 11% (76/686) Receiving objects: 12% (83/686) Receiving objects: 13% (90/686) Receiving objects: 14% (97/686) Receiving objects: 15% (103/686) Receiving objects: 16% (110/686) Receiving objects: 17% (117/686) Receiving objects: 18% (124/686) Receiving objects: 19% (131/686) Receiving objects: 20% (138/686) Receiving objects: 21% (145/686) Receiving objects: 22% (151/686) Receiving objects: 23% (158/686) Receiving objects: 24% (165/686) Receiving objects: 25% (172/686) Receiving objects: 26% (179/686) Receiving objects: 27% (186/686) Receiving objects: 28% (193/686) Receiving objects: 29% (199/686) Receiving objects: 30% (206/686) Receiving objects: 31% (213/686) Receiving objects: 32% (220/686) Receiving objects: 33% (227/686) Receiving objects: 34% (234/686) Receiving objects: 35% (241/686) Receiving objects: 36% (247/686) Receiving objects: 37% (254/686) Receiving objects: 38% (261/686) Receiving objects: 39% (268/686) Receiving objects: 40% (275/686) Receiving objects: 41% (282/686) Receiving objects: 42% (289/686) Receiving objects: 43% (295/686) Receiving objects: 44% (302/686) Receiving objects: 45% (309/686) Receiving objects: 46% (316/686) Receiving objects: 47% (323/686) Receiving objects: 48% (330/686) Receiving objects: 49% (337/686) Receiving objects: 50% (343/686) Receiving objects: 51% (350/686) Receiving objects: 52% (357/686) Receiving objects: 53% (364/686) Receiving objects: 54% (371/686) Receiving objects: 55% (378/686) Receiving objects: 56% (385/686) Receiving objects: 57% (392/686) Receiving objects: 58% (398/686) Receiving objects: 59% (405/686) Receiving objects: 60% (412/686) Receiving objects: 61% (419/686) Receiving objects: 62% (426/686) Receiving objects: 63% (433/686) Receiving objects: 64% (440/686) Receiving objects: 65% (446/686) Receiving objects: 66% (453/686) Receiving objects: 67% (460/686) Receiving objects: 68% (467/686) Receiving objects: 69% (474/686) Receiving objects: 70% (481/686) Receiving objects: 71% (488/686) Receiving objects: 72% (494/686) Receiving objects: 73% (501/686) Receiving objects: 74% (508/686) Receiving objects: 75% (515/686) Receiving objects: 76% (522/686) Receiving objects: 77% (529/686) Receiving objects: 78% (536/686) Receiving objects: 79% (542/686) Receiving objects: 80% (549/686) Receiving objects: 81% (556/686) Receiving objects: 82% (563/686) Receiving objects: 83% (570/686) Receiving objects: 84% (577/686) Receiving objects: 85% (584/686) Receiving objects: 86% (590/686) Receiving objects: 87% (597/686) Receiving objects: 88% (604/686) Receiving objects: 89% (611/686) Receiving objects: 90% (618/686) Receiving objects: 91% (625/686) Receiving objects: 92% (632/686) Receiving objects: 93% (638/686) Receiving objects: 94% (645/686) Receiving objects: 95% (652/686) Receiving objects: 96% (659/686) Receiving objects: 97% (666/686) remote: Total 686 (delta 0), reused 686 (delta 0) Receiving objects: 98% (673/686) Receiving objects: 99% (680/686) Receiving objects: 100% (686/686) Receiving objects: 100% (686/686), 3.04 MiB | 9.65 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref] a5c4d8e3d540b0580a24e4220922d747679e805c -> origin/diffinery-checkoutNote: switching to 'a5c4d8e3d540b0580a24e4220922d747679e805c'.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 a5c4d8e Merge 958c6a71f08058b8d2500eebbf3c2eeae20d42da into 4798de7b2e20f76f4cf5e2564dcf6ef1f68c7797HEAD is now at a5c4d8e3d540b0580a24e4220922d747679e805c
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.14.0 is available)Done in 1s##[endgroup]Installation Completed!
Run actions/setup-node@v46s
##[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
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: +250++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++Progress: resolved 250, reused 244, downloaded 0, added 250, done.../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.../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js.../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$ node install.js.../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 3.1s using pnpm v10.28.0
Run pnpm -r --if-present build2s
##[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 446.1kbapps/cli build: ⚡ Done in 46msapps/cli build: Donecontainers/runner build: dist/agent.mjs 682.1kbcontainers/runner build: ⚡ Done in 84mscontainers/runner build: Doneapps/diffinery build: islands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBapps/diffinery build: docs: 72 pages (+2 generated at runtime), 6 images, CLI 0.1.0 (235 KiB), editor extension 0.1.1 (20 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 tests2m 39s
##[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 "large" 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: large files: a 40 MB file is pushed and cloned intact, and push protection still reads big text filesok 1 - large files: a 40 MB file is pushed and cloned intact, and push protection still reads big text files --- duration_ms: 32036.569244 type: 'test' ...# Subtest: large pushes: three large pushes into one repository at once all go in, and a fetch meanwhile worksnot ok 2 - large pushes: three large pushes into one repository at once all go in, and a fetch meanwhile works --- duration_ms: 15458.436861 type: 'test' location: '/workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2935:1' failureType: 'testCodeFailure' error: |- git -c http.postBuffer=1048576 push -q http://127.0.0.1:42817/dev/pushes-at-once.git c exited 1 error: RPC failed; HTTP 500 curl 22 The requested URL returned error: 500 send-pack: unexpected disconnect while reading sideband packet fatal: the remote end hung up unexpectedly --- wrangler log tail --- Environment Variable local env.BOOTSTRAP_ADMINS ("dev@diffinery.local") Environment Variable local env.ACCESS_TEAM_DOMAIN ("") Environment Variable local env.ACCESS_AUD ("") Environment Variable local env.DEV_AUTH ("dev@diffinery.local") Environment Variable local env.IMPORT_GIT_AGENT ("external") Environment Variable local env.MASTER_KEY ("(hidden)") Environment Variable local env.SCHEDULE_TICK_MINUTES ("(hidden)") Environment Variable local [wrangler:info] Ready on http://127.0.0.1:42817 [wrangler:info] GET /healthz 200 OK (1546ms) [wrangler:info] POST /api/v3/diffinery/tokens 201 Created (18ms) [wrangler:info] GET /api/v3/user 200 OK (9ms) [wrangler:info] POST /api/v3/user/repos 201 Created (71ms) [wrangler:info] QUEUE diffinery-mail-dev 1/1 (17ms) [wrangler:info] send_email binding called with MessageBuilder: From: "Diffinery" <notifications@diffinery.com> To: dev@diffinery.local Subject: [Diffinery] A personal access token was added to your account Text: /workspace/diffinery/apps/diffinery/.wrangler/tmp/email/miniflare-1a76cef4a82929e2955426689b0731c2/email-text/KodD4mKushT1ScgW2cVVE1z92AbVVIFuGNWG@diffinery.com.txt HTML: /workspace/diffinery/apps/diffinery/.wrangler/tmp/email/miniflare-1a76cef4a82929e2955426689b0731c2/email-html/KodD4mKushT1ScgW2cVVE1z92AbVVIFuGNWG@diffinery.com.html [wrangler:info] GET /dev/bigfile.git/info/refs 200 OK (10ms) [wrangler:info] POST /dev/bigfile.git/git-receive-pack 200 OK (23ms) [wrangler:info] POST /dev/bigfile.git/git-receive-pack 200 OK (7654ms) [wrangler:info] GET /dev/bigfile.git/info/refs 200 OK (10ms) [wrangler:info] POST /dev/bigfile.git/git-upload-pack 200 OK (8ms) [wrangler:info] POST /dev/bigfile.git/git-upload-pack 200 OK (8ms) [wrangler:info] QUEUE diffinery-events-dev 1/1 (11ms) [wrangler:info] GET /dev/bigfile.git/info/refs 200 OK (21ms) [wrangler:info] POST /dev/bigfile.git/git-receive-pack 200 OK (261ms) [wrangler:info] QUEUE diffinery-events-dev 1/1 (9ms) [wrangler:info] GET /api/v3/user 200 OK (8ms) [wrangler:info] POST /api/v3/user/repos 201 Created (68ms) [wrangler:info] GET /dev/pushes-at-once.git/info/refs 200 OK (16ms) [wrangler:info] POST /dev/pushes-at-once.git/git-receive-pack 200 OK (26ms) [wrangler:info] QUEUE diffinery-mail-dev 1/1 (8ms) [wrangler:info] send_email binding called with MessageBuilder: From: "Diffinery" <notifications@diffinery.com> To: dev@diffinery.local Subject: [dev/bigfile] Your push was blocked: possible secrets Text: /workspace/diffinery/apps/diffinery/.wrangler/tmp/email/miniflare-1a76cef4a82929e2955426689b0731c2/email-text/B9g0LfBVo0xQfRKFWs12QILUVc2p84S2YLuH@diffinery.com.txt HTML: /workspace/diffinery/apps/diffinery/.wrangler/tmp/email/miniflare-1a76cef4a82929e2955426689b0731c2/email-html/B9g0LfBVo0xQfRKFWs12QILUVc2p84S2YLuH@diffinery.com.html [wrangler:info] QUEUE diffinery-events-dev 1/1 (7ms) [wrangler:info] GET /dev/pushes-at-once.git/info/refs 200 OK (8ms) [wrangler:info] GET /dev/pushes-at-once.git/info/refs 200 OK (19ms) [wrangler:info] GET /dev/pushes-at-once.git/info/refs 200 OK (19ms) [wrangler:info] GET /dev/pushes-at-once.git/info/refs 200 OK (27ms) [wrangler:info] POST /dev/pushes-at-once.git/git-upload-pack 200 OK (32ms) [wrangler:info] POST /dev/pushes-at-once.git/git-upload-pack 200 OK (38ms) [wrangler:info] POST /dev/pushes-at-once.git/git-receive-pack 200 OK (13ms) [wrangler:info] POST /dev/pushes-at-once.git/git-receive-pack 200 OK (21ms) [wrangler:info] POST /dev/pushes-at-once.git/git-receive-pack 200 OK (3927ms) ✘ [ERROR] Error inside ProxyWorker (the affected request failed; the dev server continues): POST http://127.0.0.1:42817/dev/pushes-at-once.git/git-receive-pack (failed after 1 attempt): Network connection lost. code: 'ERR_TEST_FAILURE' stack: |- ChildProcess.<anonymous> (file:///workspace/diffinery/apps/diffinery/test/e2e/e2e.test.mjs:2830:26) ChildProcess.emit (node:events:519:28) maybeClose (node:internal/child_process:1101:16) ChildProcess._handle.onexit (node:internal/child_process:304:5) ...# Subtest: large pushes: a 40 MB history of many files goes in one push, read from R2 in ranges, and is still checkedok 3 - large pushes: a 40 MB history of many files goes in one push, read from R2 in ranges, and is still checked --- duration_ms: 108093.833322 type: 'test' ...1..3# tests 3# suites 0# pass 2# fail 1# cancelled 0# skipped 0# todo 0# duration_ms 158724.417656##[error]Process completed with exit code 1.
Post Run pnpm/action-setup@b906affcce14559ad1aafd4ab0e942779e9f58b10s
Pruning is unnecessary.Post Run actions/checkout@v40s
Removing persisted credentials