Files
SnapOtter/tests/unit/api/audit-lib.test.ts
T
SnapOtterandGitHub 1c724d5d21 feat(db)!: SnapOtter 2.0 phase 1 foundation: postgres, migrator, compose stack (#216)
* feat(infra): add dev compose stack with postgres and redis

* fix(infra): comment dev env defaults until wired; harden dev compose restart and start_period

* chore(deps): add pg driver and testcontainers for postgres migration

* feat(db): translate schema to drizzle pg-core (timestamptz, boolean, pgEnum, jsonb)

Schema translation (apps/api/src/db/schema.ts):
- sqlite-core -> pg-core, all 10 tables preserved 1:1
- integer(mode:'timestamp') -> timestamp({ withTimezone: true })
- integer(mode:'boolean') -> boolean
- jobs.status text enum -> pgEnum('job_status') with same 4 values
- 7 columns changed from text to jsonb: jobs.inputFiles, jobs.settings,
  pipelines.steps, apiKeys.permissions, roles.permissions,
  auditLog.details, userFiles.toolChain
- settings.value stays text, jobs.error stays text, jobs.progress stays real

jsonb call-site sweep (removed JSON.stringify on writes, JSON.parse on reads):
- apps/api/src/routes/roles.ts: permissions read/write (3 sites)
- apps/api/src/routes/api-keys.ts: permissions write + read (2 sites)
- apps/api/src/routes/audit-log.ts: details read (1 site)
- apps/api/src/routes/pipeline.ts: steps write + read (2 sites)
- apps/api/src/routes/progress.ts: inputFiles write (2 sites)
- apps/api/src/routes/tool-factory.ts: toolChain read + write (2 sites)
- apps/api/src/routes/user-files.ts: toolChain read + write (4 sites)
- apps/api/src/permissions.ts: roles.permissions read (1 site)
- apps/api/src/lib/audit.ts: details write (1 site)
- apps/api/src/plugins/auth.ts: apiKeys.permissions read (1 site)

* refactor(db): type jsonb columns via $type and note raw CTE conversion requirements

* feat(db): archive sqlite migrations and generate postgres baseline

* chore(db): dockerignore legacy migrations, add archive breadcrumb, fix trailing newline

* feat(db): pg pool connection, advisory-locked boot migrations, DATABASE_URL config

* fix(db): friendly fatal on unreachable postgres, idempotent closeDb, lock-key convention note

* refactor(db): async drizzle calls in plugins, lib, permissions

* fix(api): analytics never throws, typed permission guard, single-query session invalidation

* refactor(db): async drizzle calls across all routes and bootstrap

Convert every route file and index.ts from sync SQLite drizzle
patterns to async node-postgres drizzle:

- .all() removed (bare await on select)
- .get() converted to destructured [row] = await ...
- .run() removed (bare await on insert/update/delete)
- .changes replaced with .rowCount (null-guarded) in progress.ts
- sqlite import removed from user-files.ts; raw CTEs converted to
  await db.execute(sql`...`) with postgres-dialect recursive CTEs
- ChainRow types updated: tool_chain is parsed jsonb (string[] | null),
  created_at is Date (timestamptz) with no * 1000 conversion
- All requirePermission() guard calls awaited (security: unawaited
  async guard returns truthy Promise, bypassing permission check)
- All hasEffectivePermission() and getPermissions() calls awaited
- All auditLog() calls awaited (preserves write-before-response order)
- trackEvent() and captureException() left un-awaited (fire-and-forget
  by design, guaranteed never-throw)
- ensureAnonymousUser(), startCleanupCron(), recoverStaleJobs() awaited
  in bootstrap sequence
- ensureInstanceId() and ensureDefaultSettings() made async

Files converted: 14 (index.ts + 12 route files + tools/index.ts)

* fix(db): await async checkStorageQuota in user-files upload/save routes

* fix(db): await checkStorageQuota in save-result route (missed second call site)

* feat(db): sqlite-to-postgres migrator with CLI and first-boot import

* fix(db): migrator error context, honest force semantics, boot-hook fatal, null-variance tests

* test: run suite against per-file postgres databases via testcontainers

- Add tests/global-setup.ts: spins up a Postgres testcontainer,
  creates a migrated template database once per vitest run.
- Rewrite tests/setup/per-fork-env.ts: each test file (forks pool)
  clones the template into its own database via CREATE DATABASE ...
  TEMPLATE, preserving the same per-file isolation granularity.
- Update vitest.config.ts: add globalSetup, pg alias, update comment.
- Fix tests/integration/test-server.ts: remove DB_PATH mkdir, async
  runMigrations, async db operations, remove SQLite WAL checkpoint.
- Fix 21 unit test db/index mocks: add pool and closeDb exports.
- Fix 8 unit test files: add async/await for now-async permission,
  audit, and analytics functions.
- Fix 18 integration test files: convert sync .run()/.all()/.get()
  to async drizzle patterns, add async to callbacks.
- Production change: apps/api/src/routes/teams.ts: cast COUNT(*)
  to ::int so Postgres returns a number instead of bigint string.

* fix(db): seed built-in roles, reject NUL bytes, cast COUNT, serialize job persists

- Seed built-in roles (admin, editor, user) at boot via ensureBuiltinRoles()
  with onConflictDoNothing, restoring data that legacy SQLite migration 0007
  provided via INSERT statements (the pg baseline is DDL-only).
- Reject NUL bytes in login credentials with 401 (postgres rejects \x00 in
  text columns; valid usernames never contain NUL, matching 1.x behavior).
- Cast COUNT(*)::int in user-files, audit-log, and roles listing queries so
  postgres returns a JS number instead of bigint-as-string.
- Serialize fire-and-forget job progress DB writes per jobId so the final
  "completed" status is never overwritten by a late-arriving "processing"
  write (race condition exposed by async postgres round-trips).

* test: fix teams race, seed roles in test server, poll for job status

- Add missing await to resetTeams() in teams PUT beforeEach (the async
  delete raced with the subsequent insert under postgres).
- Call ensureBuiltinRoles() in test server bootstrap so integration tests
  have the same built-in roles as production.
- Replace fixed 100ms flushPersist delay with a polling helper that waits
  for terminal job status, eliminating timing-dependent failures caused by
  postgres network round-trip latency.

* test: make heic temp-file cleanup assertion resilient to concurrent workers

Use a set-based diff instead of raw file count when checking that
decodeHeic cleans up temp files. Other concurrent test workers can
create heic-in-*/heic-out-* files in the shared tmpdir, inflating the
"after" count and causing spurious failures under full-suite load.

* fix(db): align builtin-role seed to post-0010 legacy state; test polish

* feat(docker): three-container compose (app, postgres, redis) with boot wait and migrations

* fix(docker): set TEST_DATABASE_URL so containerized tests skip testcontainers

* chore(docker): test compose project name, clearer 1.x upgrade comment, unref probe timer

* feat(enterprise): enforce D15 license boundary; move s3 storage into packages/enterprise

* fix(enterprise): restore lazy aws-sdk loading; community installs load no s3 code at boot

* fix(enterprise): boundary check catches dynamic imports; document getS3 concurrency

* feat(db)!: SnapOtter 2.0 phase 1 foundation: postgres, migrator, compose stack

BREAKING CHANGE: SQLite is no longer the runtime database. Deployments now
require Postgres (and Redis, used from phase 2). Existing installs migrate
with SQLITE_MIGRATE_PATH or 'pnpm --filter @snapotter/api migrate:sqlite'.

* fix(ci): postgres service + fresh e2e database per run; ignore unfixable torch CVE-2025-3000
2026-06-13 10:15:23 +08:00

169 lines
5.0 KiB
TypeScript

/**
* Unit tests for the audit.ts library module.
*
* Tests the auditLog function's dual-write behavior (logger + DB insert),
* actor extraction, target type derivation, and DB failure resilience.
*/
import { beforeEach, describe, expect, it, vi } from "vitest";
// ── Mocks ───────────────────────────────────────────────────────────────
const mockInsertRun = vi.fn();
vi.mock("../../../apps/api/src/db/index.js", () => ({
db: {
insert: () => ({
values: (...args: unknown[]) => {
mockInsertRun(...args);
return Promise.resolve();
},
}),
},
pool: {},
closeDb: async () => {},
schema: {
auditLog: {},
},
}));
import { auditLog } from "../../../apps/api/src/lib/audit.js";
// ── Tests ───────────────────────────────────────────────────────────────
describe("auditLog", () => {
const mockLogger = {
info: vi.fn(),
warn: vi.fn(),
error: vi.fn(),
debug: vi.fn(),
fatal: vi.fn(),
trace: vi.fn(),
child: vi.fn(),
level: "info",
silent: vi.fn(),
};
beforeEach(() => {
vi.clearAllMocks();
});
it("logs to the structured logger with audit flag", async () => {
await auditLog(mockLogger as never, "LOGIN_SUCCESS", { userId: "u1", username: "alice" });
expect(mockLogger.info).toHaveBeenCalledTimes(1);
const [logData, logMessage] = mockLogger.info.mock.calls[0];
expect(logData.audit).toBe(true);
expect(logData.event).toBe("LOGIN_SUCCESS");
expect(logData.userId).toBe("u1");
expect(logMessage).toBe("[AUDIT] LOGIN_SUCCESS");
});
it("inserts a record into the database", async () => {
await auditLog(mockLogger as never, "USER_CREATED", {
adminId: "admin-1",
targetUserId: "new-user-1",
});
expect(mockInsertRun).toHaveBeenCalledTimes(1);
});
it("extracts actorId from userId field first", async () => {
await auditLog(mockLogger as never, "FILE_UPLOADED", {
userId: "u1",
adminId: "a1",
});
// The insert was called; check logger received both fields
expect(mockLogger.info).toHaveBeenCalledTimes(1);
const logData = mockLogger.info.mock.calls[0][0];
expect(logData.userId).toBe("u1");
expect(logData.adminId).toBe("a1");
});
it("falls back to adminId when userId is absent", async () => {
await auditLog(mockLogger as never, "ROLE_CREATED", { adminId: "admin-1", roleName: "editor" });
expect(mockLogger.info).toHaveBeenCalledTimes(1);
const logData = mockLogger.info.mock.calls[0][0];
expect(logData.adminId).toBe("admin-1");
});
it("extracts username from details", async () => {
await auditLog(mockLogger as never, "LOGIN_SUCCESS", {
userId: "u1",
username: "alice",
});
const logData = mockLogger.info.mock.calls[0][0];
expect(logData.username).toBe("alice");
});
it("handles empty details object", async () => {
await auditLog(mockLogger as never, "LOGOUT");
expect(mockLogger.info).toHaveBeenCalledTimes(1);
expect(mockInsertRun).toHaveBeenCalledTimes(1);
});
it("survives DB insert failure", async () => {
mockInsertRun.mockImplementationOnce(() => {
throw new Error("DB write failed");
});
// Should not throw
await auditLog(mockLogger as never, "SETTINGS_UPDATED", { userId: "u1" });
expect(mockLogger.info).toHaveBeenCalledTimes(1);
expect(mockLogger.warn).toHaveBeenCalledTimes(1);
const [warnData] = mockLogger.warn.mock.calls[0];
expect(warnData.event).toBe("SETTINGS_UPDATED");
});
it("logs different event types correctly", async () => {
const events = [
"LOGIN_SUCCESS",
"LOGIN_FAILED",
"LOGOUT",
"PASSWORD_CHANGED",
"USER_CREATED",
"FILE_UPLOADED",
"API_KEY_CREATED",
"ROLE_CREATED",
"SETTINGS_UPDATED",
] as const;
for (const event of events) {
vi.clearAllMocks();
await auditLog(mockLogger as never, event, { userId: "u1" });
expect(mockLogger.info).toHaveBeenCalledTimes(1);
const logMessage = mockLogger.info.mock.calls[0][1];
expect(logMessage).toBe(`[AUDIT] ${event}`);
}
});
it("serializes details as JSON for DB storage", async () => {
await auditLog(mockLogger as never, "USER_UPDATED", {
adminId: "admin-1",
targetUserId: "u2",
changes: { role: "editor" },
});
expect(mockInsertRun).toHaveBeenCalledTimes(1);
});
it("includes all detail fields in the log output", async () => {
const details = {
userId: "u1",
keyId: "key-123",
keyName: "Production Key",
};
await auditLog(mockLogger as never, "API_KEY_CREATED", details);
const logData = mockLogger.info.mock.calls[0][0];
expect(logData.keyId).toBe("key-123");
expect(logData.keyName).toBe("Production Key");
});
});