diff --git a/.circleci/config.yml b/.circleci/config.yml index 4c4f2a9d..e63809d9 100644 --- a/.circleci/config.yml +++ b/.circleci/config.yml @@ -93,7 +93,7 @@ jobs: command: mkdir -p ./audit/results - run: name: Check for new npm vulnerabilities - command: npm run audit:check --silent -- --json > ./audit/results/auditResults.json + command: npm run audit:check --silent -- --json > ./audit/results/auditResults.json - store_artifacts: path: ./audit/results prefix: audit diff --git a/.ncurc.json b/.ncurc.json index cbec967a..489a7bf4 100644 --- a/.ncurc.json +++ b/.ncurc.json @@ -1,5 +1,10 @@ { "reject": [ - + "hapi-swagger", + "@hapi/joi", + "@hapi/inert", + "@hapi/good", + "@hapi/vision", + "@hapi/hapi" ] } diff --git a/audit-resolve.json b/audit-resolve.json index d8776842..2cfccba0 100644 --- a/audit-resolve.json +++ b/audit-resolve.json @@ -2,43 +2,43 @@ "decisions": { "1179|@mojaloop/central-services-logger>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|@mojaloop/central-services-shared>@mojaloop/central-services-logger>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|@mojaloop/central-services-shared>@mojaloop/event-sdk>@mojaloop/central-services-logger>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|@mojaloop/central-services-shared>@mojaloop/event-sdk>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|npm-check-updates>requireg>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|npm-check-updates>update-notifier>latest-version>package-json>registry-auth-token>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|npm-check-updates>update-notifier>latest-version>package-json>registry-url>rc>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|standard>standard-engine>minimist": { "decision": "ignore", - "madeAt": 1585126050129, - "expiresAt": 1585730841159 + "madeAt": 1586850165517, + "expiresAt": 1587454961179 }, "1179|npm-check-updates>rc-config-loader>json5>minimist": { "decision": "ignore", @@ -47,23 +47,23 @@ }, "1179|@mojaloop/central-services-shared>@mojaloop/event-sdk>grpc>node-pre-gyp>mkdirp>minimist": { "decision": "ignore", - "madeAt": 1585126057838, - "expiresAt": 1585730841159 + "madeAt": 1586850170432, + "expiresAt": 1587454961179 }, "1179|@mojaloop/central-services-shared>@mojaloop/event-sdk>grpc>node-pre-gyp>tar>mkdirp>minimist": { "decision": "ignore", - "madeAt": 1585126057838, - "expiresAt": 1585730841159 + "madeAt": 1586850170432, + "expiresAt": 1587454961179 }, "1179|@mojaloop/central-services-shared>@mojaloop/event-sdk>grpc>node-pre-gyp>rc>minimist": { "decision": "ignore", - "madeAt": 1585126057838, - "expiresAt": 1585730841159 + "madeAt": 1586850170432, + "expiresAt": 1587454961179 }, "1179|hapi-swagger>handlebars>optimist>minimist": { "decision": "ignore", - "madeAt": 1585126057838, - "expiresAt": 1585730841159 + "madeAt": 1586850167997, + "expiresAt": 1587454961179 }, "1179|standard>eslint>file-entry-cache>flat-cache>write>mkdirp>minimist": { "decision": "ignore", diff --git a/package-lock.json b/package-lock.json index fcd3b290..ec6bc387 100644 --- a/package-lock.json +++ b/package-lock.json @@ -1,6 +1,6 @@ { "name": "sims", - "version": "9.4.0", + "version": "9.5.0", "lockfileVersion": 1, "requires": true, "dependencies": { @@ -31,9 +31,9 @@ } }, "@grpc/proto-loader": { - "version": "0.5.3", - "resolved": "https://registry.npmjs.org/@grpc/proto-loader/-/proto-loader-0.5.3.tgz", - "integrity": "sha512-8qvUtGg77G2ZT2HqdqYoM/OY97gQd/0crSG34xNmZ4ZOsv3aQT/FQV9QfZPazTGna6MIoyUd+u6AxsoZjJ/VMQ==", + "version": "0.5.4", + "resolved": "https://registry.npmjs.org/@grpc/proto-loader/-/proto-loader-0.5.4.tgz", + "integrity": "sha512-HTM4QpI9B2XFkPz7pjwMyMgZchJ93TVkL3kWPW8GDMDKYxsMnmf4w2TNMJK7+KNiYHS5cJrCEAFlF+AwtXWVPA==", "requires": { "lodash.camelcase": "^4.3.0", "protobufjs": "^6.8.6" @@ -413,9 +413,9 @@ } }, "@mojaloop/central-services-logger": { - "version": "9.1.0", - "resolved": "https://registry.npmjs.org/@mojaloop/central-services-logger/-/central-services-logger-9.1.0.tgz", - "integrity": "sha512-V45TPKI+0mqrSuQBOGH01yVotldu/6XCjsNKZ0M+82Kwhb0enQFSb4CKUr6TLjZINQfrNzQOofaSCJx8sUeSpg==", + "version": "9.5.1", + "resolved": "https://registry.npmjs.org/@mojaloop/central-services-logger/-/central-services-logger-9.5.1.tgz", + "integrity": "sha512-VItX0jmJkGk5GiXnO5s2Fz7cpYvGtq0AmzrjT+Va39XvL/eMPMvzDy08wRbkcyD/RRTzu/20BKMWBw7GtkzG6A==", "requires": { "parse-strings-in-object": "2.0.0", "rc": "1.2.8", @@ -423,24 +423,24 @@ } }, "@mojaloop/central-services-metrics": { - "version": "9.1.0", - "resolved": "https://registry.npmjs.org/@mojaloop/central-services-metrics/-/central-services-metrics-9.1.0.tgz", - "integrity": "sha512-pE+zgVduOORYipJsUTa3ugm930Uzm8dnLxIkJEpBFoZWPqknDMTSZFvy2PU3g/hft2+IIuLSlOzHC7YxNdWBRA==", + "version": "9.5.0", + "resolved": "https://registry.npmjs.org/@mojaloop/central-services-metrics/-/central-services-metrics-9.5.0.tgz", + "integrity": "sha512-4wba5JCNhmevBEHAPl+BmMqTmfT/7lOxbuRlziyAFhcySrZpCQhINMwyGm1CmNlldsDtp8rHaL5inQzKAGsBXA==", "requires": { "prom-client": "11.5.3" } }, "@mojaloop/central-services-shared": { - "version": "9.4.1", - "resolved": "https://registry.npmjs.org/@mojaloop/central-services-shared/-/central-services-shared-9.4.1.tgz", - "integrity": "sha512-gy5OOCMyqJ8MzH+0p/ZuakYX3dDU6YMQLwFnu1kz6FBjJ159VDLylDDTL8gM52EF8cfn7nr3Y64jSQfdgdR4Vw==", + "version": "9.5.5", + "resolved": "https://registry.npmjs.org/@mojaloop/central-services-shared/-/central-services-shared-9.5.5.tgz", + "integrity": "sha512-n5esiCEeLQgyREepQmH/rwznQmBCIahaa1wGbZtGiwnGCaPNVvlW3jdoPpilQUmMs6u6RIlMQWxIlM1lw8kq+Q==", "requires": { "@hapi/catbox": "11.1.0", "@hapi/catbox-memory": "5.0.0", "@mojaloop/central-services-error-handling": "9.1.0", - "@mojaloop/central-services-logger": "9.1.0", - "@mojaloop/central-services-metrics": "9.1.0", - "@mojaloop/event-sdk": "9.4.1", + "@mojaloop/central-services-logger": "9.5.1", + "@mojaloop/central-services-metrics": "9.5.0", + "@mojaloop/event-sdk": "9.5.2", "axios": "0.19.2", "base64url": "3.0.1", "clone": "2.1.2", @@ -465,12 +465,12 @@ } }, "@mojaloop/event-sdk": { - "version": "9.4.1", - "resolved": "https://registry.npmjs.org/@mojaloop/event-sdk/-/event-sdk-9.4.1.tgz", - "integrity": "sha512-lTe+rt4utAohTOS+zBGNJA99VE4qEC/pamFMACqygT73WSSu6A5eMrn2243xmBEM+mXmIL1/2XUeR5JESAJBAA==", + "version": "9.5.2", + "resolved": "https://registry.npmjs.org/@mojaloop/event-sdk/-/event-sdk-9.5.2.tgz", + "integrity": "sha512-fDpqx+kwwCcBZ4hNQ+xyhQLVuB+8VEhoamP+DVZzSZck8qTqzTomLMhlXGPlnGJx6g4yL8JGfAAqbaz+Tqg0Aw==", "requires": { - "@grpc/proto-loader": "0.5.3", - "@mojaloop/central-services-logger": "9.1.0", + "@grpc/proto-loader": "0.5.4", + "@mojaloop/central-services-logger": "9.5.1", "brototype": "0.0.6", "error-callsites": "2.0.3", "grpc": "1.24.2", @@ -480,18 +480,11 @@ "protobufjs": "6.8.9", "rc": "1.2.8", "serialize-error": "4.1.0", - "sinon": "9.0.1", + "sinon": "9.0.2", "traceparent": "1.0.0", "tslib": "1.11.1", "uuid4": "1.1.4", "winston": "3.2.1" - }, - "dependencies": { - "tslib": { - "version": "1.11.1", - "resolved": "https://registry.npmjs.org/tslib/-/tslib-1.11.1.tgz", - "integrity": "sha512-aZW88SY8kQbU7gpV19lN24LtXh/yD4ZZg6qieAJDDg+YBsJcSmLGK9QpnUjAKVG/xefmvJGd1WUmfpT/g6AJGA==" - } } }, "@mojaloop/sdk-standard-components": { @@ -552,9 +545,9 @@ } }, "@npmcli/promise-spawn": { - "version": "1.1.0", - "resolved": "https://registry.npmjs.org/@npmcli/promise-spawn/-/promise-spawn-1.1.0.tgz", - "integrity": "sha512-FwbuYN9KXBkloLeIR3xRgI8dyOdfK/KzaJlChszNuwmUXD1lHXfLlSeo4n4KrKt2udIK9K9/TzlnyCA3ubM2fA==", + "version": "1.2.0", + "resolved": "https://registry.npmjs.org/@npmcli/promise-spawn/-/promise-spawn-1.2.0.tgz", + "integrity": "sha512-nFtqjVETliApiRdjbYwKwhlSHx2ZMagyj5b9YbNt0BWeeOVxJd47ZVE2u16vxDHyTOZvk+YLV7INwfAE9a2uow==", "dev": true, "requires": { "infer-owner": "^1.0.4" @@ -621,9 +614,9 @@ "dev": true }, "@sinonjs/commons": { - "version": "1.7.1", - "resolved": "https://registry.npmjs.org/@sinonjs/commons/-/commons-1.7.1.tgz", - "integrity": "sha512-Debi3Baff1Qu1Unc3mjJ96MgpbwTn43S1+9yJ0llWygPwDNu2aaWBD6yc9y/Z8XDRNhx7U+u2UDg2OGQXkclUQ==", + "version": "1.7.2", + "resolved": "https://registry.npmjs.org/@sinonjs/commons/-/commons-1.7.2.tgz", + "integrity": "sha512-+DUO6pnp3udV/v2VfUWgaY5BIE1IfT7lLfeDzPVeMT1XKkaAp9LgSI9x5RtrFQoZ9Oi0PgXQQHPaoKu7dCjVxw==", "requires": { "type-detect": "4.0.8" } @@ -696,9 +689,9 @@ "integrity": "sha512-5tXH6Bx/kNGd3MgffdmP4dy2Z+G4eaXw0SE81Tq3BNadtnMR5/ySMzX4SLEzHJzSmPNn4HIdpQsBvXMUykr58w==" }, "@types/node": { - "version": "10.17.17", - "resolved": "https://registry.npmjs.org/@types/node/-/node-10.17.17.tgz", - "integrity": "sha512-gpNnRnZP3VWzzj5k3qrpRC6Rk3H/uclhAVo1aIvwzK5p5cOrs9yEyQ8H/HBsBY0u5rrWxXEiVPQ0dEB6pkjE8Q==" + "version": "10.17.19", + "resolved": "https://registry.npmjs.org/@types/node/-/node-10.17.19.tgz", + "integrity": "sha512-46/xThm3zvvc9t9/7M3AaLEqtOpqlYYYcCZbpYVAQHG20+oMZBkae/VMrn4BTi6AJ8cpack0mEXhGiKmDNbLrQ==" }, "abab": { "version": "2.0.3", @@ -1227,6 +1220,17 @@ "ssri": "^8.0.0", "tar": "^6.0.1", "unique-filename": "^1.1.1" + }, + "dependencies": { + "p-map": { + "version": "3.0.0", + "resolved": "https://registry.npmjs.org/p-map/-/p-map-3.0.0.tgz", + "integrity": "sha512-d3qXVTF/s+W+CdJ5A29wywV2n8CQQYahlgz2bFiA+4eVNJbHJodPZ+/gXwPGh0bOqA+j8S+6+ckmvLGPk1QpxQ==", + "dev": true, + "requires": { + "aggregate-error": "^3.0.0" + } + } } }, "cacheable-request": { @@ -1541,9 +1545,9 @@ "dev": true }, "mkdirp": { - "version": "0.5.4", - "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-0.5.4.tgz", - "integrity": "sha512-iG9AK/dJLtJ0XNgTuDbSyNS3zECqDlAhnQW4CsNxBG3LQJBbHmRX1egw39DmtOdCAqY+dKXV+sgPgilNWUKMVw==", + "version": "0.5.5", + "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-0.5.5.tgz", + "integrity": "sha512-NKmAlESf6jMGym1++R0Ra7wvhV+wFW63FaSOFPwRahvea0gMUcGUhVeAg/0BC0wiv9ih5NYPB1Wn1UEI1/L+xQ==", "dev": true, "requires": { "minimist": "^1.2.5" @@ -2339,21 +2343,6 @@ "integrity": "sha512-kVscqXk4OCp68SZ0dkgEKVi6/8ij300KBWTJq32P/dYeWTSwK41WyTxalN1eRmA5Z9UU/LX9D7FWSmV9SAYx6g==", "dev": true }, - "execa": { - "version": "1.0.0", - "resolved": "https://registry.npmjs.org/execa/-/execa-1.0.0.tgz", - "integrity": "sha512-adbxcyWV46qiHyvSp50TKt05tB4tK3HcmF7/nxfAdhnox83seTDbwnaqKO4sXRy7roHAIFqJP/Rw/AuEbX61LA==", - "dev": true, - "requires": { - "cross-spawn": "^6.0.0", - "get-stream": "^4.0.0", - "is-stream": "^1.1.0", - "npm-run-path": "^2.0.0", - "p-finally": "^1.0.0", - "signal-exit": "^3.0.0", - "strip-eof": "^1.0.0" - } - }, "extend": { "version": "3.0.2", "resolved": "https://registry.npmjs.org/extend/-/extend-3.0.2.tgz", @@ -3549,9 +3538,9 @@ } }, "is-installed-globally": { - "version": "0.3.1", - "resolved": "https://registry.npmjs.org/is-installed-globally/-/is-installed-globally-0.3.1.tgz", - "integrity": "sha512-oiEcGoQbGc+3/iijAijrK2qFpkNoNjsHOm/5V5iaeydyrS/hnwaRCEgH5cpW0P3T1lSjV5piB7S5b5lEugNLhg==", + "version": "0.3.2", + "resolved": "https://registry.npmjs.org/is-installed-globally/-/is-installed-globally-0.3.2.tgz", + "integrity": "sha512-wZ8x1js7Ia0kecP/CHM/3ABkAmujX7WPvQk6uu3Fly/Mk44pySulQpnHG46OMjHGXApINnV4QhY3SWnECO2z5g==", "dev": true, "requires": { "global-dirs": "^2.0.1", @@ -3743,9 +3732,9 @@ "integrity": "sha1-Epai1Y/UXxmg9s4B1lcB4sc1tus=" }, "json5": { - "version": "2.1.2", - "resolved": "https://registry.npmjs.org/json5/-/json5-2.1.2.tgz", - "integrity": "sha512-MoUOQ4WdiN3yxhm7NEVJSJrieAo5hNSLQ5sj05OTRHPL9HOBy8u4Bu88jsC1jvqAdN+E1bJmsUcZH+1HQxliqQ==", + "version": "2.1.3", + "resolved": "https://registry.npmjs.org/json5/-/json5-2.1.3.tgz", + "integrity": "sha512-KXPvOm8K9IJKFM0bmdn8QXh7udDh1g/giieX0NLCaMnb4hEiVFqnop2ImTXCc5e0/oHz3LTqmHGtExn5hfMkOA==", "dev": true, "requires": { "minimist": "^1.2.5" @@ -4223,9 +4212,9 @@ } }, "mkdirp": { - "version": "1.0.3", - "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-1.0.3.tgz", - "integrity": "sha512-6uCP4Qc0sWsgMLy1EOqqS/3rjDHOEnsStVr/4vtAIK2Y5i2kA7lFFejYrpIyiN9w0pYf4ckeCYT9f1r1P9KX5g==", + "version": "1.0.4", + "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-1.0.4.tgz", + "integrity": "sha512-vVqVZQyf3WLx2Shd0qJ9xuvqgAyKPLAiqITEtqW0oIUjzo3PePDd6fW9iFz30ef7Ysp/oiWqbhszeGWW2T6Gzw==", "dev": true }, "moment": { @@ -4254,9 +4243,9 @@ "dev": true }, "mkdirp": { - "version": "0.5.4", - "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-0.5.4.tgz", - "integrity": "sha512-iG9AK/dJLtJ0XNgTuDbSyNS3zECqDlAhnQW4CsNxBG3LQJBbHmRX1egw39DmtOdCAqY+dKXV+sgPgilNWUKMVw==", + "version": "0.5.5", + "resolved": "https://registry.npmjs.org/mkdirp/-/mkdirp-0.5.5.tgz", + "integrity": "sha512-NKmAlESf6jMGym1++R0Ra7wvhV+wFW63FaSOFPwRahvea0gMUcGUhVeAg/0BC0wiv9ih5NYPB1Wn1UEI1/L+xQ==", "dev": true, "requires": { "minimist": "^1.2.5" @@ -4426,9 +4415,9 @@ } }, "npm-check-updates": { - "version": "4.0.5", - "resolved": "https://registry.npmjs.org/npm-check-updates/-/npm-check-updates-4.0.5.tgz", - "integrity": "sha512-dO2jeEmD1DAa/8NKxQAuhVsICDYWKTL1kZkvUFyRNphK4NiLk1HA7Jk5mCfl2L2xU5FxiGhNq5vgYlivu+2kjw==", + "version": "4.1.2", + "resolved": "https://registry.npmjs.org/npm-check-updates/-/npm-check-updates-4.1.2.tgz", + "integrity": "sha512-CRO20Z12fygKL/ow4j4pnpyxevda/PuFbWpsF5E9sFW0B+M3d32A1dD+fTHLDjgderhKXr64W8qQ6M/Gq8OLiw==", "dev": true, "requires": { "chalk": "^3.0.0", @@ -4442,12 +4431,13 @@ "libnpmconfig": "^1.2.1", "lodash": "^4.17.15", "node-alias": "^1.0.4", + "p-map": "^4.0.0", "pacote": "^11.1.4", "progress": "^2.0.3", "prompts": "^2.3.2", "rc-config-loader": "^3.0.0", "requireg": "^0.2.2", - "semver": "^7.1.3", + "semver": "^7.2.1", "semver-utils": "^1.1.4", "spawn-please": "^0.3.0", "update-notifier": "^4.1.0" @@ -4529,9 +4519,9 @@ "dev": true }, "semver": { - "version": "7.1.3", - "resolved": "https://registry.npmjs.org/semver/-/semver-7.1.3.tgz", - "integrity": "sha512-ekM0zfiA9SCBlsKa2X1hxyxiI4L3B6EbVJkkdgQXnSEEaHlGdvyodMruTiulSRWMMB4NeIuYNMC9rTKTz97GxA==", + "version": "7.3.0", + "resolved": "https://registry.npmjs.org/semver/-/semver-7.3.0.tgz", + "integrity": "sha512-uyvgU/igkrMgNHwLgXvlpD9jEADbJhB0+JXSywoO47JgJ6c16iau9F9cjtc/E5o0PoqRYTiTIAPRKaYe84z6eQ==", "dev": true } } @@ -4546,9 +4536,9 @@ }, "dependencies": { "semver": { - "version": "7.1.3", - "resolved": "https://registry.npmjs.org/semver/-/semver-7.1.3.tgz", - "integrity": "sha512-ekM0zfiA9SCBlsKa2X1hxyxiI4L3B6EbVJkkdgQXnSEEaHlGdvyodMruTiulSRWMMB4NeIuYNMC9rTKTz97GxA==", + "version": "7.3.0", + "resolved": "https://registry.npmjs.org/semver/-/semver-7.3.0.tgz", + "integrity": "sha512-uyvgU/igkrMgNHwLgXvlpD9jEADbJhB0+JXSywoO47JgJ6c16iau9F9cjtc/E5o0PoqRYTiTIAPRKaYe84z6eQ==", "dev": true } } @@ -4571,9 +4561,9 @@ }, "dependencies": { "semver": { - "version": "7.1.3", - "resolved": "https://registry.npmjs.org/semver/-/semver-7.1.3.tgz", - "integrity": "sha512-ekM0zfiA9SCBlsKa2X1hxyxiI4L3B6EbVJkkdgQXnSEEaHlGdvyodMruTiulSRWMMB4NeIuYNMC9rTKTz97GxA==", + "version": "7.3.0", + "resolved": "https://registry.npmjs.org/semver/-/semver-7.3.0.tgz", + "integrity": "sha512-uyvgU/igkrMgNHwLgXvlpD9jEADbJhB0+JXSywoO47JgJ6c16iau9F9cjtc/E5o0PoqRYTiTIAPRKaYe84z6eQ==", "dev": true } } @@ -4591,9 +4581,9 @@ } }, "npm-pick-manifest": { - "version": "6.0.0", - "resolved": "https://registry.npmjs.org/npm-pick-manifest/-/npm-pick-manifest-6.0.0.tgz", - "integrity": "sha512-PdJpXMvjqt4nftNEDpCgjBUF8yI3Q3MyuAmVB9nemnnCg32F4BPL/JFBfdj8DubgHCYUFQhtLWmBPvdsFtjWMg==", + "version": "6.1.0", + "resolved": "https://registry.npmjs.org/npm-pick-manifest/-/npm-pick-manifest-6.1.0.tgz", + "integrity": "sha512-ygs4k6f54ZxJXrzT0x34NybRlLeZ4+6nECAIbr2i0foTnijtS1TJiyzpqtuUAJOps/hO0tNDr8fRV5g+BtRlTw==", "dev": true, "requires": { "npm-install-checks": "^4.0.0", @@ -4602,9 +4592,9 @@ }, "dependencies": { "semver": { - "version": "7.1.3", - "resolved": "https://registry.npmjs.org/semver/-/semver-7.1.3.tgz", - "integrity": "sha512-ekM0zfiA9SCBlsKa2X1hxyxiI4L3B6EbVJkkdgQXnSEEaHlGdvyodMruTiulSRWMMB4NeIuYNMC9rTKTz97GxA==", + "version": "7.3.0", + "resolved": "https://registry.npmjs.org/semver/-/semver-7.3.0.tgz", + "integrity": "sha512-uyvgU/igkrMgNHwLgXvlpD9jEADbJhB0+JXSywoO47JgJ6c16iau9F9cjtc/E5o0PoqRYTiTIAPRKaYe84z6eQ==", "dev": true } } @@ -4843,9 +4833,9 @@ } }, "p-map": { - "version": "3.0.0", - "resolved": "https://registry.npmjs.org/p-map/-/p-map-3.0.0.tgz", - "integrity": "sha512-d3qXVTF/s+W+CdJ5A29wywV2n8CQQYahlgz2bFiA+4eVNJbHJodPZ+/gXwPGh0bOqA+j8S+6+ckmvLGPk1QpxQ==", + "version": "4.0.0", + "resolved": "https://registry.npmjs.org/p-map/-/p-map-4.0.0.tgz", + "integrity": "sha512-/bjOqmgETBYB5BoEeGVea8dmvHb2m9GLy1E9W43yeyfP6QQCZGFNa+XRceJEuDB6zqr+gKpIAmlLebMpykw/MQ==", "dev": true, "requires": { "aggregate-error": "^3.0.0" @@ -4909,9 +4899,9 @@ }, "dependencies": { "semver": { - "version": "7.1.3", - "resolved": "https://registry.npmjs.org/semver/-/semver-7.1.3.tgz", - "integrity": "sha512-ekM0zfiA9SCBlsKa2X1hxyxiI4L3B6EbVJkkdgQXnSEEaHlGdvyodMruTiulSRWMMB4NeIuYNMC9rTKTz97GxA==", + "version": "7.3.0", + "resolved": "https://registry.npmjs.org/semver/-/semver-7.3.0.tgz", + "integrity": "sha512-uyvgU/igkrMgNHwLgXvlpD9jEADbJhB0+JXSywoO47JgJ6c16iau9F9cjtc/E5o0PoqRYTiTIAPRKaYe84z6eQ==", "dev": true }, "which": { @@ -5739,12 +5729,12 @@ } }, "sinon": { - "version": "9.0.1", - "resolved": "https://registry.npmjs.org/sinon/-/sinon-9.0.1.tgz", - "integrity": "sha512-iTTyiQo5T94jrOx7X7QLBZyucUJ2WvL9J13+96HMfm2CGoJYbIPqRfl6wgNcqmzk0DI28jeGx5bUTXizkrqBmg==", + "version": "9.0.2", + "resolved": "https://registry.npmjs.org/sinon/-/sinon-9.0.2.tgz", + "integrity": "sha512-0uF8Q/QHkizNUmbK3LRFqx5cpTttEVXudywY9Uwzy8bTfZUhljZ7ARzSxnRHWYWtVTeh4Cw+tTb3iU21FQVO9A==", "requires": { - "@sinonjs/commons": "^1.7.0", - "@sinonjs/fake-timers": "^6.0.0", + "@sinonjs/commons": "^1.7.2", + "@sinonjs/fake-timers": "^6.0.1", "@sinonjs/formatio": "^5.0.1", "@sinonjs/samsam": "^5.0.3", "diff": "^4.0.2", @@ -6223,8 +6213,7 @@ "tslib": { "version": "1.11.1", "resolved": "https://registry.npmjs.org/tslib/-/tslib-1.11.1.tgz", - "integrity": "sha512-aZW88SY8kQbU7gpV19lN24LtXh/yD4ZZg6qieAJDDg+YBsJcSmLGK9QpnUjAKVG/xefmvJGd1WUmfpT/g6AJGA==", - "dev": true + "integrity": "sha512-aZW88SY8kQbU7gpV19lN24LtXh/yD4ZZg6qieAJDDg+YBsJcSmLGK9QpnUjAKVG/xefmvJGd1WUmfpT/g6AJGA==" }, "tunnel-agent": { "version": "0.6.0", @@ -6737,6 +6726,52 @@ "wrap-ansi": "^2.0.0" } }, + "cross-spawn": { + "version": "6.0.5", + "resolved": "https://registry.npmjs.org/cross-spawn/-/cross-spawn-6.0.5.tgz", + "integrity": "sha512-eTVLrBSt7fjbDygz805pMnstIs2VTBNkRm0qxZd+M7A5XDdxVRWO5MxGBXZhjY4cqLYLdtrGqRf8mBPmzwSpWQ==", + "dev": true, + "requires": { + "nice-try": "^1.0.4", + "path-key": "^2.0.1", + "semver": "^5.5.0", + "shebang-command": "^1.2.0", + "which": "^1.2.9" + } + }, + "execa": { + "version": "1.0.0", + "resolved": "https://registry.npmjs.org/execa/-/execa-1.0.0.tgz", + "integrity": "sha512-adbxcyWV46qiHyvSp50TKt05tB4tK3HcmF7/nxfAdhnox83seTDbwnaqKO4sXRy7roHAIFqJP/Rw/AuEbX61LA==", + "dev": true, + "requires": { + "cross-spawn": "^6.0.0", + "get-stream": "^4.0.0", + "is-stream": "^1.1.0", + "npm-run-path": "^2.0.0", + "p-finally": "^1.0.0", + "signal-exit": "^3.0.0", + "strip-eof": "^1.0.0" + } + }, + "find-up": { + "version": "3.0.0", + "resolved": "https://registry.npmjs.org/find-up/-/find-up-3.0.0.tgz", + "integrity": "sha512-1yD6RmLI1XBfxugvORwlck6f75tYL+iR0jqwsOrOxMZyGYqUuDhJ0l4AXdO1iX/FTs9cBAMEk1gWSEx1kSbylg==", + "dev": true, + "requires": { + "locate-path": "^3.0.0" + } + }, + "get-stream": { + "version": "4.1.0", + "resolved": "https://registry.npmjs.org/get-stream/-/get-stream-4.1.0.tgz", + "integrity": "sha512-GMat4EJ5161kIy2HevLlr4luNjBgvmj413KaQA7jt4V8B4RDsfpHk7WQ9GVqfYyyx8OS/L66Kox+rJRNklLK7w==", + "dev": true, + "requires": { + "pump": "^3.0.0" + } + }, "invert-kv": { "version": "2.0.0", "resolved": "https://registry.npmjs.org/invert-kv/-/invert-kv-2.0.0.tgz", @@ -6758,6 +6793,16 @@ "invert-kv": "^2.0.0" } }, + "locate-path": { + "version": "3.0.0", + "resolved": "https://registry.npmjs.org/locate-path/-/locate-path-3.0.0.tgz", + "integrity": "sha512-7AO748wWnIhNqAuaty2ZWHkQHRSNfPVIsPIfwEOWO22AmaoVrWavlOcMR5nzTLNYvp36X220/maaRsrec1G65A==", + "dev": true, + "requires": { + "p-locate": "^3.0.0", + "path-exists": "^3.0.0" + } + }, "os-locale": { "version": "3.1.0", "resolved": "https://registry.npmjs.org/os-locale/-/os-locale-3.1.0.tgz", @@ -6769,6 +6814,40 @@ "mem": "^4.0.0" } }, + "p-limit": { + "version": "2.2.2", + "resolved": "https://registry.npmjs.org/p-limit/-/p-limit-2.2.2.tgz", + "integrity": "sha512-WGR+xHecKTr7EbUEhyLSh5Dube9JtdiG78ufaeLxTgpudf/20KqyMioIUZJAezlTIi6evxuoUs9YXc11cU+yzQ==", + "dev": true, + "requires": { + "p-try": "^2.0.0" + } + }, + "p-locate": { + "version": "3.0.0", + "resolved": "https://registry.npmjs.org/p-locate/-/p-locate-3.0.0.tgz", + "integrity": "sha512-x+12w/To+4GFfgJhBEpiDcLozRJGegY+Ei7/z0tSLkMmxGZNybVMSfWj9aJn8Z5Fc7dBUNJOOVgPv2H7IwulSQ==", + "dev": true, + "requires": { + "p-limit": "^2.0.0" + } + }, + "p-try": { + "version": "2.2.0", + "resolved": "https://registry.npmjs.org/p-try/-/p-try-2.2.0.tgz", + "integrity": "sha512-R4nPAVTAU0B9D35/Gk3uJf/7XYbQcyohSKdvAxIRSNghFl4e71hVoGnBNQz9cWaXxO2I10KTC+3jMdvvoKw6dQ==", + "dev": true + }, + "pump": { + "version": "3.0.0", + "resolved": "https://registry.npmjs.org/pump/-/pump-3.0.0.tgz", + "integrity": "sha512-LwZy+p3SFs1Pytd/jYct4wpv49HiYCqd9Rlc5ZVdk0V+8Yzv6jR5Blk3TRmPL1ft69TxP0IMZGJ+WPFU2BFhww==", + "dev": true, + "requires": { + "end-of-stream": "^1.1.0", + "once": "^1.3.1" + } + }, "string-width": { "version": "2.1.1", "resolved": "https://registry.npmjs.org/string-width/-/string-width-2.1.1.tgz", diff --git a/package.json b/package.json index 3bd653b2..e340e68a 100644 --- a/package.json +++ b/package.json @@ -1,6 +1,6 @@ { "name": "sims", - "version": "9.4.0", + "version": "9.5.0", "description": "A super-simple fsp simulator", "main": "src/index.js", "author": "ModusBox", @@ -40,9 +40,9 @@ "@hapi/joi-date": "2.0.1", "@hapi/vision": "6.0.0", "@mojaloop/central-services-error-handling": "9.1.0", - "@mojaloop/central-services-logger": "9.1.0", - "@mojaloop/central-services-metrics": "9.1.0", - "@mojaloop/central-services-shared": "9.4.1", + "@mojaloop/central-services-logger": "9.5.1", + "@mojaloop/central-services-metrics": "9.5.0", + "@mojaloop/central-services-shared": "9.5.5", "axios": "0.19.2", "base64url": "3.0.1", "blipp": "4.0.1", @@ -56,6 +56,6 @@ "pre-commit": "1.2.2", "standard": "14.3.3", "npm-audit-resolver": "2.2.0", - "npm-check-updates": "4.0.5" + "npm-check-updates": "4.1.2" } } diff --git a/src/acceptheaderpayee/handler.js b/src/acceptheaderpayee/handler.js index 6c1dfebe..15b54bc6 100644 --- a/src/acceptheaderpayee/handler.js +++ b/src/acceptheaderpayee/handler.js @@ -68,7 +68,7 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -90,7 +90,7 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info('IN PAYEEFSP:: POST /acceptheaderpayeefsp/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN PAYEEFSP:: POST /acceptheaderpayeefsp/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) @@ -106,7 +106,7 @@ exports.getPartiesByTypeAndId = function (req, h) { ).startTimer() const metadata = `${req.method} ${req.path} ${req.params.id} ` - Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) // Saving Incoming request const incomingRequest = { headers: req.headers @@ -146,9 +146,9 @@ exports.getPartiesByTypeAndId = function (req, h) { data: JSON.stringify(correlationCache.get(req.params.id)) } - // Logger.info((new Date().toISOString()), 'Executing PUT', url) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'Executing PUT', url) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) @@ -156,7 +156,7 @@ exports.getPartiesByTypeAndId = function (req, h) { histTimerEnd({ success: true, fsp: 'payee', operation: 'getPartiesByTypeAndId', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) histTimerEnd({ success: false, fsp: 'payee', operation: 'getPartiesByTypeAndId', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } })() @@ -174,8 +174,8 @@ exports.postQuotes = function (req, h) { const metadata = `${req.method} ${req.path}` const quotesRequest = req.payload - Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quotesRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quotesRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -234,9 +234,9 @@ exports.postQuotes = function (req, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info((new Date().toISOString()), 'Executing PUT', url) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'Executing PUT', url) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) @@ -244,7 +244,7 @@ exports.postQuotes = function (req, h) { histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, req.path, requesterName); @@ -265,10 +265,10 @@ exports.postTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.transferId}` - Logger.info(`IN PAYEEFSP:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -317,9 +317,9 @@ exports.postTransfers = async function (req, h) { data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) @@ -332,7 +332,7 @@ exports.postTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) histTimerEnd({ success: false, fsp: 'payee', @@ -368,7 +368,7 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) @@ -390,7 +390,7 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -411,7 +411,7 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: Final response for GET /acceptheaderpayeefsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: Final response for GET /acceptheaderpayeefsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}`) histTimerEnd({ success: true, fsp: 'payee', operation: 'getcorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) @@ -424,7 +424,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -440,7 +440,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /acceptheaderpayeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/bulkTransfers/handler.js b/src/bulkTransfers/handler.js index bbd830b3..18415f39 100644 --- a/src/bulkTransfers/handler.js +++ b/src/bulkTransfers/handler.js @@ -45,10 +45,10 @@ exports.postBulkTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.bulkTransferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.bulkTransferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.bulkTransferId}` - Logger.info(`IN Bulk Transfers POST:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN Bulk Transfers POST:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -109,14 +109,14 @@ exports.postBulkTransfers = async function (req, h) { }), data: JSON.stringify(bulkTransferResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(bulkTransferResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(bulkTransferResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: req.headers['fspiop-source'], @@ -125,8 +125,8 @@ exports.postBulkTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: req.headers['fspiop-source'], @@ -143,7 +143,7 @@ exports.postBulkTransfers = async function (req, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: req.headers['fspiop-source'], @@ -162,9 +162,9 @@ exports.putBulkTransfersById = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - START`) - Logger.info(`IN Bulk Transfer:: PUT /bulkTransfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN Bulk Transfer:: PUT /bulkTransfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) @@ -175,7 +175,7 @@ exports.putBulkTransfersById = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - END`) histTimerEnd({ success: true, fsp: request.headers['fspiop-source'], @@ -193,9 +193,9 @@ exports.putBulkTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - START`) - Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -205,7 +205,7 @@ exports.putBulkTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: request.headers['fspiop-source'], @@ -223,11 +223,11 @@ exports.getCorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - START`) - Logger.info(`IN bulk transfers:: Final response for GET /bulkTransfers/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}`) + Logger.isInfoEnabled && Logger.info(`IN bulk transfers:: Final response for GET /bulkTransfers/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'getBulkCorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -239,7 +239,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -255,7 +255,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN Bulk Transfers :: PUT /bulkTransfers/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/index.js b/src/index.js index bab74b26..75fed98d 100644 --- a/src/index.js +++ b/src/index.js @@ -25,9 +25,14 @@ const Routes = require('./routes') const Setup = require('.' + '/shared/setup') +let httpHostPort = process.env.HTTP_HOST_PORT || 8444 + +if (httpHostPort && !isNaN(httpHostPort)) { + httpHostPort = parseInt(httpHostPort) +} module.exports = Setup.initialize({ service: 'api', - port: 8444, + port: httpHostPort, modules: [Routes] }) diff --git a/src/lib/metrics.js b/src/lib/metrics.js index 1c83ff32..5f81b7e1 100644 --- a/src/lib/metrics.js +++ b/src/lib/metrics.js @@ -50,7 +50,7 @@ const metricOptions = { const setup = () => { if (alreadySetup || isDisabled) { if (isDisabled) { - Logger.warn(disabledMessage) + Logger.isWarnEnabled && Logger.warn(disabledMessage) } return } diff --git a/src/lib/requestLogger.js b/src/lib/requestLogger.js index fe9ed624..4e35b04a 100644 --- a/src/lib/requestLogger.js +++ b/src/lib/requestLogger.js @@ -6,16 +6,16 @@ const Util = require('util') const logRequest = function (request) { const traceId = request.headers.traceparent ? request.headers.traceparent.split('-')[1] : undefined if (request.path.indexOf('health') > -1 || request.path.indexOf('metrics') > -1) { - Logger.debug(`L1p-Trace-Id=${traceId} - Method: ${request.method} Path: ${request.path} Query: ${JSON.stringify(request.query)}`) - Logger.debug(`L1p-Trace-Id=${traceId} - Headers: ${JSON.stringify(request.headers)}`) + Logger.isDebugEnabled && Logger.debug(`L1p-Trace-Id=${traceId} - Method: ${request.method} Path: ${request.path} Query: ${JSON.stringify(request.query)}`) + Logger.isDebugEnabled && Logger.debug(`L1p-Trace-Id=${traceId} - Headers: ${JSON.stringify(request.headers)}`) if (request.body) { - Logger.debug(`L1p-Trace-Id=${traceId} - Body: ${request.body}`) + Logger.isDebugEnabled && Logger.debug(`L1p-Trace-Id=${traceId} - Body: ${request.body}`) } } else { - Logger.info(`L1p-Trace-Id=${traceId} - Method: ${request.method} Path: ${request.path} Query: ${JSON.stringify(request.query)}`) - Logger.info(`L1p-Trace-Id=${traceId} - Headers: ${JSON.stringify(request.headers)}`) + Logger.isInfoEnabled && Logger.info(`L1p-Trace-Id=${traceId} - Method: ${request.method} Path: ${request.path} Query: ${JSON.stringify(request.query)}`) + Logger.isInfoEnabled && Logger.info(`L1p-Trace-Id=${traceId} - Headers: ${JSON.stringify(request.headers)}`) if (request.body) { - Logger.info(`L1p-Trace-Id=${traceId} - Body: ${request.body}`) + Logger.isInfoEnabled && Logger.info(`L1p-Trace-Id=${traceId} - Body: ${request.body}`) } } } @@ -31,15 +31,15 @@ const logResponse = function (request) { } if (request.path.indexOf('health') > -1 || request.path.indexOf('metrics') > -1) { if (!response) { - Logger.debug(`L1p-Trace-Id=${traceId} - Response: ${request.response}`) + Logger.isDebugEnabled && Logger.debug(`L1p-Trace-Id=${traceId} - Response: ${request.response}`) } else { - Logger.debug(`L1p-Trace-Id=${traceId} - Response: ${response} Status: ${request.response.statusCode}`) + Logger.isDebugEnabled && Logger.debug(`L1p-Trace-Id=${traceId} - Response: ${response} Status: ${request.response.statusCode}`) } } else { if (!response) { - Logger.info(`L1p-Trace-Id=${traceId} - Response: ${request.response}`) + Logger.isInfoEnabled && Logger.info(`L1p-Trace-Id=${traceId} - Response: ${request.response}`) } else { - Logger.info(`L1p-Trace-Id=${traceId} - Response: ${response} Status: ${request.response.statusCode}`) + Logger.isInfoEnabled && Logger.info(`L1p-Trace-Id=${traceId} - Response: ${response} Status: ${request.response.statusCode}`) } } } diff --git a/src/lib/sendRequest.js b/src/lib/sendRequest.js index 3392aa5d..62967c6a 100644 --- a/src/lib/sendRequest.js +++ b/src/lib/sendRequest.js @@ -26,16 +26,105 @@ 'use strict' const Logger = require('@mojaloop/central-services-logger') -const request = require('axios') const { pickBy, identity } = require('lodash') -module.exports = async (url, opts, span) => { - Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(opts.body)}]`) - let optionsWithCleanHeaders = Object.assign({}, opts, { headers: pickBy(opts.headers, identity) }) - if (span) { - optionsWithCleanHeaders = span.injectContextToHttpRequest(optionsWithCleanHeaders) +// module.exports = async (url, opts, span) => { +// Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(opts.body)}]`) +// let optionsWithCleanHeaders = Object.assign({}, opts, { headers: pickBy(opts.headers, identity) }) +// if (span) { +// optionsWithCleanHeaders = span.injectContextToHttpRequest(optionsWithCleanHeaders) +// } +// const res = await request(url, optionsWithCleanHeaders) +// Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) +// return res +// } + +const httpKeepAlive = process.env.HTTP_KEEPALIVE || 'true' +const httpKeepAliveMsecs = process.env.HTTP_KEEPALIVEMS || undefined +const httpMaxSockets = process.env.HTTP_MAXSOCKETS || undefined +const httpMaxFreeSockets = process.env.HTTP_MAXFREESOCKETS || undefined +const httpTimeoutMsecs = process.env.HTTP_TIMEOUTMS || undefined + +const httpAgentConfig = {} + +if (httpKeepAlive && httpKeepAlive === 'true') { + Object.assign(httpAgentConfig, { keepAlive: true }) +} + +if (httpKeepAliveMsecs && !isNaN(httpKeepAliveMsecs)) { + Object.assign(httpAgentConfig, { keepAliveMsecs: parseInt(httpKeepAliveMsecs) }) +} + +if (httpMaxSockets && !isNaN(httpMaxSockets)) { + Object.assign(httpAgentConfig, { maxSockets: parseInt(httpMaxSockets) }) +} + +if (httpMaxFreeSockets && !isNaN(httpMaxFreeSockets)) { + Object.assign(httpAgentConfig, { maxFreeSockets: parseInt(httpMaxFreeSockets) }) +} + +if (httpTimeoutMsecs && !isNaN(httpTimeoutMsecs)) { + Object.assign(httpAgentConfig, { timeout: parseInt(httpTimeoutMsecs) }) +} + +/** + * Class: HTTPRequestHandler + * Implementation that allows config options to be injected into underying Axios. + * See https://github.com/axios/axios#request-config for configuration options. + * TODO: + * - Productionise code below, and also create unit tests, etc. + * - Consider replacing all sendRequest using the implementation below +*/ + +const http = require('http') +const axios = require('axios') +class HTTPRequestHandler { + constructor (opts) { + if (opts) { + this._opts = opts + } else { + // Set config defaults when creating the instance + this._opts = { + httpAgent: new http.Agent({ + keepAlive: true + }) + } + } + + this._requestInstance = axios.create(opts) } - const res = await request(url, optionsWithCleanHeaders) - Logger.info((new Date().toISOString()), 'response: ', res.status) - return res + + /** + * @method sendRequest + * + * @description sends a request to url + * + * @param {string} url the endpoint for the service you require + * @param {object} opts option config for axios - https://github.com/axios/axios#request-config + * @param {object} span a span for event logging if this request is within a span + * + *@return {object} The response for the request being sent or error object with response included + */ + async sendRequest (url, opts, span) { + Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(opts.body)}]`) + let optionsWithCleanHeaders = Object.assign({}, opts, { headers: pickBy(opts.headers, identity) }) + if (span) { + optionsWithCleanHeaders = span.injectContextToHttpRequest(optionsWithCleanHeaders) + } + const res = await this._requestInstance.request(url, optionsWithCleanHeaders) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) + return res + } +} + +const httpRequestHandler = new HTTPRequestHandler({ + httpAgent: new http.Agent( + { + httpAgent: httpAgentConfig + } + ) +}) + +module.exports = async (url, opts, span) => { + return httpRequestHandler.sendRequest(url, opts, span) } diff --git a/src/noresponsepayeefsp/handler.js b/src/noresponsepayeefsp/handler.js index b1d55350..e44925ab 100644 --- a/src/noresponsepayeefsp/handler.js +++ b/src/noresponsepayeefsp/handler.js @@ -58,9 +58,9 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -71,7 +71,7 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -83,9 +83,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -95,7 +95,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -107,7 +107,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -123,7 +123,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN noresponsepayeefsp:: PUT /noresponsepayeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/oracle/handler.js b/src/oracle/handler.js index 873bd940..adba11db 100644 --- a/src/oracle/handler.js +++ b/src/oracle/handler.js @@ -38,7 +38,7 @@ exports.createParticipantsByTypeAndId = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`createParticipantByTypeId::ID=${request.params.ID} payload=${request.payload}`) + Logger.isDebugEnabled && Logger.debug(`createParticipantByTypeId::ID=${request.params.ID} payload=${request.payload}`) addNewRequest(request) const record = { partyList: [ @@ -74,7 +74,7 @@ exports.getParticipantsByTypeId = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`getParticipantsByTypeId::ID=${request.params.ID}`) + Logger.isDebugEnabled && Logger.debug(`getParticipantsByTypeId::ID=${request.params.ID}`) addNewRequest(request) let idMap = new Map() let response @@ -107,7 +107,7 @@ exports.updateParticipantsByTypeId = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`updateParticipantByTypeId::ID=${request.params.ID} payload=${request.payload}`) + Logger.isDebugEnabled && Logger.debug(`updateParticipantByTypeId::ID=${request.params.ID} payload=${request.payload}`) addNewRequest(request) let idMap if (participantCache.get(request.params.Type)) { @@ -141,7 +141,7 @@ exports.delParticipantsByTypeId = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`delParticipantsByTypeId::ID=${request.params.ID}`) + Logger.isDebugEnabled && Logger.debug(`delParticipantsByTypeId::ID=${request.params.ID}`) addNewRequest(request) let idMap if (participantCache.get(request.params.Type)) { @@ -245,7 +245,7 @@ exports.getPartiesByTypeIdAndSubId = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`getPartiesByTypeId::ID=${request.params.ID}`) + Logger.isDebugEnabled && Logger.debug(`getPartiesByTypeId::ID=${request.params.ID}`) addNewRequest(request) let idMap = new Map() let response diff --git a/src/payee/handler.js b/src/payee/handler.js index 75ec89b8..32bb1a8b 100644 --- a/src/payee/handler.js +++ b/src/payee/handler.js @@ -71,9 +71,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN PAYEEFSP:: PUT /payeefsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /payeefsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -84,7 +84,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -96,12 +96,12 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) - Logger.info('IN PAYEEFSP:: POST /payeefsp/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN PAYEEFSP:: POST /payeefsp/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -114,10 +114,10 @@ exports.getPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - START`) const metadata = `${request.method} ${request.path} ${request.params.id} ` - Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) // Saving Incoming request const incomingRequest = { headers: request.headers @@ -161,19 +161,19 @@ exports.getPartiesByTypeAndId = function (request, h) { data: JSON.stringify(correlationCache.get(request.params.id)) } - // Logger.info((new Date().toISOString()), 'Executing PUT', url) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'Executing PUT', url) const res = await sendRequest(url, opts, request.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'getPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getPartiesByTypeAndId - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'getPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) } })() @@ -189,12 +189,12 @@ exports.postQuotes = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) const metadata = `${request.method} ${request.path}` const quoteRequest = request.payload - Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quoteRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN PAYEEFSP::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quoteRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -206,8 +206,8 @@ exports.postQuotes = function (request, h) { // prepare response // const fulfillImage = new cc.PreimageSha256() // fulfillImage.setPreimage(new Buffer('hello world')) - // Logger.info(fulfillImage.serializeUri()) - // Logger.info(fulfillImage.getConditionUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.serializeUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.getConditionUri()) // const condition = fulfillImage.getConditionUri() // // const binaryPrepare = IlpPacket.serializeIlpPrepare({ @@ -276,19 +276,19 @@ exports.postQuotes = function (request, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info((new Date().toISOString()), 'Executing PUT', url) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'Executing PUT', url) const res = await sendRequest(url, opts, request.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, request.path, requesterName); @@ -308,11 +308,11 @@ exports.postTransfers = async function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - - Logger.debug(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::postTransfers - START`) + Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${request.method} ${request.path} ${request.payload.transferId}` - Logger.info(`IN PAYEEFSP:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -366,14 +366,18 @@ exports.postTransfers = async function (request, h) { data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) - const res = await sendRequest(url, opts, request.span) - // Logger.info(`response: ${res.status}`) - if ((res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) || (res.status !== Enums.Http.ReturnCodes.OK.CODE)) { - // TODO: how does one identify the failed response? - throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) - } - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + setImmediate(async () => { + const res = await sendRequest(url, opts, request.span) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) + if ((res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) && (res.status !== Enums.Http.ReturnCodes.OK.CODE)) { + // TODO: how does one identify the failed response? + throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) + } + }) + + Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::postTransfers - END`) + Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -382,8 +386,8 @@ exports.postTransfers = async function (request, h) { destination: request.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: 'payee', @@ -400,7 +404,7 @@ exports.postTransfers = async function (request, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -419,9 +423,9 @@ exports.putTransfersById = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - START`) - Logger.info(`IN PAYEEFSP:: PUT /payeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /payeefsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) @@ -432,7 +436,7 @@ exports.putTransfersById = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -444,9 +448,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - START`) - Logger.info(`IN PAYEEFSP:: PUT /payeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /payeefsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -456,7 +460,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -468,19 +472,19 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - START`) const responseData = correlationCache.get(request.params.id) - Logger.info(`IN PAYEEFSP:: Final response for GET /payeefsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(responseData)}`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: Final response for GET /payeefsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(responseData)}`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'getcorrelationId' }) return h.response(responseData).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } exports.getQuotesById = function (request, h) { const responseData = quoteCache.get(request.params.id) - Logger.info(`IN PAYEEFSP:: PUT callback for GET /payeefsp/quotes/${request.params.id}, CACHE: [${JSON.stringify(responseData)}`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT callback for GET /payeefsp/quotes/${request.params.id}, CACHE: [${JSON.stringify(responseData)}`) quoteCache.del(request.params.id) if (responseData) { @@ -527,7 +531,7 @@ exports.getQuotesById = function (request, h) { }), data: JSON.stringify(responseData) } - // Logger.info((new Date().toISOString()), 'Executing PUT', url) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'Executing PUT', url) const res = await sendRequest(url, opts, request.span) if (res.status !== Enums.Http.ReturnCodes.OK.CODE) { throw new Error(`Failed to send. Result: ${res}`) @@ -535,13 +539,13 @@ exports.getQuotesById = function (request, h) { histTimerEnd({ success: true, fsp: 'payee', operation: 'getQuotes', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) histTimerEnd({ success: false, fsp: 'payee', operation: 'getQuotes', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) } }) } else { setImmediate(async () => { - Logger.error(`getQuotesById: Quote ${request.params.id} not found.`) + Logger.isErrorEnabled && Logger.error(`getQuotesById: Quote ${request.params.id} not found.`) await sendErrorCallback( ErrorHandler.CreateFSPIOPError(ErrorHandler.Enums.FSPIOPErrorCodes.QUOTE_ID_NOT_FOUND, `Quote id ${request.params.id} not found`, null, request.headers['fspiop-source']), request.params.id, @@ -602,7 +606,7 @@ const sendErrorCallback = async (fspiopError, quoteId, headers, span) => { histTimerEnd({ success: true, fsp: 'payee', operation: 'sendErrorCallback', source: headers['fspiop-source'], destination: 'switch' }) } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) histTimerEnd({ success: false, fsp: 'payee', operation: 'sendErrorCallback', source: headers['fspiop-source'], destination: 'switch' }) } } @@ -615,7 +619,7 @@ exports.getRequestById = function (request, h) { ).startTimer() const responseData = requestCache.get(request.params.id) - Logger.info(`IN PAYEEFSP:: PUT /payeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /payeefsp/requests/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) requestCache.del(request.params.id) histTimerEnd({ success: true, fsp: 'payee', operation: 'getRequestById' }) @@ -631,7 +635,7 @@ exports.getCallbackById = function (request, h) { ).startTimer() const responseData = callbackCache.get(request.params.id) - Logger.info(`IN PAYEEFSP:: PUT /payeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYEEFSP:: PUT /payeefsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) callbackCache.del(request.params.id) histTimerEnd({ success: true, fsp: 'payee', operation: 'getCallbackById' }) diff --git a/src/payer/handler.js b/src/payer/handler.js index b54473e9..4fbae30b 100644 --- a/src/payer/handler.js +++ b/src/payer/handler.js @@ -58,9 +58,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -71,7 +71,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -84,9 +84,9 @@ exports.putPartiesByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/parties/${request.params.type}/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/parties/${request.params.type}/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -97,7 +97,7 @@ exports.putPartiesByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putPartiesByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -124,9 +124,9 @@ exports.putQuotesById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -136,7 +136,7 @@ exports.putQuotesById = function (request, h) { callbackCache.set(request.params.id, incomingRequest) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putQuotesById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -162,10 +162,11 @@ exports.putTransfersById = function (request, h) { 'Histogram for Simulator http operations', ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() + Logger.isPerfEnabled && Logger.perf(`[cid=${request.params.id}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::putTransfersById - START`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -176,8 +177,9 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) + Logger.isPerfEnabled && Logger.perf(`[cid=${request.params.id}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::putTransfersById - END`) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -188,9 +190,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -200,7 +202,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -212,12 +214,12 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) const responseData = correlationCache.get(request.params.id) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/correlationid/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'getcorrelationId' }) return h.response(responseData).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -230,7 +232,7 @@ exports.getRequestById = function (request, h) { ).startTimer() const responseData = requestCache.get(request.params.id) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/requests/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/requests/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) requestCache.del(request.params.id) histTimerEnd({ success: true, fsp: 'payer', operation: 'getRequestById' }) @@ -246,7 +248,7 @@ exports.getCallbackById = function (request, h) { ).startTimer() const responseData = callbackCache.get(request.params.id) - Logger.info(`IN PAYERFSP:: PUT /payerfsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) + Logger.isInfoEnabled && Logger.info(`IN PAYERFSP:: PUT /payerfsp/callbacks/${request.params.id}, CACHE: [${JSON.stringify(responseData)}]`) callbackCache.del(request.params.id) histTimerEnd({ success: true, fsp: 'payer', operation: 'getCallbackById' }) diff --git a/src/routes.js b/src/routes.js index 0b247bf8..44844551 100644 --- a/src/routes.js +++ b/src/routes.js @@ -30,7 +30,7 @@ exports.plugin = { register: function (server) { Glob.sync('*/routes.js', { cwd: __dirname, ignore: 'routes.js' }) .forEach(x => { - Logger.info(`Loading module: [${x}]`) + Logger.isInfoEnabled && Logger.info(`Loading module: [${x}]`) server.route(require('./' + x)) }) } diff --git a/src/shared/setup.js b/src/shared/setup.js index 8d255524..4cf2ce12 100644 --- a/src/shared/setup.js +++ b/src/shared/setup.js @@ -48,19 +48,19 @@ const createServer = (port, modules) => { RequestLogger.logResponse(request) return h.continue }) - Logger.info('Registering server modules...') + Logger.isInfoEnabled && Logger.info('Registering server modules...') await server.register(modules) - Logger.info('Registering server plugins') + Logger.isInfoEnabled && Logger.info('Registering server plugins') await require('./plugins').registerPlugins(server) - Logger.info('Initializing metrics...') + Logger.isInfoEnabled && Logger.info('Initializing metrics...') Metrics.setup() - Logger.info('Server starting up...') + Logger.isInfoEnabled && Logger.info('Server starting up...') await server.start() - Logger.info(`Server running at: ${server.info.uri}`) + Logger.isInfoEnabled && Logger.info(`Server running at: ${server.info.uri}`) return server })() } diff --git a/src/testfsp1/handler.js b/src/testfsp1/handler.js index dbbed187..3b8f7cd8 100644 --- a/src/testfsp1/handler.js +++ b/src/testfsp1/handler.js @@ -70,9 +70,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN TESTFSP1:: PUT /testfsp1/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN TESTFSP1:: PUT /testfsp1/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -83,7 +83,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -96,12 +96,12 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) - Logger.info('IN testfsp1:: POST /testfsp1/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN testfsp1:: POST /testfsp1/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -152,9 +152,9 @@ exports.putPartiesByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) - Logger.info(`IN testfsp1:: PUT /testfsp1/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -165,7 +165,7 @@ exports.putPartiesByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putPartiesByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -193,12 +193,12 @@ exports.postQuotes = function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) const metadata = `${req.method} ${req.path}` const quotesRequest = req.payload - Logger.info((new Date().toISOString()), ['IN testfsp1::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quotesRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN testfsp1::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quotesRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -210,8 +210,8 @@ exports.postQuotes = function (req, h) { // prepare response // const fulfillImage = new cc.PreimageSha256() // fulfillImage.setPreimage(new Buffer('hello world')) - // Logger.info(fulfillImage.serializeUri()) - // Logger.info(fulfillImage.getConditionUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.serializeUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.getConditionUri()) // const condition = fulfillImage.getConditionUri() // // const binaryPrepare = IlpPacket.serializeIlpPrepare({ @@ -278,19 +278,19 @@ exports.postQuotes = function (req, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, req.path, requesterName); @@ -311,9 +311,9 @@ exports.putQuotesById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) - Logger.info(`IN testfsp1:: PUT /testfsp1/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -324,7 +324,7 @@ exports.putQuotesById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putQuotesById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -351,10 +351,10 @@ exports.postTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.transferId}` - Logger.info(`IN testfsp1:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -400,14 +400,14 @@ exports.postTransfers = async function (req, h) { }, data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -416,8 +416,8 @@ exports.postTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: 'payee', @@ -434,7 +434,7 @@ exports.postTransfers = async function (req, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -454,9 +454,9 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN testfsp1:: PUT /testfsp1/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -467,7 +467,7 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -479,9 +479,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN testfsp1:: PUT /testfsp1/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -491,7 +491,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -503,11 +503,11 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) - Logger.info(`IN testfsp1:: PUT /testfsp1/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'getcorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -519,7 +519,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp1:: PUT /testfsp1/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -535,7 +535,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp1:: PUT /testfsp1/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp1:: PUT /testfsp1/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/testfsp2/handler.js b/src/testfsp2/handler.js index 9817d21f..60a66f65 100644 --- a/src/testfsp2/handler.js +++ b/src/testfsp2/handler.js @@ -70,9 +70,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -83,7 +83,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -96,12 +96,12 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) - Logger.info('IN testfsp2:: POST /testfsp2/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN testfsp2:: POST /testfsp2/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -152,9 +152,9 @@ exports.putPartiesByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -165,7 +165,7 @@ exports.putPartiesByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putPartiesByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -193,12 +193,12 @@ exports.postQuotes = function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) const metadata = `${req.method} ${req.path}` const quotesRequest = req.payload - Logger.info((new Date().toISOString()), ['IN testfsp2::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quotesRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN testfsp2::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quotesRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -210,8 +210,8 @@ exports.postQuotes = function (req, h) { // prepare response // const fulfillImage = new cc.PreimageSha256() // fulfillImage.setPreimage(new Buffer('hello world')) - // Logger.info(fulfillImage.serializeUri()) - // Logger.info(fulfillImage.getConditionUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.serializeUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.getConditionUri()) // const condition = fulfillImage.getConditionUri() // // const binaryPrepare = IlpPacket.serializeIlpPrepare({ @@ -278,19 +278,19 @@ exports.postQuotes = function (req, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, req.path, requesterName); @@ -311,9 +311,9 @@ exports.putQuotesById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -324,7 +324,7 @@ exports.putQuotesById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putQuotesById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -351,10 +351,10 @@ exports.postTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.transferId}` - Logger.info(`IN testfsp2:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -407,14 +407,14 @@ exports.postTransfers = async function (req, h) { }), data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -423,8 +423,8 @@ exports.postTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: 'payee', @@ -441,7 +441,7 @@ exports.postTransfers = async function (req, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -461,9 +461,9 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -474,7 +474,7 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -486,9 +486,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -498,7 +498,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -510,11 +510,11 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) - Logger.info(`IN testfsp2:: PUT /testfsp2/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'getcorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -526,7 +526,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp2:: PUT /testfsp2/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -542,7 +542,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp2:: PUT /testfsp2/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp2:: PUT /testfsp2/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/testfsp3/handler.js b/src/testfsp3/handler.js index 0947fc3e..c6920c0f 100644 --- a/src/testfsp3/handler.js +++ b/src/testfsp3/handler.js @@ -70,9 +70,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -83,7 +83,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -96,12 +96,12 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) - Logger.info('IN testfsp3:: POST /testfsp3/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN testfsp3:: POST /testfsp3/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -152,9 +152,9 @@ exports.putPartiesByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -165,7 +165,7 @@ exports.putPartiesByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putPartiesByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -193,12 +193,12 @@ exports.postQuotes = function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) const metadata = `${req.method} ${req.path}` const quotesRequest = req.payload - Logger.info((new Date().toISOString()), ['IN testfsp3::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quotesRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN testfsp3::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quotesRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -210,8 +210,8 @@ exports.postQuotes = function (req, h) { // prepare response // const fulfillImage = new cc.PreimageSha256() // fulfillImage.setPreimage(new Buffer('hello world')) - // Logger.info(fulfillImage.serializeUri()) - // Logger.info(fulfillImage.getConditionUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.serializeUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.getConditionUri()) // const condition = fulfillImage.getConditionUri() // // const binaryPrepare = IlpPacket.serializeIlpPrepare({ @@ -278,19 +278,19 @@ exports.postQuotes = function (req, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, req.path, requesterName); @@ -311,9 +311,9 @@ exports.putQuotesById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -324,7 +324,7 @@ exports.putQuotesById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putQuotesById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -351,10 +351,10 @@ exports.postTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.transferId}` - Logger.info(`IN testfsp3:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -407,14 +407,14 @@ exports.postTransfers = async function (req, h) { }), data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -423,8 +423,8 @@ exports.postTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: 'payee', @@ -441,7 +441,7 @@ exports.postTransfers = async function (req, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -461,9 +461,9 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -474,7 +474,7 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -486,9 +486,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -498,7 +498,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -510,11 +510,11 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) - Logger.info(`IN testfsp3:: PUT /testfsp3/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'getcorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -526,7 +526,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp3:: PUT /testfsp3/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -542,7 +542,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp3:: PUT /testfsp3/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp3:: PUT /testfsp3/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/testfsp4/handler.js b/src/testfsp4/handler.js index bd686f14..13f2bf45 100644 --- a/src/testfsp4/handler.js +++ b/src/testfsp4/handler.js @@ -70,9 +70,9 @@ exports.putParticipantsByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/participants/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -83,7 +83,7 @@ exports.putParticipantsByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putParticipantsByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putParticipantsByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -96,12 +96,12 @@ exports.postPartiesByTypeAndId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - START`) - Logger.info('IN testfsp4:: POST /testfsp4/parties/' + request.params.id, request.payload) + Logger.isInfoEnabled && Logger.info('IN testfsp4:: POST /testfsp4/parties/' + request.params.id, request.payload) correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payee::postPartiesByTypeAndId - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postPartiesByTypeAndId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -152,9 +152,9 @@ exports.putPartiesByTypeId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/parties/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -165,7 +165,7 @@ exports.putPartiesByTypeId = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putPartiesByTypeId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putPartiesByTypeId', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -193,12 +193,12 @@ exports.postQuotes = function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - START`) const metadata = `${req.method} ${req.path}` const quotesRequest = req.payload - Logger.info((new Date().toISOString()), ['IN testfsp4::'], `received: ${metadata}. `) - Logger.info(`incoming request: ${quotesRequest.quoteId}`) + Logger.isInfoEnabled && Logger.info((new Date().toISOString()), ['IN testfsp4::'], `received: ${metadata}. `) + Logger.isInfoEnabled && Logger.info(`incoming request: ${quotesRequest.quoteId}`) // Saving Incoming request const incomingRequest = { @@ -210,8 +210,8 @@ exports.postQuotes = function (req, h) { // prepare response // const fulfillImage = new cc.PreimageSha256() // fulfillImage.setPreimage(new Buffer('hello world')) - // Logger.info(fulfillImage.serializeUri()) - // Logger.info(fulfillImage.getConditionUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.serializeUri()) + // Logger.isInfoEnabled && Logger.info(fulfillImage.getConditionUri()) // const condition = fulfillImage.getConditionUri() // // const binaryPrepare = IlpPacket.serializeIlpPrepare({ @@ -278,19 +278,19 @@ exports.postQuotes = function (req, h) { }), data: JSON.stringify(quotesResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(quotesResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info((new Date().toISOString()), 'response: ', res.status) + // Logger.isInfoEnabled && Logger.info((new Date().toISOString()), 'response: ', res.status) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${res}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - END`) histTimerEnd({ success: true, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postQuotes - ERROR`) histTimerEnd({ success: false, fsp: 'payee', operation: 'postQuotes', source: req.headers['fspiop-source'], destination: req.headers['fspiop-destination'] }) // TODO: what if this fails? We need to log. What happens by default? // const url = await rq.createErrorUrl(db, req.path, requesterName); @@ -311,9 +311,9 @@ exports.putQuotesById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/quotes/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -324,7 +324,7 @@ exports.putQuotesById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putQuotesById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putQuotesById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -351,10 +351,10 @@ exports.postTransfers = async function (req, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) + Logger.isDebugEnabled && Logger.debug(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - START`) const metadata = `${req.method} ${req.path} ${req.payload.transferId}` - Logger.info(`IN testfsp4:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: received: ${metadata}.`) if (!transfersFulfilResponseDisabled) { // Saving Incoming request @@ -407,14 +407,14 @@ exports.postTransfers = async function (req, h) { }), data: JSON.stringify(transfersResponse) } - // Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) + // Logger.isInfoEnabled && Logger.info(`Executing PUT: [${url}], HEADERS: [${JSON.stringify(opts.headers)}], BODY: [${JSON.stringify(transfersResponse)}]`) const res = await request(url, opts, req.span) - // Logger.info(`response: ${res.status}`) + // Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.ACCEPTED.CODE) { // TODO: how does one identify the failed response? throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -423,8 +423,8 @@ exports.postTransfers = async function (req, h) { destination: req.headers['fspiop-destination'] }) } catch (err) { - Logger.error(err) - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) + Logger.isErrorEnabled && Logger.error(err) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - ERROR`) histTimerEnd({ success: false, fsp: 'payee', @@ -441,7 +441,7 @@ exports.postTransfers = async function (req, h) { // rq.sendError(url, asyncResponses.serverError, rq.defaultHeaders(requesterName, 'participants'), {logger}); } } else { - // Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${req.payload.transferId}, fsp=${req.headers['fspiop-source']}, source=${req.headers['fspiop-source']}, dest=${req.headers['fspiop-destination']}] ~ Simulator::api::payee::postTransfers - END`) histTimerEnd({ success: true, fsp: 'payee', @@ -461,9 +461,9 @@ exports.putTransfersById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/transfers/${request.params.id}, PAYLOAD: [${JSON.stringify(request.payload)}]`) // Saving Incoming request const incomingRequest = { @@ -474,7 +474,7 @@ exports.putTransfersById = function (request, h) { correlationCache.set(request.params.id, request.payload) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersById - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersById', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -486,9 +486,9 @@ exports.putTransfersByIdError = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/transfers/${request.params.id}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.id, request.payload) // Saving Incoming request @@ -498,7 +498,7 @@ exports.putTransfersByIdError = function (request, h) { } callbackCache.set(request.params.id, incomingRequest) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::putTransfersByIdError - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'putTransfersByIdError', source: request.headers['fspiop-source'], destination: request.headers['fspiop-destination'] }) return h.response().code(Enums.Http.ReturnCodes.OK.CODE) } @@ -510,11 +510,11 @@ exports.getcorrelationId = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - START`) - Logger.info(`IN testfsp4:: PUT /testfsp4/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/correlationid/${request.params.id}, CACHE: [${JSON.stringify(correlationCache.get(request.params.id))}]`) - // Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) + // Logger.isPerfEnabled && Logger.perf(`[cid=${request.payload.transferId}, fsp=${request.headers['fspiop-source']}, source=${request.headers['fspiop-source']}, dest=${request.headers['fspiop-destination']}] ~ Simulator::api::payer::getcorrelationId - END`) histTimerEnd({ success: true, fsp: 'payer', operation: 'getcorrelationId' }) return h.response(correlationCache.get(request.params.id)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } @@ -526,7 +526,7 @@ exports.getRequestById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp4:: PUT /testfsp4/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/requests/${request.params.id}, CACHE: [${JSON.stringify(requestCache.get(request.params.id))}]`) const responseData = requestCache.get(request.params.id) requestCache.del(request.params.id) @@ -542,7 +542,7 @@ exports.getCallbackById = function (request, h) { ['success', 'fsp', 'operation', 'source', 'destination'] ).startTimer() - Logger.info(`IN testfsp4:: PUT /testfsp4/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) + Logger.isInfoEnabled && Logger.info(`IN testfsp4:: PUT /testfsp4/callbacks/${request.params.id}, CACHE: [${JSON.stringify(callbackCache.get(request.params.id))}]`) const responseData = callbackCache.get(request.params.id) callbackCache.del(request.params.id) diff --git a/src/transactionRequests/handler.js b/src/transactionRequests/handler.js index 68c4dc3c..b848e939 100644 --- a/src/transactionRequests/handler.js +++ b/src/transactionRequests/handler.js @@ -39,7 +39,7 @@ const transactionRequestsEndpoint = process.env.TRANSACTION_REQUESTS_ENDPOINT || exports.getTransactionRequestById = function (request, h) { (async () => { - Logger.info(`IN transactionRequests:: Final response for GET /transactionRequests/correlationid/${request.params.ID}, CACHE: [${JSON.stringify(correlationCache.get(request.params.ID))}`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests:: Final response for GET /transactionRequests/correlationid/${request.params.ID}, CACHE: [${JSON.stringify(correlationCache.get(request.params.ID))}`) const url = transactionRequestsEndpoint + '/transactionRequests/' + request.params.ID try { let transactionRequestResponse @@ -76,12 +76,12 @@ exports.getTransactionRequestById = function (request, h) { data: JSON.stringify(transactionRequestResponse) } const res = await sendRequest(url, opts, request.span) - Logger.info(`response: ${res.status}`) + Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.OK.CODE) { throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) } })() @@ -91,7 +91,7 @@ exports.getTransactionRequestById = function (request, h) { exports.postTransactionRequest = function (request, h) { (async () => { const metadata = `${request.method} ${request.path} ${request.payload.transactionRequestId}` - Logger.info(`IN transactionRequests POST:: received: ${metadata}.`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests POST:: received: ${metadata}.`) const url = transactionRequestsEndpoint + '/transactionRequests/' + request.payload.transactionRequestId try { if (requestsCache.get(request.payload.transactionRequestId)) { @@ -128,12 +128,12 @@ exports.postTransactionRequest = function (request, h) { data: JSON.stringify(transactionRequestsResponse) } const res = await sendRequest(url, opts, request.span) - Logger.info(`response: ${res.status}`) + Logger.isInfoEnabled && Logger.info(`response: ${res.status}`) if (res.status !== Enums.Http.ReturnCodes.OK.CODE) { throw new Error(`Failed to send. Result: ${JSON.stringify(res)}`) } } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) } })() @@ -141,7 +141,7 @@ exports.postTransactionRequest = function (request, h) { } exports.putTransactionRequest = function (request, h) { - Logger.info(`IN transactionRequests :: PUT /transactionRequests/${request.params.ID}, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests :: PUT /transactionRequests/${request.params.ID}, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.ID, { headers: request.headers, data: request.payload }) callbackCache.set(request.params.ID, { headers: request.headers, data: request.payload }) @@ -149,7 +149,7 @@ exports.putTransactionRequest = function (request, h) { } exports.putTransactionRequestError = function (request, h) { - Logger.info(`IN transactionRequests :: PUT /transactionRequests/${request.params.ID}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests :: PUT /transactionRequests/${request.params.ID}/error, PAYLOAD: [${JSON.stringify(request.payload)}]`) correlationCache.set(request.params.ID, { headers: request.headers, data: request.payload }) callbackCache.set(request.params.ID, { headers: request.headers, data: request.payload }) @@ -157,13 +157,13 @@ exports.putTransactionRequestError = function (request, h) { } exports.getCorrelationId = function (request, h) { - Logger.info(`IN transactionRequests:: GET /transactionRequests/correlationid/${request.params.ID}, CACHE: [${JSON.stringify(correlationCache.get(request.params.ID))}`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests:: GET /transactionRequests/correlationid/${request.params.ID}, CACHE: [${JSON.stringify(correlationCache.get(request.params.ID))}`) return h.response(correlationCache.get(request.params.ID)).code(Enums.Http.ReturnCodes.ACCEPTED.CODE) } exports.getRequestById = function (request, h) { - Logger.info(`IN transactionRequests :: GET /transactionRequests/requests/${request.params.ID}, CACHE: [${JSON.stringify(requestsCache.get(request.params.ID))}]`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests :: GET /transactionRequests/requests/${request.params.ID}, CACHE: [${JSON.stringify(requestsCache.get(request.params.ID))}]`) const responseData = requestsCache.get(request.params.ID) requestsCache.del(request.params.ID) @@ -171,7 +171,7 @@ exports.getRequestById = function (request, h) { } exports.getCallbackById = function (request, h) { - Logger.info(`IN transactionRequests :: GET /transactionRequests/callbacks/${request.params.ID}, CACHE: [${JSON.stringify(callbackCache.get(request.params.ID))}]`) + Logger.isInfoEnabled && Logger.info(`IN transactionRequests :: GET /transactionRequests/callbacks/${request.params.ID}, CACHE: [${JSON.stringify(callbackCache.get(request.params.ID))}]`) const responseData = callbackCache.get(request.params.ID) callbackCache.del(request.params.ID) @@ -204,6 +204,6 @@ const sendErrorCallback = async (fspiopError, transactionRequestId, headers, spa throw new Error(`Failed to send. Result: ${res}`) } } catch (err) { - Logger.error(err) + Logger.isErrorEnabled && Logger.error(err) } }