Diffinery runner: job test (Unit tests (1/2)) for codician/diffinery@5594b9dd6196Runner: image diffinery-runner:7d76ed7e2bbe8f5431f60bdc, in hkg01, APAC, container 4c82f3ad82d780f1773f9204701770d59a8dc8c52ce9316c25ca4b5b4c475d74Workspace: /workspace/diffineryJob completed with conclusion: success

##[group]Run actions/checkout@v4##[endgroup]Syncing repository: codician/diffineryFetching the repository (depth 1)remote: Enumerating objects: 584, done.        Receiving objects:   0% (1/584)
Receiving objects:   1% (6/584)
Receiving objects:   2% (12/584)
Receiving objects:   3% (18/584)
Receiving objects:   4% (24/584)
Receiving objects:   5% (30/584)
Receiving objects:   6% (36/584)
Receiving objects:   7% (41/584)
Receiving objects:   8% (47/584)
Receiving objects:   9% (53/584)
Receiving objects:  10% (59/584)
Receiving objects:  11% (65/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  12% (71/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  13% (76/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  14% (82/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  15% (88/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  16% (94/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  17% (100/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  18% (106/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  19% (111/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  20% (117/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  21% (123/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  22% (129/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  23% (135/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  24% (141/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  25% (146/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  26% (152/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  27% (158/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  28% (164/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  29% (170/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  30% (176/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  31% (182/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  32% (187/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  33% (193/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  34% (199/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  35% (205/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  36% (211/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  37% (217/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  38% (222/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  39% (228/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  39% (230/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  40% (234/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  41% (240/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  42% (246/584), 195.94 KiB | 368.00 KiB/s
Receiving objects:  43% (252/584), 1.07 MiB | 1.03 MiB/s    
Receiving objects:  44% (257/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  45% (263/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  46% (269/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  47% (275/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  48% (281/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  49% (287/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  50% (292/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  51% (298/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  52% (304/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  53% (310/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  54% (316/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  55% (322/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  56% (328/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  57% (333/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  58% (339/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  59% (345/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  60% (351/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  61% (357/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  62% (363/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  63% (368/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  64% (374/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  65% (380/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  66% (386/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  67% (392/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  68% (398/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  69% (403/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  70% (409/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  71% (415/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  72% (421/584), 1.07 MiB | 1.03 MiB/s
Receiving objects:  73% (427/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  74% (433/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  75% (438/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  76% (444/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  77% (450/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  78% (456/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  79% (462/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  80% (468/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  81% (474/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  82% (479/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  83% (485/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  84% (491/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  85% (497/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  86% (503/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  87% (509/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  88% (514/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  89% (520/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  90% (526/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  91% (532/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  92% (538/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  93% (544/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  94% (549/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  95% (555/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  96% (561/584), 2.02 MiB | 1.32 MiB/s
remote: Total 584 (delta 0), reused 584 (delta 0)        Receiving objects:  97% (567/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  98% (573/584), 2.02 MiB | 1.32 MiB/s
Receiving objects:  99% (579/584), 2.02 MiB | 1.32 MiB/s
Receiving objects: 100% (584/584), 2.02 MiB | 1.32 MiB/s
Receiving objects: 100% (584/584), 2.38 MiB | 1.48 MiB/s, done.From https://diffinery.com/codician/diffinery * [new ref]         5594b9dd61969a269ce5ebbb16582c11f190070b -> origin/mainSwitched to a new branch 'main'HEAD is now at 5594b9dd61969a269ce5ebbb16582c11f190070b

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.11.2 is available)Done in 1.4s##[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')pnpm cache is not found

##[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 0, downloaded 9, added 0Progress: resolved 248, reused 0, downloaded 15, added 1Progress: resolved 248, reused 0, downloaded 42, added 8Progress: resolved 248, reused 0, downloaded 106, added 32Progress: resolved 248, reused 0, downloaded 125, added 40Progress: resolved 248, reused 0, downloaded 138, added 44Progress: resolved 248, reused 0, downloaded 140, added 44Progress: resolved 248, reused 0, downloaded 144, added 48Progress: resolved 248, reused 0, downloaded 156, added 48Progress: resolved 248, reused 0, downloaded 167, added 52Progress: resolved 248, reused 0, downloaded 171, added 52Progress: resolved 248, reused 0, downloaded 172, added 52Progress: resolved 248, reused 0, downloaded 181, added 56Progress: resolved 248, reused 0, downloaded 207, added 64Progress: resolved 248, reused 0, downloaded 222, added 68Progress: resolved 248, reused 0, downloaded 223, added 68Progress: resolved 248, reused 0, downloaded 242, added 82Progress: resolved 248, reused 0, downloaded 242, added 144Progress: resolved 248, reused 0, downloaded 242, added 172Progress: resolved 248, reused 0, downloaded 242, added 248, done.../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.../esbuild@0.25.11/node_modules/esbuild postinstall$ node install.js.../node_modules/workerd postinstall$ node install.js.../esbuild@0.28.1/node_modules/esbuild postinstall: Done.../node_modules/workerd postinstall: Done.../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$ node install.js.../node_modules/workerd postinstall: Done.../esbuild@0.28.2/node_modules/esbuild postinstall: DonedevDependencies:+ turbo 2.11.7+ typescript 5.9.3Done in 32.8s using pnpm v10.28.0

##[group]Run pnpm -r --if-present build##[endgroup]Scope: 6 of 7 workspace projects##[group]@diffinery/cli@0.1.0 : build apps/cli> @diffinery/cli@0.1.0 build /workspace/diffinery/apps/cli> 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);"  dist/diffinery.mjs  428.7kb⚡ Done in 101ms##[endgroup]##[group]@diffinery/app@0.1.0 : build apps/diffinery> @diffinery/app@0.1.0 build /workspace/diffinery/apps/diffinery> node islands/build.mjs && node scripts/build-docs.mjsislands: kumo.js 466 KB, kumo.css 149 KB, terminal.js 286 KBdocs: 61 pages (+2 generated at runtime), CLI 0.1.0 (222 KiB)##[endgroup]##[group]@diffinery/runner@0.1.0 : build containers/runner> @diffinery/runner@0.1.0 build /workspace/diffinery/containers/runner> 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);"  dist/agent.mjs  657.2kb⚡ Done in 134ms##[endgroup]

##[group]Run pnpm -r --if-present run test --shard=1/2##[endgroup]Scope: 6 of 7 workspace projects##[group]@diffinery/git-core@0.1.0 : test packages/git-core> @diffinery/git-core@0.1.0 test /workspace/diffinery/packages/git-core> vitest run --shard=1/2 RUN  v4.1.11 /workspace/diffinery/packages/git-core ✓ test/pack-limits.test.ts (6 tests) 8154ms     ✓ resolves a long delta chain in one pass, whatever order the pack lists it in  3248ms     ✓ counts what each object costs in memory, not only its content  1832ms     ✓ refuses a small pack whose objects inflate past the memory budget  2986ms ✓ test/diff-budget.test.ts (5 tests) 974ms     ✓ a file rewritten from scratch is diffed in one pass, as one replaced block  311ms     ✓ a three-way merge too large to compute is a conflict, quickly  645ms ✓ test/pack-stream.test.ts (3 tests) 317ms Test Files  3 passed (3)      Tests  14 passed (14)   Start at  14:51:43   Duration  10.77s (transform 369ms, setup 0ms, import 599ms, tests 9.45s, environment 0ms)##[endgroup]##[group]@diffinery/workflow-yaml@0.1.0 : test packages/workflow-yaml> @diffinery/workflow-yaml@0.1.0 test /workspace/diffinery/packages/workflow-yaml> vitest run --shard=1/2 RUN  v4.1.11 /workspace/diffinery/packages/workflow-yaml ✓ test/parse.test.ts (31 tests) 106ms ✓ test/expr.test.ts (48 tests) 36ms ✓ test/cron.test.ts (23 tests) 19ms Test Files  3 passed (3)      Tests  102 passed (102)   Start at  14:51:54   Duration  3.02s (transform 1.90s, setup 0ms, import 2.21s, tests 162ms, environment 1ms)##[endgroup]##[group]@diffinery/cli@0.1.0 : test apps/cli> @diffinery/cli@0.1.0 test /workspace/diffinery/apps/cli> vitest run --shard=1/2 RUN  v4.1.11 /workspace/diffinery/apps/cli ✓ test/migrate.test.ts (4 tests) 915ms     ✓ creates the repo, pushes branches and tags, and copies issues, PRs, variables and secret names  431ms ✓ test/pr.test.ts (13 tests) 367ms ✓ test/runner.test.ts (8 tests) 480ms ✓ test/misc.test.ts (9 tests) 379ms Test Files  4 passed (4)      Tests  34 passed (34)   Start at  14:51:58   Duration  4.72s (transform 800ms, setup 0ms, import 1.69s, tests 2.14s, environment 1ms)##[endgroup]##[group]@diffinery/app@0.1.0 : test apps/diffinery> @diffinery/app@0.1.0 test /workspace/diffinery/apps/diffinery> vitest run --passWithNoTests --exclude 'test/e2e/**' --shard=1/2 RUN  v4.1.11 /workspace/diffinery/apps/diffinery ✓ test/unit/usage.test.ts (23 tests) 100ms(node:593) ExperimentalWarning: SQLite is an experimental feature and might change at any time(Use `node --trace-warnings ...` to show where the warning was created)stderr | test/unit/suppression.test.ts > Email Sending's answer to a send > puts a refused recipient on the list (source send) and audits it; temporary failures change nothingemail failed test Ann@Example.com E_RECIPIENT_SUPPRESSED: recipient is suppressedstderr | test/unit/suppression.test.ts > Email Sending's answer to a send > puts a refused recipient on the list (source send) and audits it; temporary failures change nothingemail failed test bob@example.com E_DAILY_LIMIT_EXCEEDED: nope ✓ test/unit/suppression.test.ts (11 tests) 202ms(node:604) ExperimentalWarning: SQLite is an experimental feature and might change at any time(Use `node --trace-warnings ...` to show where the warning was created)stderr | test/unit/moderation.test.ts > suspension > refuses tokens and sessions at once, stops Actions, and unsuspending restores the tokensmail queue not bound; dropping 1 email(s)stderr | test/unit/moderation.test.ts > suspension > refuses tokens and sessions at once, stops Actions, and unsuspending restores the tokensmail queue not bound; dropping 1 email(s) ✓ test/unit/moderation.test.ts (9 tests) 164ms ✓ test/unit/review.test.ts (19 tests) 35ms(node:622) ExperimentalWarning: SQLite is an experimental feature and might change at any time(Use `node --trace-warnings ...` to show where the warning was created) ✓ test/unit/auto-merge.test.ts (12 tests) 337ms ✓ test/unit/job-permissions.test.ts (8 tests) 36ms ✓ test/unit/today.test.ts (10 tests) 27ms(node:643) ExperimentalWarning: SQLite is an experimental feature and might change at any time(Use `node --trace-warnings ...` to show where the warning was created)stderr | test/unit/killswitch.test.ts > kill switches > counts repositories that couldn't be stopped, and needs a reasonkill switch: stopping work in repository broken failed Error: gone    at Object.stopActions (/workspace/diffinery/apps/diffinery/test/unit/killswitch.test.ts:24:36)    at worker (/workspace/diffinery/apps/diffinery/src/lib/killswitch.ts:155:63)    at Function.from (<anonymous>)    at stopIn (/workspace/diffinery/apps/diffinery/src/lib/killswitch.ts:166:27)    at changePause (/workspace/diffinery/apps/diffinery/src/lib/killswitch.ts:225:21)    at process.processTicksAndRejections (node:internal/process/task_queues:105:5)    at /workspace/diffinery/apps/diffinery/test/unit/killswitch.test.ts:123:12    at async file:///workspace/diffinery/node_modules/.pnpm/@vitest+runner@4.1.11/node_modules/@vitest/runner/dist/chunk-artifact.js:1903:20 ✓ test/unit/killswitch.test.ts (5 tests) 138msstderr | test/unit/rate-limit.test.ts > rate limit checks > lets requests through when no limiter is configured or the limiter failsrate limiter failed RL_ANON Error: down    at Object.limit (/workspace/diffinery/apps/diffinery/test/unit/rate-limit.test.ts:89:67)    at overLimit (/workspace/diffinery/apps/diffinery/src/lib/rate-limit.ts:70:22)    at /workspace/diffinery/apps/diffinery/test/unit/rate-limit.test.ts:90:18    at process.processTicksAndRejections (node:internal/process/task_queues:105:5)stderr | test/unit/rate-limit.test.ts > model requests per paying person (phase 5a) > counts per person, and lets requests through without a binding or when it failsmodel rate limiter failed Error: down    at Object.limit (/workspace/diffinery/apps/diffinery/test/unit/rate-limit.test.ts:130:61)    at modelRateLimited (/workspace/diffinery/apps/diffinery/src/lib/rate-limit.ts:89:33)    at /workspace/diffinery/apps/diffinery/test/unit/rate-limit.test.ts:131:18    at process.processTicksAndRejections (node:internal/process/task_queues:105:5)    at async file:///workspace/diffinery/node_modules/.pnpm/@vitest+runner@4.1.11/node_modules/@vitest/runner/dist/chunk-artifact.js:1903:20 ✓ test/unit/rate-limit.test.ts (10 tests) 3774ms     ✓ answers 429 with retry-after once an anonymous address is over its limit  3742ms ✓ test/unit/coordinator.test.ts (8 tests) 10ms ✓ test/unit/secret-scan.test.ts (7 tests) 792ms     ✓ scans a large file in slices, never as one string, with the same results  537ms ✓ test/unit/job-graph.test.ts (12 tests) 28ms ✓ test/unit/fsck.test.ts (16 tests) 416ms     ✓ refuses a tree too large to check, before reading its names  396ms ✓ test/unit/markdown-safety.test.ts (20 tests) 362ms ✓ test/unit/deploy-log-notes.test.ts (2 tests) 57ms ✓ test/unit/reusable.test.ts (4 tests) 19ms ✓ test/unit/required.test.ts (8 tests) 10ms ✓ test/unit/redirects.test.ts (9 tests) 8ms ✓ test/unit/upload-pack.test.ts (1 test) 874ms     ✓ sends each object as it is read, in side-band packets, never the whole pack at once  873ms ✓ test/unit/push-retry.test.ts (3 tests) 8ms ✓ test/unit/wait-timer.test.ts (5 tests) 7ms ✓ test/unit/org-variables.test.ts (2 tests) 7ms ✓ test/unit/stages.test.ts (3 tests) 8ms ✓ test/unit/d1.test.ts (3 tests) 6ms ✓ test/unit/receive-head.test.ts (2 tests) 25ms ✓ test/unit/archive-stream.test.ts (3 tests) 471ms     ✓ refuse more entries than classic zip can hold instead of writing a broken archive  326ms ✓ test/unit/job-secrets.test.ts (4 tests) 6ms ✓ test/unit/tree-names.test.ts (5 tests) 8ms(node:816) ExperimentalWarning: SQLite is an experimental feature and might change at any time(Use `node --trace-warnings ...` to show where the warning was created) ✓ test/unit/inflight.test.ts (1 test) 30ms ✓ test/unit/environment-secrets.test.ts (3 tests) 5ms ✓ test/unit/terminal-command.test.ts (1 test) 9ms ✓ test/unit/unpack-failure.test.ts (2 tests) 5ms Test Files  32 passed (32)      Tests  231 passed (231)   Start at  14:52:03   Duration  18.94s (transform 4.25s, setup 0ms, import 4.58s, tests 7.99s, environment 4ms)##[endgroup]##[group]@diffinery/runner@0.1.0 : test containers/runner> @diffinery/runner@0.1.0 test /workspace/diffinery/containers/runner> vitest run --shard=1/2 RUN  v4.1.11 /workspace/diffinery/containers/runner ✓ test/jail.test.ts (12 tests) 133ms ✓ test/import.test.ts (6 tests) 1608ms     ✓ pushes history in chunks under a size limit the server enforces, then every ref, and cleans up  1254ms     ✓ splits a refused batch of a large commit's files again, rather than retrying it whole  343ms ✓ test/runtime.test.ts (11 tests) 881ms     ✓ uploads large files as blocks, small ones in one request, and downloads them back  759ms ✓ test/relay.test.ts (4 tests) 461ms ✓ test/docker.test.ts (4 tests) 26684ms     ✓ runs steps and JavaScript actions in a job container next to a service container  13849ms     ✓ runs docker:// steps and Dockerfile actions with inputs, outputs, args and post entrypoints  6969ms     ✓ fails a service that never gets healthy, and cleans up  5349ms     ✓ explains that containers need Docker  513ms Test Files  5 passed (5)      Tests  37 passed (37)   Start at  14:52:23   Duration  34.95s (transform 839ms, setup 0ms, import 4.31s, tests 29.77s, environment 1ms)##[endgroup]

Cache Size: ~215 MB (225862784 B)##[warning]Failed to save: Unable to reserve cache with key node-cache-Linux-x64-pnpm-4b94436b86798d88b931ea24b5b847697aebf45520d6ef384cb382ce6c1f1e08, another job may be creating this cache.

Pruning is unnecessary.

Removing persisted credentials