Improve logging

Author: deptyped

src/bot/helpers/logging.ts

@@ -12,7 +12,7 @@ export function getUpdateInfo(ctx: Context): Omit<Update, "update_id"> {
 export function logHandle(id: string): Middleware<Context> {
   return (ctx, next) => {
     ctx.logger.info({
-      msg: `handle ${id}`,
+      msg: `Handle "${id}"`,
       ...(id.startsWith("unhandled") ? { update: getUpdateInfo(ctx) } : {}),
     });
 

src/bot/middlewares/update-logger.ts

@@ -7,7 +7,7 @@ export function updateLogger(): Middleware<Context> {
   return async (ctx, next) => {
     ctx.api.config.use((previous, method, payload, signal) => {
       ctx.logger.debug({
-        msg: "bot api call",
+        msg: "Bot API call",
         method,
         payload,
       });
@@ -16,7 +16,7 @@ export function updateLogger(): Middleware<Context> {
     });
 
     ctx.logger.debug({
-      msg: "update received",
+      msg: "Update received",
       update: getUpdateInfo(ctx),
     });
 
@@ -26,8 +26,8 @@ export function updateLogger(): Middleware<Context> {
     } finally {
       const endTime = performance.now();
       ctx.logger.debug({
-        msg: "update processed",
-        duration: endTime - startTime,
+        msg: "Update processed",
+        elapsed: endTime - startTime,
       });
     }
   };

src/main.ts

@@ -13,7 +13,7 @@ try {
 
   // graceful shutdown
   onShutdown(async () => {
-    logger.info("shutdown");
+    logger.info("Shutdown");
 
     await bot.stop();
   });
@@ -47,12 +47,16 @@ try {
       allowed_updates: config.BOT_ALLOWED_UPDATES,
       secret_token: config.BOT_WEBHOOK_SECRET,
     });
+    logger.info({
+      msg: "Webhook was set",
+      url: config.BOT_WEBHOOK,
+    });
   } else if (config.BOT_MODE === "polling") {
     await bot.start({
       allowed_updates: config.BOT_ALLOWED_UPDATES,
       onStart: ({ username }) =>
         logger.info({
-          msg: "bot running...",
+          msg: "Bot running...",
           username,
         }),
     });