Server: Update and clean logging a bit

Sharp: Switch back to sharp due to bugs in main sharp git.

api/media/routes.mjs

@@ -1,5 +1,5 @@
 import path from 'path'
-import sharp from 'sharp-lite'
+import sharp from 'sharp'
 import fs from 'fs/promises'
 import { HttpError } from '../error.mjs'
 import * as security from './security.mjs'

api/server.mjs

@@ -1,5 +1,5 @@
 import { performance } from 'perf_hooks'
-import { Flaska, QueryHandler, JsonHandler } from 'flaska'
+import { Flaska, QueryHandler, JsonHandler, HttpError } from 'flaska'
 
 import TestRoutes from './test/routes.mjs'
 import MediaRoutes from './media/routes.mjs'
@@ -20,28 +20,47 @@ app.before(function(ctx) {
 
 app.after(function(ctx) {
   let ended = performance.now() - ctx.__started
-  let logger = ctx.log.info
+
+  let status = ''
+  let level = 'info'
   if (ctx.status >= 400) {
-    logger = ctx.log.warn
+    status = ctx.status + ' '
+    level = 'warn'
   }
-  logger.apply(ctx.log, [{
+  if (ctx.status >= 500) {
-    path: ctx.url,
+    level = 'error'
+  }
+
+  ctx.log[level]({
+    duration: Math.round(ended),
     status: ctx.status,
-    ms: Math.round(ended),
+  }, `<-- ${status}${ctx.method} ${ctx.url}`)
-  }, 'Request finished'])
 })
 
 app.onerror(function(err, ctx) {
+  
   if (err.status && err.status >= 400 && err.status < 500) {
+    if (err.body && err.body.request) {
+      ctx.log.warn({ request: err.body.request}, err.message)
+    } else {
       ctx.log.warn(err.message)
+    }
   } else {
     ctx.log.error(err)
   }
   ctx.status = err.status || 500
+
+  if (err instanceof HttpError) {
+    ctx.body = err.body || {
+      status: ctx.status,
+      message: err.message,
+    }
+  } else {
     ctx.body = {
       status: ctx.status,
       message: err.message,
     }
+  }
 })
 
 const test = new TestRoutes()

package.json

@@ -1,6 +1,6 @@
 {
   "name": "storage-upload",
-  "version": "2.1.2",
+  "version": "2.1.3",
   "description": "",
   "main": "index.js",
   "scripts": {
@@ -31,11 +31,11 @@
   },
   "homepage": "https://github.com/nfp-projects/storage-upload#readme",
   "dependencies": {
-    "bunyan-lite": "^1.1.1",
+    "bunyan-lite": "^1.2.0",
     "flaska": "^1.2.3",
     "formidable": "^1.2.2",
     "nconf-lite": "^2.0.0",
-    "sharp-lite": "^1.29.6"
+    "sharp": "^0.30.3"
   },
   "devDependencies": {
     "eltro": "^1.2.3"

test/media/api.test.mjs

@@ -1,4 +1,4 @@
-import sharp from 'sharp-lite'
+import sharp from 'sharp'
 import { Eltro as t, assert} from 'eltro'
 import fs from 'fs/promises'
 import { fileURLToPath } from 'url'

test/server.test.mjs

@@ -19,8 +19,7 @@ t.describe('Server', function() {
     assert.ok(data.version)
     assert.strictEqual(server.log.info.callCount, 1)
     assert.strictEqual(server.log.info.lastCall[0].status, 200)
-    assert.strictEqual(server.log.info.lastCall[0].path, '/')
+    assert.match(server.log.info.lastCall[1], /\<-- GET \//)
-    assert.strictEqual(typeof(server.log.info.lastCall[0].ms), 'number')
   })
 
   t.test('should handle errors fine', async function() {
@@ -32,9 +31,9 @@ t.describe('Server', function() {
     assert.ok(data.body)
     assert.strictEqual(data.body.status, 500)
     assert.match(data.body.message, /test/)
-    assert.strictEqual(server.log.warn.callCount, 1)
+    assert.strictEqual(server.log.error.firstCall[0].message, 'This is a test')
-    assert.strictEqual(server.log.warn.lastCall[0].status, 500)
+    assert.strictEqual(server.log.error.callCount, 2)
-    assert.strictEqual(server.log.warn.lastCall[0].path, '/error')
+    assert.strictEqual(server.log.error.secondCall[0].status, 500)
-    assert.strictEqual(typeof(server.log.warn.lastCall[0].ms), 'number')
+    assert.match(server.log.error.secondCall[1], /\<-- 500 GET \/error/)
   })
 })