Eikon: -eikonpid=3216 -EikonProcessId=4600 -HwndComInterop=0x1 "-manifest=C:\Users\R\AppData\Local\Thomson Reuters\Eikon User\Cache\LibraryCache\9.0.47109_SL1-7JCQ6GQ__EikonContainer.dll.manifest" "-Context=C:\Users\R\AppData\Local\Thomson Reuters\Eikon User\Cache\LibraryCache\Apps\THOMSONREUTERS.EIKON.DESKTOPSXSSVC\1.1.0.69" /prefetch:1

start node

Arg: C:\Program Files (x86)\Thomson Reuters\Eikon\Y\Bin\Eikonbox.exe C:\Users\R\AppData\Local\Thomson Reuters\Eikon User\Cache\LibraryCache\Apps\THOMSONREUTERS.EIKON.DESKTOPSXSSVC\1.1.0.69\index.js -TraceLevel=4 

[2019-04-29 15:37:39.604|1|api-svc|1|INFO] PA: true
[2019-04-29 15:37:39.644|1|api-svc|2|DEBUG] Waiting for FT
[2019-04-29 15:37:40.625|1|api-svc|2|DEBUG] Gen key successfully
[2019-04-29 15:37:40.633|1|api-svc|2|DEBUG] SxSServer init OK
[2019-04-29 15:37:42.652|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=1 data={"settingName":"KOBRA.APPLICATION.DESKTOPSXS.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.665|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=1 data~={"callId":1,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:42.670|1|api-svc|1|INFO] FT is ready
[2019-04-29 15:37:42.675|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=2 data={"settingName":"{Temporary}RDE_PRODUCT_STRINGID","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.681|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=2 data~={"callId":2,"value":"NET45,EIKON9.0.47109,SR0,ADF6.20184.11.20","action":"ReturnCall"}
[2019-04-29 15:37:42.684|1|api-svc|3|DEBUG] set User Agent
[2019-04-29 15:37:42.691|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=3 data={"settingName":"{Temporary}KOBRA.APPLICATION.DESKTOPSXS.PO","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.696|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=4 data={"settingName":"KOBRA.APPLICATION.DESKTOPSXS.HTTP.PORT","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.704|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=3 data~={"callId":3,"value":"SIDEBYSIDE,APIPROXY","action":"ReturnCall"}
[2019-04-29 15:37:42.708|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=4 data~={"callId":4,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:42.712|1|api-svc|1|INFO] PO: SIDEBYSIDE,APIPROXY
[2019-04-29 15:37:42.717|1|api-svc|3|DEBUG] create SIDEBYSIDE
[2019-04-29 15:37:42.721|1|api-svc|3|DEBUG] create APIPROXY
[2019-04-29 15:37:42.736|1|data-api|1|INFO] [ConfigurationManager]Getting configuration ...
[2019-04-29 15:37:42.747|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=5 data={"settingName":"KOBRA.APPLICATION.DESKTOPSXS.ENCRYPTION.DISABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.754|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=6 data={"settingName":"url.apps","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.760|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=7 data={"settingName":"APIPROXY.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.767|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=8 data={"settingName":"APIPROXY.THROTTLING.REQUEST.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.776|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=9 data={"settingName":"APIPROXY.THROTTLING.REQUEST.MAX","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.782|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=10 data={"settingName":"APIPROXY.THROTTLING.REQUEST.PERIOD","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.788|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=11 data={"settingName":"APIPROXY.THROTTLING.DAILY.REQUEST.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.794|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=12 data={"settingName":"APIPROXY.THROTTLING.DAILY.REQUEST.MAX","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.801|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=13 data={"settingName":"APIPROXY.THROTTLING.VOLUME.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.807|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=14 data={"settingName":"APIPROXY.THROTTLING.VOLUME.MAX","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.813|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=15 data={"settingName":"APIPROXY.THROTTLING.VOLUME.PERIOD","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.819|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=16 data={"settingName":"APIPROXY.THROTTLING.DAILY.VOLUME.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.825|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=17 data={"settingName":"APIPROXY.THROTTLING.DAILY.VOLUME.MAX","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.834|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=18 data={"settingName":"APIPROXY.MINIMALVERSION","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.847|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=19 data={"settingName":"APIPROXY.USAGETRACKING.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.855|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=20 data={"settingName":"APIPROXY.STREAMING.ENABLED","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.862|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=21 data={"settingName":"APIPROXY.STREAMING.CONNECTION.MAX","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:42.869|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=5 data~={"callId":5,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:42.885|1|sxs-api|3|DEBUG] [proxy] Add server key kid=87lQPCDIqdY2jhhRanxsDJsnT7UGbML2XKBnhKb31sM
[2019-04-29 15:37:42.896|1|sxs-api|3|DEBUG] [ws] Create endpoint=/sxs/v1/notifications
[2019-04-29 15:37:42.905|1|sxs-api|3|DEBUG] [ws] Create endpoint=/sxs/s/v1/notifications
[2019-04-29 15:37:42.922|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=6 data~={"callId":6,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:42.929|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=7 data~={"callId":7,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:42.937|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=8 data~={"callId":8,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:42.946|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=9 data~={"callId":9,"value":"5","action":"ReturnCall"}
[2019-04-29 15:37:42.951|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=10 data~={"callId":10,"value":"1","action":"ReturnCall"}
[2019-04-29 15:37:42.960|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=11 data~={"callId":11,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:42.968|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=12 data~={"callId":12,"value":"10000","action":"ReturnCall"}
[2019-04-29 15:37:42.975|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=13 data~={"callId":13,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:42.982|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=14 data~={"callId":14,"value":"50000","action":"ReturnCall"}
[2019-04-29 15:37:42.990|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=15 data~={"callId":15,"value":"60","action":"ReturnCall"}
[2019-04-29 15:37:42.998|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=16 data~={"callId":16,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:43.006|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=17 data~={"callId":17,"value":"5000000","action":"ReturnCall"}
[2019-04-29 15:37:43.014|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=18 data~={"callId":18,"value":"0.0.0","action":"ReturnCall"}
[2019-04-29 15:37:43.021|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=19 data~={"callId":19,"value":"true","action":"ReturnCall"}
[2019-04-29 15:37:43.026|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=20 data~={"callId":20,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:43.032|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=21 data~={"callId":21,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:43.076|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=22 data={"settingName":"common.datacenter.active","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:43.090|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=22 data~={"callId":22,"value":"","action":"ReturnCall"}
[2019-04-29 15:37:43.099|1|data-api|1|INFO] [ConfigurationManager]Configuration successfully retrieved.
[2019-04-29 15:37:43.112|1|data-api|3|DEBUG] [ConfigurationManager]{"currentVersion":"1.1.0-nightly20190116","dataCenter":"","endPointURL":"http://emea1.apps.cp.thomsonreuters.com/Apps/UDF/MSF","minimalVersion":"0.0.0","minimalVersionRequirementMet":true,"proxyEnabled":true,"streaming":{"enabled":true,"maxConnection":1},"throttling":{"dailyRequestCount":{"enabled":true,"max":10000},"dailyVolume":{"enabled":true,"max":5000000},"requestCount":{"enabled":true,"max":5,"period":1},"volume":{"enabled":true,"max":50000,"period":60}},"usageTrackingEnabled":true}
[2019-04-29 15:37:43.142|1|data-api|3|DEBUG] [HomeController][HomeController::create] Creating index controller.
[2019-04-29 15:37:43.155|1|data-api|3|DEBUG] [ApiController][ApiController::create] Creating API controller.
[2019-04-29 15:37:43.170|1|data-api|3|DEBUG] [TracingMiddleware]Creating new request tracing middleware.
[2019-04-29 15:37:43.189|1|data-api|3|DEBUG] [SettingsAggregatorService]Getting value for APIPROXY.THROTTLING.STORE from platform setting service
[2019-04-29 15:37:43.211|1|data-api|1|INFO] [Throttling][RBT] Request-count based throttling has been enabled by configuration.
[2019-04-29 15:37:43.216|1|data-api|3|DEBUG] [Throttling][RBT] Applying request-count limits - 5 request(s) per 1 second(s)
[2019-04-29 15:37:43.226|1|data-api|1|INFO] [Throttling][VBT] Volume-based throttling has been enabled by configuration.
[2019-04-29 15:37:43.233|1|data-api|3|DEBUG] [Throttling][VBT] Applying volume limits - 50000 KB per 60 second(s)
[2019-04-29 15:37:43.242|1|api-svc|1|INFO] Start server...
[2019-04-29 15:37:43.262|1|api-svc|2|DEBUG] onStarted: 9000
[2019-04-29 15:37:43.274|1|api-svc|2|DEBUG] [bus] channel=/desktopsxs name=sxs:GetSetting callId=23 data={"settingName":"APIPROXY.THROTTLING.STORE","provider":"Configuration","isVersioning":false,"action":"GetSetting"}
[2019-04-29 15:37:43.284|1|data-api|1|INFO] Write port file
[2019-04-29 15:37:43.292|1|api-svc|1|INFO] Listening to port=9000
[2019-04-29 15:37:43.297|1|api-svc|2|DEBUG] [bus] onCallback name=sxs:GetSetting callId=23 data~={"callId":23,"value":"{\"dailyRequest\":\"[]\",\"dailyVolume\":\"[]\"}","action":"ReturnCall"}
[2019-04-29 15:37:43.304|1|data-api|3|DEBUG] [SettingsAggregatorService]Got value "{"dailyRequest":"[]","dailyVolume":"[]"}", trying to parse ...
[2019-04-29 15:37:43.310|1|data-api|3|DEBUG] [SettingsAggregatorService]Parsing succeeded !
[2019-04-29 15:37:43.317|1|data-api|1|INFO] [Throttling][DRBT] Daily request-count based throttling has been enabled by configuration.
[2019-04-29 15:37:43.325|1|data-api|3|DEBUG] [Throttling][DRBT] Applying daily request-count limits - 10000 request(s) per day
[2019-04-29 15:37:43.333|1|data-api|1|INFO] [Throttling][DVBT] Daily volume-based throttling has been enabled by configuration.
[2019-04-29 15:37:43.341|1|data-api|3|DEBUG] [Throttling][DVBT] Applying daily volume-based limits - 5000000 KB per day
[2019-04-29 15:37:47.330|1|sxs-api|3|DEBUG] [event] onMclEvents