Improve 'tries' naming scheme and implement exponential retry delay with jitter
This commit is contained in:
@@ -13,7 +13,7 @@ export async function up(db: Kysely<any>): Promise<void> {
|
|||||||
.addColumn("started_at", "timestamptz")
|
.addColumn("started_at", "timestamptz")
|
||||||
.addColumn("ended_at", "timestamptz")
|
.addColumn("ended_at", "timestamptz")
|
||||||
.addColumn("available_at", "timestamptz", (cb) => cb.notNull().defaultTo(sql`now()`))
|
.addColumn("available_at", "timestamptz", (cb) => cb.notNull().defaultTo(sql`now()`))
|
||||||
.addColumn("tries", "integer", (cb) => cb.notNull().defaultTo(0))
|
.addColumn("errors", "integer", (cb) => cb.notNull().defaultTo(0))
|
||||||
.addColumn("rate_limits", "integer", (cb) => cb.notNull().defaultTo(0))
|
.addColumn("rate_limits", "integer", (cb) => cb.notNull().defaultTo(0))
|
||||||
.addColumn("has_failed", "boolean", (cb) => cb.notNull().defaultTo(false))
|
.addColumn("has_failed", "boolean", (cb) => cb.notNull().defaultTo(false))
|
||||||
.execute()
|
.execute()
|
||||||
|
|||||||
@@ -6,6 +6,7 @@ import { Type as t } from "@sinclair/typebox";
|
|||||||
import { Value } from "@sinclair/typebox/value";
|
import { Value } from "@sinclair/typebox/value";
|
||||||
import { sql } from "kysely";
|
import { sql } from "kysely";
|
||||||
import zipcodesUs from "zipcodes-us";
|
import zipcodesUs from "zipcodes-us";
|
||||||
|
import { minToMs, secToMs } from "@blade-and-brawn/domain";
|
||||||
|
|
||||||
export class CommerceService {
|
export class CommerceService {
|
||||||
readonly Printful = new PrintfulClient({
|
readonly Printful = new PrintfulClient({
|
||||||
@@ -37,8 +38,8 @@ class ApparelOrdersService {
|
|||||||
this.Queue = new EventQueue({
|
this.Queue = new EventQueue({
|
||||||
group: "apparel_order",
|
group: "apparel_order",
|
||||||
cfg: {
|
cfg: {
|
||||||
retry: { limit: 3, delayMs: 10000 },
|
error: { limit: 3, initialRetryDelayMs: secToMs(1) },
|
||||||
concurrency: { limit: 1, timeoutMs: 600000 }
|
concurrency: { limit: 1, timeoutMs: minToMs(10) }
|
||||||
},
|
},
|
||||||
events: {
|
events: {
|
||||||
"apparel_order_create": defineEventType({
|
"apparel_order_create": defineEventType({
|
||||||
@@ -105,8 +106,8 @@ class ApparelSyncService {
|
|||||||
this.Queue = new EventQueue({
|
this.Queue = new EventQueue({
|
||||||
group: "apparel_sync",
|
group: "apparel_sync",
|
||||||
cfg: {
|
cfg: {
|
||||||
retry: { limit: 3, delayMs: 10000 },
|
error: { limit: 3, initialRetryDelayMs: secToMs(1) },
|
||||||
concurrency: { limit: 1, timeoutMs: 600000 }
|
concurrency: { limit: 1, timeoutMs: minToMs(10) }
|
||||||
},
|
},
|
||||||
events: {
|
events: {
|
||||||
"apparel_sync_update": defineEventType({
|
"apparel_sync_update": defineEventType({
|
||||||
|
|||||||
@@ -5,11 +5,13 @@ import { sleep } from "bun";
|
|||||||
import { db } from "../database/db";
|
import { db } from "../database/db";
|
||||||
import { AssertError, Value } from "@sinclair/typebox/value";
|
import { AssertError, Value } from "@sinclair/typebox/value";
|
||||||
import type { TSchema, Static } from "@sinclair/typebox";
|
import type { TSchema, Static } from "@sinclair/typebox";
|
||||||
import { RateLimitError } from "@blade-and-brawn/domain";
|
import { minToMs, RateLimitError, secToMs } from "@blade-and-brawn/domain";
|
||||||
|
|
||||||
export type EventSource = "portal" | "printful" | "webflow";
|
export type EventSource = "portal" | "printful" | "webflow";
|
||||||
export type EventStatus = "waiting" | "available" | "processing" | "failed" | "fulfilled";
|
export type EventStatus = "waiting" | "available" | "processing" | "failed" | "fulfilled";
|
||||||
|
|
||||||
|
type RetryType = "error" | "ratelimit";
|
||||||
|
|
||||||
type EventProcessor<P extends TSchema, S extends TSchema> =
|
type EventProcessor<P extends TSchema, S extends TSchema> =
|
||||||
(payload: Static<P>, setState: (state: Static<S>) => Promise<void>, id: string) => Promise<void>;
|
(payload: Static<P>, setState: (state: Static<S>) => Promise<void>, id: string) => Promise<void>;
|
||||||
|
|
||||||
@@ -19,9 +21,9 @@ export type EventTypeOptions<P extends TSchema, S extends TSchema> = {
|
|||||||
};
|
};
|
||||||
|
|
||||||
type EventQueueCfg = {
|
type EventQueueCfg = {
|
||||||
retry: {
|
error: {
|
||||||
limit: number,
|
limit: number,
|
||||||
delayMs: number,
|
initialRetryDelayMs: number,
|
||||||
},
|
},
|
||||||
concurrency: {
|
concurrency: {
|
||||||
limit: number,
|
limit: number,
|
||||||
@@ -36,10 +38,20 @@ export function defineEventType<P extends TSchema, S extends TSchema>(opt: Event
|
|||||||
return opt;
|
return opt;
|
||||||
}
|
}
|
||||||
|
|
||||||
|
function addJitter(delay: number, jitterFactor: number): number {
|
||||||
|
const jitterMultiplier = 1 + (Math.random() - 0.5) * jitterFactor;
|
||||||
|
return delay * jitterMultiplier;
|
||||||
|
}
|
||||||
|
|
||||||
|
function exponentialDelay(initialDelay: number, tries: number, cap: number = Infinity) {
|
||||||
|
return Math.min(initialDelay * (2 ** tries), cap);
|
||||||
|
}
|
||||||
|
|
||||||
export class EventQueue<G extends string, T extends Record<string, EventTypeOptions<any, any>>> {
|
export class EventQueue<G extends string, T extends Record<string, EventTypeOptions<any, any>>> {
|
||||||
private static readonly DEQUEUE_RETRY_DELAY_MS = 10000; // 10 seconds
|
private static readonly DEQUEUE_RETRY_DELAY_MS = secToMs(10);
|
||||||
private static readonly DEQUEUE_RETRY_LIMIT = 3;
|
private static readonly DEQUEUE_RETRY_LIMIT = 3;
|
||||||
private static readonly RATE_LIMIT_RETRY_LIMIT = 15;
|
private static readonly RATE_LIMIT_RETRY_LIMIT = 15;
|
||||||
|
private static readonly JITTER_FACTOR = 0.2;
|
||||||
|
|
||||||
private _lastCleanDate: Date = new Date(0);
|
private _lastCleanDate: Date = new Date(0);
|
||||||
readonly cfg: EventQueueCfg;
|
readonly cfg: EventQueueCfg;
|
||||||
@@ -181,7 +193,7 @@ export class EventQueue<G extends string, T extends Record<string, EventTypeOpti
|
|||||||
|
|
||||||
async front(trx?: Transaction<DB>) {
|
async front(trx?: Transaction<DB>) {
|
||||||
const result = await (trx ?? db).selectFrom("events")
|
const result = await (trx ?? db).selectFrom("events")
|
||||||
.select(["id", "type", "payload", "available_at", "tries", "rate_limits"])
|
.select(["id", "type", "payload", "available_at", "errors", "rate_limits"])
|
||||||
.where("group", "=", this.group)
|
.where("group", "=", this.group)
|
||||||
.where("started_at", "is", null)
|
.where("started_at", "is", null)
|
||||||
.where("available_at", "<=", new Date())
|
.where("available_at", "<=", new Date())
|
||||||
@@ -222,7 +234,7 @@ export class EventQueue<G extends string, T extends Record<string, EventTypeOpti
|
|||||||
.execute();
|
.execute();
|
||||||
}
|
}
|
||||||
|
|
||||||
private async processEvent(event: Pick<Selectable<DB["events"]>, "id" | "type" | "tries" | "payload" | "rate_limits">) {
|
private async processEvent(event: Pick<Selectable<DB["events"]>, "id" | "type" | "errors" | "payload" | "rate_limits">) {
|
||||||
log.info({ id: event.id, type: event.type, payload: event.payload }, "processing event");
|
log.info({ id: event.id, type: event.type, payload: event.payload }, "processing event");
|
||||||
if (!(event.type in this.events)) throw new Error(`event type not registered in this queue (${this.group}): ${event.type}`);
|
if (!(event.type in this.events)) throw new Error(`event type not registered in this queue (${this.group}): ${event.type}`);
|
||||||
const cfg = this.events[event.type as keyof T]!;
|
const cfg = this.events[event.type as keyof T]!;
|
||||||
@@ -235,26 +247,30 @@ export class EventQueue<G extends string, T extends Record<string, EventTypeOpti
|
|||||||
catch (err) {
|
catch (err) {
|
||||||
if (err instanceof RateLimitError && event.rate_limits < EventQueue.RATE_LIMIT_RETRY_LIMIT) {
|
if (err instanceof RateLimitError && event.rate_limits < EventQueue.RATE_LIMIT_RETRY_LIMIT) {
|
||||||
log.warn(
|
log.warn(
|
||||||
{ tries: event.tries, delay: err.retryDelayMs, source: err.source, payload: err.payload },
|
{ rateLimits: event.rate_limits, delay: err.retryDelayMs, source: err.source, payload: err.payload },
|
||||||
"encountered a rate limit error"
|
"encountered a rate limit error"
|
||||||
);
|
);
|
||||||
await this.retry(event.id, err.retryDelayMs, { isRateLimit: true });
|
await this.retry(event.id, err.retryDelayMs, "ratelimit");
|
||||||
return;
|
return;
|
||||||
}
|
}
|
||||||
|
|
||||||
if (err instanceof AssertError) {
|
if (err instanceof AssertError) {
|
||||||
log.error({ tries: event.tries }, "could not process event: malformed payload");
|
log.error({ errors: event.errors }, "could not process event: malformed payload");
|
||||||
await this.fail(event.id);
|
await this.fail(event.id);
|
||||||
return;
|
return;
|
||||||
}
|
}
|
||||||
|
|
||||||
if ((event.tries - event.rate_limits) < this.cfg.retry.limit) {
|
if (event.errors < this.cfg.error.limit) {
|
||||||
log.warn({ err, tries: event.tries, delay: this.cfg.retry.delayMs }, "encountered an error during event processing, retrying")
|
const retryDelayMs = addJitter(
|
||||||
await this.retry(event.id, this.cfg.retry.delayMs);
|
exponentialDelay(this.cfg.error.initialRetryDelayMs, event.errors),
|
||||||
|
EventQueue.JITTER_FACTOR
|
||||||
|
);
|
||||||
|
log.warn({ err, errors: event.errors, retryDelayMs: retryDelayMs }, "encountered an error during event processing, retrying")
|
||||||
|
await this.retry(event.id, retryDelayMs, "error");
|
||||||
return;
|
return;
|
||||||
}
|
}
|
||||||
|
|
||||||
log.error({ err, tries: event.tries }, "event failed");
|
log.error({ err, errors: event.errors, rateLimits: event.rate_limits }, "event failed");
|
||||||
await this.fail(event.id);
|
await this.fail(event.id);
|
||||||
}
|
}
|
||||||
}
|
}
|
||||||
@@ -266,11 +282,11 @@ export class EventQueue<G extends string, T extends Record<string, EventTypeOpti
|
|||||||
.execute();
|
.execute();
|
||||||
}
|
}
|
||||||
|
|
||||||
private async retry(id: string, delayMs: number, opt: { isRateLimit?: boolean } = {}) {
|
private async retry(id: string, delayMs: number, type: RetryType) {
|
||||||
await db.updateTable("events")
|
await db.updateTable("events")
|
||||||
.set((eb) => ({
|
.set((eb) => ({
|
||||||
tries: eb("tries", "+", 1),
|
errors: type === "error" ? eb("errors", "+", 1) : eb.ref("errors"),
|
||||||
rate_limits: opt.isRateLimit ? eb("rate_limits", "+", 1) : eb.ref("rate_limits"),
|
rate_limits: type === "ratelimit" ? eb("rate_limits", "+", 1) : eb.ref("rate_limits"),
|
||||||
started_at: null,
|
started_at: null,
|
||||||
ended_at: null,
|
ended_at: null,
|
||||||
has_failed: false,
|
has_failed: false,
|
||||||
|
|||||||
Reference in New Issue
Block a user