Skip to content

Instantly share code, notes, and snippets.

Embed
What would you like to do?
2020-10-21T17:27:04.7089624+03:00 0HM3LPJK8Q5CH:00000003 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/license/feature?t=1603290424489 (ca22a1cb)
2020-10-21T17:27:04.7093500+03:00 0HM3LPJK8Q5CH:00000003 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:04.7279406+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:04.7635741+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:04.7759282+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:04.7761664+03:00 0HM3LPJK8Q5CH:00000003 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:04.7765265+03:00 0HM3LPJK8Q5CH:00000003 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:04.7766192+03:00 0HM3LPJK8Q5CH:00000003 [DBG] 1 candidate(s) found for the request path '"/api/v1/license/feature"' (9406aaa8)
2020-10-21T17:27:04.7766704+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Endpoint '"Universal.Server.Controllers.LicenseController.GetLicensedFeatures (Universal.Server)"' with route pattern '"api/v1/license/feature"' is valid for the request path '"/api/v1/license/feature"' (430aaaf2)
2020-10-21T17:27:04.7767128+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Request matched endpoint '"Universal.Server.Controllers.LicenseController.GetLicensedFeatures (Universal.Server)"' (cbf60c4b)
2020-10-21T17:27:04.9938254+03:00 0HM3LPJK8Q5CH:00000003 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:04.9938897+03:00 0HM3LPJK8Q5CH:00000003 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:04.9939170+03:00 0HM3LPJK8Q5CH:00000003 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:05.0075906+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:05.0425616+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:05.0550334+03:00 0HM3LPJK8Q5CH:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:05.0553644+03:00 0HM3LPJK8Q5CH:00000003 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:05.0554235+03:00 0HM3LPJK8Q5CH:00000003 [INF] Executing endpoint '"Universal.Server.Controllers.LicenseController.GetLicensedFeatures (Universal.Server)"' (500cc934)
2020-10-21T17:27:05.0555582+03:00 0HM3LPJK8Q5CH:00000003 [INF] Route matched with "{action = \"GetLicensedFeatures\", controller = \"License\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.Common.Interfaces.Feature] GetLicensedFeatures()" on controller "Universal.Server.Controllers.LicenseController" ("Universal.Server"). (122b2fdf)
2020-10-21T17:27:05.0556195+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:05.0556570+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:05.0557054+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:05.0557429+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:05.0557757+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:05.0561583+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Executing controller factory for controller "Universal.Server.Controllers.LicenseController" ("Universal.Server") (9650b6ae)
2020-10-21T17:27:05.0562538+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Executed controller factory for controller "Universal.Server.Controllers.LicenseController" ("Universal.Server") (65418032)
2020-10-21T17:27:05.7072449+03:00 0HM3LPJK8Q5CH:00000003 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:05.7073227+03:00 0HM3LPJK8Q5CH:00000003 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:05.7073460+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:05.7073674+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:05.7074186+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:05.7074662+03:00 0HM3LPJK8Q5CH:00000003 [INF] Executing ObjectResult, writing value of type '"System.Collections.Generic.List`1[[UniversalAutomation.Common.Interfaces.Feature, UniversalAutomation.Common, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null]]"'. (8a1b66c8)
2020-10-21T17:27:05.7076972+03:00 0HM3LPJK8Q5CH:00000003 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:05.7079097+03:00 0HM3LPJK8Q5CH:00000003 [INF] Executed action "Universal.Server.Controllers.LicenseController.GetLicensedFeatures (Universal.Server)" in 651.7368ms (afa2e885)
2020-10-21T17:27:05.7079698+03:00 0HM3LPJK8Q5CH:00000003 [INF] Executed endpoint '"Universal.Server.Controllers.LicenseController.GetLicensedFeatures (Universal.Server)"' (99874f2b)
2020-10-21T17:27:05.7081026+03:00 0HM3LPJK8Q5CH:00000003 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:05.7081850+03:00 0HM3LPJK8Q5CH:00000003 [INF] Request finished in 999.1763ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:06.3389876+03:00 0HM3LPJK8Q5CG:00000003 [INF] Request starting HTTP/1.1 POST http://apptest.com/api/v1/script/1 application/json;charset=UTF-8 70 (ca22a1cb)
2020-10-21T17:27:06.3394095+03:00 0HM3LPJK8Q5CG:00000003 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:06.3542075+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:06.3900142+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.4024238+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.4027468+03:00 0HM3LPJK8Q5CG:00000003 [DBG] The request has an origin header: '"http://apptest.com"'. (e0d3e4a6)
2020-10-21T17:27:06.4027898+03:00 0HM3LPJK8Q5CG:00000003 [INF] CORS policy execution failed. (09b6f179)
2020-10-21T17:27:06.4028453+03:00 0HM3LPJK8Q5CG:00000003 [INF] Request origin "http://apptest.com" does not have permission to access the resource. (a03d560b)
2020-10-21T17:27:06.4029534+03:00 0HM3LPJK8Q5CG:00000003 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:06.4033205+03:00 0HM3LPJK8Q5CG:00000003 [DBG] "POST" requests are not supported (1c759b4c)
2020-10-21T17:27:06.4034553+03:00 0HM3LPJK8Q5CG:00000003 [DBG] 1 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:06.4035173+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Endpoint '"UniversalAutomation.ScriptController.InvokeScript (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:06.4035559+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.InvokeScript (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:06.6206551+03:00 0HM3LPJK8Q5CG:00000003 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:06.6207064+03:00 0HM3LPJK8Q5CG:00000003 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:06.6207299+03:00 0HM3LPJK8Q5CG:00000003 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:06.6333801+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:06.6688505+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.6811453+03:00 0HM3LPJK8Q5CG:00000003 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.6813416+03:00 0HM3LPJK8Q5CG:00000003 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:06.6813850+03:00 0HM3LPJK8Q5CG:00000003 [INF] Executing endpoint '"UniversalAutomation.ScriptController.InvokeScript (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:06.6814861+03:00 0HM3LPJK8Q5CG:00000003 [INF] Route matched with "{action = \"InvokeScript\", controller = \"Script\"}". Executing controller action with signature "System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.IActionResult] InvokeScript(Int64, UniversalAutomation.JobContext)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:06.6815465+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:06.6815775+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:06.6816110+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:06.6816384+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:06.6816664+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:06.6817208+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:06.6817824+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:06.6819880+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:06.6821489+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:06.6822146+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:06.6822502+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:06.6822773+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:06.6823480+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:06.6824347+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to bind parameter '"jobContext"' of type '"UniversalAutomation.JobContext"' ... (0448c17b)
2020-10-21T17:27:06.6825707+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to bind parameter '"jobContext"' of type '"UniversalAutomation.JobContext"' using the name '""' in request data ... (1d38b825)
2020-10-21T17:27:06.6826510+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Rejected input formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonPatchInputFormatter"' for content type '"application/json;charset=UTF-8"'. (8721b744)
2020-10-21T17:27:06.6827468+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Selected input formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonInputFormatter"' for content type '"application/json;charset=UTF-8"'. (df426542)
2020-10-21T17:27:06.6828992+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Connection id ""0HM3LPJK8Q5CG"", Request id ""0HM3LPJK8Q5CG:00000003"": started reading request body. (55b8f554)
2020-10-21T17:27:06.6830225+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Connection id ""0HM3LPJK8Q5CG"", Request id ""0HM3LPJK8Q5CG:00000003"": done reading request body. (6feb3b06)
2020-10-21T17:27:06.6832912+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to bind parameter '"jobContext"' of type '"UniversalAutomation.JobContext"'. (90fee3af)
2020-10-21T17:27:06.6833281+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to bind parameter '"jobContext"' of type '"UniversalAutomation.JobContext"'. (90fee3af)
2020-10-21T17:27:06.6833546+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Attempting to validate the bound parameter '"jobContext"' of type '"UniversalAutomation.JobContext"' ... (ce60666b)
2020-10-21T17:27:06.6834222+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Done attempting to validate the bound parameter '"jobContext"' of type '"UniversalAutomation.JobContext"'. (5d5b0261)
2020-10-21T17:27:06.6842195+03:00 0HM3LPJK8Q5CG:00000003 [INF] Invoking script 1, Identity: AUTO\uib70046, Using app token: (4ef54cec)
2020-10-21T17:27:06.6851182+03:00 0HM3LPJK8Q5CG:00000003 [DBG] ParentJobId: 0 (78f15068)
2020-10-21T17:27:06.6892302+03:00 0HM3LPJK8Q5CG:00000003 [INF] Executing JsonResult, writing value of type '"System.Int64"'. (2f513669)
2020-10-21T17:27:06.6893472+03:00 0HM3LPJK8Q5CG:00000003 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:06.6895354+03:00 0HM3LPJK8Q5CG:00000003 [INF] Executed action "UniversalAutomation.ScriptController.InvokeScript (UniversalAutomation)" in 7.8199ms (afa2e885)
2020-10-21T17:27:06.6895910+03:00 0HM3LPJK8Q5CG:00000003 [INF] Executed endpoint '"UniversalAutomation.ScriptController.InvokeScript (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:06.6897101+03:00 0HM3LPJK8Q5CG:00000003 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:06.6897831+03:00 0HM3LPJK8Q5CG:00000003 [INF] Request finished in 350.8142ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:06.7990286+03:00 0HM3LPJK8Q5CI:00000005 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290426616 (ca22a1cb)
2020-10-21T17:27:06.7993730+03:00 0HM3LPJK8Q5CI:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:06.7995123+03:00 0HM3LPJK8Q5CH:00000004 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290426616 (ca22a1cb)
2020-10-21T17:27:06.7998171+03:00 0HM3LPJK8Q5CH:00000004 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:06.8183124+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:06.8199775+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:06.8553520+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.8570758+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.8679419+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.8682348+03:00 0HM3LPJK8Q5CI:00000005 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:06.8686507+03:00 0HM3LPJK8Q5CI:00000005 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:06.8687619+03:00 0HM3LPJK8Q5CI:00000005 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:06.8688256+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:06.8688685+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:06.8698156+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:06.8700359+03:00 0HM3LPJK8Q5CH:00000004 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:06.8701857+03:00 0HM3LPJK8Q5CH:00000004 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:06.8702412+03:00 0HM3LPJK8Q5CH:00000004 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:06.8702968+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:06.8703390+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:06.9177177+03:00 [INF] Job 72 started. (bf0f324b)
2020-10-21T17:27:06.9190462+03:00 [DBG] AppToken not specified. Looking up AppToken for identity: 6 (3b99d64a)
2020-10-21T17:27:06.9295519+03:00 [DBG] Job 72 bound to port 55200. (3761d392)
2020-10-21T17:27:07.0863654+03:00 0HM3LPJK8Q5CI:00000005 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:07.0864345+03:00 0HM3LPJK8Q5CI:00000005 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:07.0864743+03:00 0HM3LPJK8Q5CI:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.0880699+03:00 0HM3LPJK8Q5CH:00000004 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:07.0881293+03:00 0HM3LPJK8Q5CH:00000004 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:07.0881666+03:00 0HM3LPJK8Q5CH:00000004 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.1002263+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.1019651+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.1377430+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.1396691+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.1507434+03:00 0HM3LPJK8Q5CI:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.1510178+03:00 0HM3LPJK8Q5CI:00000005 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:07.1510733+03:00 0HM3LPJK8Q5CI:00000005 [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:07.1511964+03:00 0HM3LPJK8Q5CI:00000005 [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:07.1512798+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.1513465+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.1514322+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:07.1514970+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.1515578+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.1516368+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:07.1517174+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:07.1519686+03:00 [DBG] Starting C:\Windows\System32\WindowsPowerShell\v1.0\powershell.exe with command line -NoProfile -Command "& { [System.Reflection.Assembly]::LoadFrom('C:\inetpub\wwwroot\Coeus\Host-v5\Host.dll') | Out-Null; [UniversalHost.AgentService]::StartJob(55200, 6268) }" (f09cf803)
2020-10-21T17:27:07.1519707+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:07.1519934+03:00 [INF] Starting job using Process. (4d0a5a43)
2020-10-21T17:27:07.1522074+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:07.1523067+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.1523360+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.1523663+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:07.1524525+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:07.1529295+03:00 0HM3LPJK8Q5CH:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.1530291+03:00 0HM3LPJK8Q5CI:00000005 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:07.1530925+03:00 0HM3LPJK8Q5CI:00000005 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:07.1531179+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:07.1531405+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:07.1531923+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:07.1532018+03:00 0HM3LPJK8Q5CH:00000004 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:07.1532227+03:00 0HM3LPJK8Q5CI:00000005 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:07.1532488+03:00 0HM3LPJK8Q5CH:00000004 [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:07.1533506+03:00 0HM3LPJK8Q5CH:00000004 [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:07.1533638+03:00 0HM3LPJK8Q5CI:00000005 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:07.1534130+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.1534762+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.1535221+03:00 0HM3LPJK8Q5CI:00000005 [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.9028ms (afa2e885)
2020-10-21T17:27:07.1535533+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:07.1535608+03:00 0HM3LPJK8Q5CI:00000005 [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:07.1536112+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.1536746+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.1537023+03:00 0HM3LPJK8Q5CI:00000005 [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:07.1537410+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:07.1537752+03:00 0HM3LPJK8Q5CI:00000005 [INF] Request finished in 354.7163ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:07.1538269+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:07.1539066+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:07.1539959+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:07.1540259+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.1540625+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.1540863+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:07.1541130+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:07.1547915+03:00 0HM3LPJK8Q5CH:00000004 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:07.1548298+03:00 0HM3LPJK8Q5CH:00000004 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:07.1548486+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:07.1548659+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:07.1548958+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:07.1549173+03:00 0HM3LPJK8Q5CH:00000004 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:07.1550865+03:00 0HM3LPJK8Q5CH:00000004 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:07.1551959+03:00 0HM3LPJK8Q5CH:00000004 [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.4718ms (afa2e885)
2020-10-21T17:27:07.1552368+03:00 0HM3LPJK8Q5CH:00000004 [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:07.1553854+03:00 0HM3LPJK8Q5CH:00000004 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:07.1554466+03:00 0HM3LPJK8Q5CH:00000004 [INF] Request finished in 355.928ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:07.2276724+03:00 0HM3LPJK8Q5CG:00000004 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290427049 (ca22a1cb)
2020-10-21T17:27:07.2280416+03:00 0HM3LPJK8Q5CG:00000004 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.2433804+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.2806479+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.2928471+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.2931336+03:00 0HM3LPJK8Q5CG:00000004 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:07.2933869+03:00 0HM3LPJK8Q5CG:00000004 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:07.2935170+03:00 0HM3LPJK8Q5CG:00000004 [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:07.2935829+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:07.2936085+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:07.2936597+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:07.3866961+03:00 [INF] Starting groom job. (bad5cbbf)
2020-10-21T17:27:07.3869052+03:00 [INF] Script test.ps1 has a max history of 100 (9a743f90)
2020-10-21T17:27:07.3917986+03:00 [INF] Script has 0 jobs to delete. (1676cac2)
2020-10-21T17:27:07.3920060+03:00 [INF] Groom date is: 9/21/2020 2:27:07 PM (e2bbae8f)
2020-10-21T17:27:07.3940745+03:00 [INF] Old jobs: 0 (be620771)
2020-10-21T17:27:07.3951247+03:00 [INF] Finished groom job. (ccb4f234)
2020-10-21T17:27:07.5159688+03:00 0HM3LPJK8Q5CG:00000004 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:07.5160410+03:00 0HM3LPJK8Q5CG:00000004 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:07.5160719+03:00 0HM3LPJK8Q5CG:00000004 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.5297191+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.5645462+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.5759905+03:00 0HM3LPJK8Q5CG:00000004 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.5761818+03:00 0HM3LPJK8Q5CG:00000004 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:07.5762266+03:00 0HM3LPJK8Q5CG:00000004 [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:07.5763071+03:00 0HM3LPJK8Q5CG:00000004 [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:07.5763541+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.5763813+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.5764126+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:07.5764385+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:07.5764822+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:07.5765355+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:07.5765908+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:07.5766547+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:07.5767451+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:07.5767832+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.5768073+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:07.5768297+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:07.5768589+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:07.5778817+03:00 0HM3LPJK8Q5CG:00000004 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:07.5779205+03:00 0HM3LPJK8Q5CG:00000004 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:07.5779422+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:07.5779582+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:07.5779917+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:07.5780152+03:00 0HM3LPJK8Q5CG:00000004 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:07.5781408+03:00 0HM3LPJK8Q5CG:00000004 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:07.5782558+03:00 0HM3LPJK8Q5CG:00000004 [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.7338ms (afa2e885)
2020-10-21T17:27:07.5782972+03:00 0HM3LPJK8Q5CG:00000004 [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:07.5784318+03:00 0HM3LPJK8Q5CG:00000004 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:07.5784936+03:00 0HM3LPJK8Q5CG:00000004 [INF] Request finished in 350.831ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:07.6520623+03:00 0HM3LPJK8Q5CI:00000006 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290427472 (ca22a1cb)
2020-10-21T17:27:07.6523531+03:00 0HM3LPJK8Q5CI:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.6651820+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.7072615+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.7191610+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:07.7193464+03:00 0HM3LPJK8Q5CI:00000006 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:07.7195848+03:00 0HM3LPJK8Q5CI:00000006 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:07.7196656+03:00 0HM3LPJK8Q5CI:00000006 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:07.7197431+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:07.7197855+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:07.9375410+03:00 0HM3LPJK8Q5CI:00000006 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:07.9376179+03:00 0HM3LPJK8Q5CI:00000006 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:07.9376493+03:00 0HM3LPJK8Q5CI:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:07.9523452+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:07.9886094+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:08.0004377+03:00 0HM3LPJK8Q5CI:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:08.0006493+03:00 0HM3LPJK8Q5CI:00000006 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:08.0006952+03:00 0HM3LPJK8Q5CI:00000006 [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:08.0007880+03:00 0HM3LPJK8Q5CI:00000006 [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:08.0008366+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:08.0008664+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:08.0009090+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:08.0009331+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:08.0009593+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:08.0010108+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:08.0010596+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:08.0011961+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:08.0013723+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:08.0014389+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:08.0014653+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:08.0014923+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:08.0015702+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:08.0021000+03:00 0HM3LPJK8Q5CI:00000006 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:08.0021460+03:00 0HM3LPJK8Q5CI:00000006 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:08.0021698+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:08.0021860+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:08.0022345+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:08.0022785+03:00 0HM3LPJK8Q5CI:00000006 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:08.0023737+03:00 0HM3LPJK8Q5CI:00000006 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:08.0025310+03:00 0HM3LPJK8Q5CI:00000006 [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.5176ms (afa2e885)
2020-10-21T17:27:08.0025672+03:00 0HM3LPJK8Q5CI:00000006 [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:08.0026698+03:00 0HM3LPJK8Q5CI:00000006 [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:08.0027459+03:00 0HM3LPJK8Q5CI:00000006 [INF] Request finished in 350.651ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:09.1481076+03:00 0HM3LPJK8Q5CH:00000005 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290428968 (ca22a1cb)
2020-10-21T17:27:09.1485616+03:00 0HM3LPJK8Q5CH:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.1494423+03:00 0HM3LPJK8Q5CG:00000005 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290428970 (ca22a1cb)
2020-10-21T17:27:09.1497603+03:00 0HM3LPJK8Q5CG:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.1632849+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.1649905+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.1992980+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.2010155+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.2109477+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.2111734+03:00 0HM3LPJK8Q5CH:00000005 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:09.2113962+03:00 0HM3LPJK8Q5CH:00000005 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:09.2114546+03:00 0HM3LPJK8Q5CH:00000005 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:09.2114982+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:09.2115240+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:09.2127665+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.2129919+03:00 0HM3LPJK8Q5CG:00000005 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:09.2131387+03:00 0HM3LPJK8Q5CG:00000005 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:09.2131955+03:00 0HM3LPJK8Q5CG:00000005 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:09.2132646+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:09.2133051+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:09.4299618+03:00 0HM3LPJK8Q5CG:00000005 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:09.4300397+03:00 0HM3LPJK8Q5CG:00000005 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:09.4300852+03:00 0HM3LPJK8Q5CG:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.4301275+03:00 0HM3LPJK8Q5CH:00000005 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:09.4301761+03:00 0HM3LPJK8Q5CH:00000005 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:09.4301988+03:00 0HM3LPJK8Q5CH:00000005 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.4456658+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.4473949+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.4822014+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.4839037+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.4936896+03:00 0HM3LPJK8Q5CG:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.4938986+03:00 0HM3LPJK8Q5CG:00000005 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:09.4939430+03:00 0HM3LPJK8Q5CG:00000005 [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:09.4940369+03:00 0HM3LPJK8Q5CG:00000005 [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:09.4940862+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.4941152+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.4941440+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:09.4941690+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.4941942+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.4942364+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:09.4942856+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:09.4944086+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:09.4945648+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:09.4946316+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.4946603+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.4946854+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:09.4947674+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:09.4955155+03:00 0HM3LPJK8Q5CG:00000005 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:09.4955202+03:00 0HM3LPJK8Q5CH:00000005 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.4955595+03:00 0HM3LPJK8Q5CG:00000005 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:09.4956100+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:09.4956473+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:09.4957096+03:00 0HM3LPJK8Q5CH:00000005 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:09.4957030+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:09.4957387+03:00 0HM3LPJK8Q5CH:00000005 [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:09.4957448+03:00 0HM3LPJK8Q5CG:00000005 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:09.4957998+03:00 0HM3LPJK8Q5CH:00000005 [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:09.4958351+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.4958625+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.4958902+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:09.4959150+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.4959405+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.4959771+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:09.4960133+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:09.4961045+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:09.4961058+03:00 0HM3LPJK8Q5CG:00000005 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:09.4962426+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:09.4962566+03:00 0HM3LPJK8Q5CG:00000005 [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 2.0258ms (afa2e885)
2020-10-21T17:27:09.4962995+03:00 0HM3LPJK8Q5CG:00000005 [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:09.4963198+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.4963713+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.4964210+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:09.4964380+03:00 0HM3LPJK8Q5CG:00000005 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:09.4965027+03:00 0HM3LPJK8Q5CG:00000005 [INF] Request finished in 347.0501ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:09.4965091+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:09.4969750+03:00 0HM3LPJK8Q5CH:00000005 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:09.4970106+03:00 0HM3LPJK8Q5CH:00000005 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:09.4970286+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:09.4970450+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:09.4970713+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:09.4970945+03:00 0HM3LPJK8Q5CH:00000005 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:09.4971639+03:00 0HM3LPJK8Q5CH:00000005 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:09.4972502+03:00 0HM3LPJK8Q5CH:00000005 [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.2726ms (afa2e885)
2020-10-21T17:27:09.4973010+03:00 0HM3LPJK8Q5CH:00000005 [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:09.4973830+03:00 0HM3LPJK8Q5CH:00000005 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:09.4974430+03:00 0HM3LPJK8Q5CH:00000005 [INF] Request finished in 349.3649ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:09.5661033+03:00 0HM3LPJK8Q5CI:00000007 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290429384 (ca22a1cb)
2020-10-21T17:27:09.5664157+03:00 0HM3LPJK8Q5CI:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.5920306+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.6280121+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.6404630+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.6406725+03:00 0HM3LPJK8Q5CI:00000007 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:09.6408416+03:00 0HM3LPJK8Q5CI:00000007 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:09.6409047+03:00 0HM3LPJK8Q5CI:00000007 [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:09.6409479+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:09.6409736+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:09.6409979+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:09.8591652+03:00 0HM3LPJK8Q5CI:00000007 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:09.8592337+03:00 0HM3LPJK8Q5CI:00000007 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:09.8592617+03:00 0HM3LPJK8Q5CI:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:09.8726817+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:09.9138331+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.9254827+03:00 0HM3LPJK8Q5CI:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:09.9256853+03:00 0HM3LPJK8Q5CI:00000007 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:09.9257272+03:00 0HM3LPJK8Q5CI:00000007 [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:09.9258201+03:00 0HM3LPJK8Q5CI:00000007 [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:09.9258669+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.9258964+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.9259371+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:09.9259639+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:09.9259884+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:09.9260396+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:09.9260976+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:09.9262217+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:09.9263422+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:09.9264052+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.9264321+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:09.9264569+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:09.9265222+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:09.9275577+03:00 0HM3LPJK8Q5CI:00000007 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:09.9275985+03:00 0HM3LPJK8Q5CI:00000007 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:09.9276346+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:09.9276514+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:09.9276829+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:09.9277064+03:00 0HM3LPJK8Q5CI:00000007 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:09.9278751+03:00 0HM3LPJK8Q5CI:00000007 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:09.9279996+03:00 0HM3LPJK8Q5CI:00000007 [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.966ms (afa2e885)
2020-10-21T17:27:09.9280500+03:00 0HM3LPJK8Q5CI:00000007 [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:09.9281783+03:00 0HM3LPJK8Q5CI:00000007 [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:09.9282504+03:00 0HM3LPJK8Q5CI:00000007 [INF] Request finished in 362.1161ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:09.9971633+03:00 0HM3LPJK8Q5CG:00000006 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290429814 (ca22a1cb)
2020-10-21T17:27:09.9975302+03:00 0HM3LPJK8Q5CG:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.0111444+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.0458605+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.0573423+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.0575334+03:00 0HM3LPJK8Q5CG:00000006 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:10.0577183+03:00 0HM3LPJK8Q5CG:00000006 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:10.0577805+03:00 0HM3LPJK8Q5CG:00000006 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:10.0578240+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:10.0578488+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:10.1473285+03:00 0HM3LPJK8Q5CH:00000006 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290429969 (ca22a1cb)
2020-10-21T17:27:10.1476399+03:00 0HM3LPJK8Q5CI:00000008 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290429971 (ca22a1cb)
2020-10-21T17:27:10.1476475+03:00 0HM3LPJK8Q5CH:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.1479389+03:00 0HM3LPJK8Q5CI:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.1615925+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.1629677+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.1986267+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.2003529+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.2113939+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.2116033+03:00 0HM3LPJK8Q5CH:00000006 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:10.2117866+03:00 0HM3LPJK8Q5CH:00000006 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:10.2118460+03:00 0HM3LPJK8Q5CH:00000006 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:10.2118893+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:10.2119133+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:10.2130911+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.2133123+03:00 0HM3LPJK8Q5CI:00000008 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:10.2134577+03:00 0HM3LPJK8Q5CI:00000008 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:10.2135146+03:00 0HM3LPJK8Q5CI:00000008 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:10.2135832+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:10.2136331+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:10.2783532+03:00 0HM3LPJK8Q5CG:00000006 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:10.2784239+03:00 0HM3LPJK8Q5CG:00000006 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:10.2784488+03:00 0HM3LPJK8Q5CG:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.2914311+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.3263898+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.3380013+03:00 0HM3LPJK8Q5CG:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.3382098+03:00 0HM3LPJK8Q5CG:00000006 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:10.3382602+03:00 0HM3LPJK8Q5CG:00000006 [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:10.3383673+03:00 0HM3LPJK8Q5CG:00000006 [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:10.3384248+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.3384684+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.3385140+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:10.3385515+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.3385915+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.3386620+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:10.3387405+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:10.3388850+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:10.3390429+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:10.3391301+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.3391796+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.3392410+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:10.3393420+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:10.3398342+03:00 0HM3LPJK8Q5CG:00000006 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:10.3398766+03:00 0HM3LPJK8Q5CG:00000006 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:10.3399132+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:10.3399466+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:10.3400027+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:10.3400626+03:00 0HM3LPJK8Q5CG:00000006 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:10.3401785+03:00 0HM3LPJK8Q5CG:00000006 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:10.3403385+03:00 0HM3LPJK8Q5CG:00000006 [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.6972ms (afa2e885)
2020-10-21T17:27:10.3403881+03:00 0HM3LPJK8Q5CG:00000006 [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:10.3404884+03:00 0HM3LPJK8Q5CG:00000006 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:10.3405485+03:00 0HM3LPJK8Q5CG:00000006 [INF] Request finished in 343.387ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:10.4313355+03:00 0HM3LPJK8Q5CH:00000006 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:10.4314126+03:00 0HM3LPJK8Q5CH:00000006 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:10.4314588+03:00 0HM3LPJK8Q5CH:00000006 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.4334598+03:00 0HM3LPJK8Q5CI:00000008 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:10.4335067+03:00 0HM3LPJK8Q5CI:00000008 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:10.4335315+03:00 0HM3LPJK8Q5CI:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.4447953+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.4464861+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.4804997+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.4822245+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.4922347+03:00 0HM3LPJK8Q5CH:00000006 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.4924572+03:00 0HM3LPJK8Q5CH:00000006 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:10.4925140+03:00 0HM3LPJK8Q5CH:00000006 [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:10.4926337+03:00 0HM3LPJK8Q5CH:00000006 [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:10.4926912+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.4927207+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.4927533+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:10.4927802+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.4928070+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.4928546+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:10.4929099+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:10.4930379+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:10.4932284+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:10.4933171+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.4933825+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.4934398+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:10.4935443+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:10.4939873+03:00 0HM3LPJK8Q5CI:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.4941304+03:00 0HM3LPJK8Q5CH:00000006 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:10.4941773+03:00 0HM3LPJK8Q5CH:00000006 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:10.4942192+03:00 0HM3LPJK8Q5CI:00000008 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:10.4942134+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:10.4942493+03:00 0HM3LPJK8Q5CI:00000008 [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:10.4942512+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:10.4943092+03:00 0HM3LPJK8Q5CI:00000008 [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:10.4943107+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:10.4943424+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.4943555+03:00 0HM3LPJK8Q5CH:00000006 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:10.4943704+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.4944002+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:10.4944228+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.4944486+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.4944872+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:10.4944766+03:00 0HM3LPJK8Q5CH:00000006 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:10.4945239+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:10.4946340+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:10.4946361+03:00 0HM3LPJK8Q5CH:00000006 [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.7637ms (afa2e885)
2020-10-21T17:27:10.4946824+03:00 0HM3LPJK8Q5CH:00000006 [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:10.4947941+03:00 0HM3LPJK8Q5CH:00000006 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:10.4948278+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:10.4948611+03:00 0HM3LPJK8Q5CH:00000006 [INF] Request finished in 347.5077ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:10.4949110+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.4949568+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.4950051+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:10.4950927+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:10.4957633+03:00 0HM3LPJK8Q5CI:00000008 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:10.4957971+03:00 0HM3LPJK8Q5CI:00000008 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:10.4958171+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:10.4958321+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:10.4958602+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:10.4958809+03:00 0HM3LPJK8Q5CI:00000008 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:10.4960768+03:00 0HM3LPJK8Q5CI:00000008 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:10.4962157+03:00 0HM3LPJK8Q5CI:00000008 [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.7237ms (afa2e885)
2020-10-21T17:27:10.4962653+03:00 0HM3LPJK8Q5CI:00000008 [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:10.4963690+03:00 0HM3LPJK8Q5CI:00000008 [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:10.4964289+03:00 0HM3LPJK8Q5CI:00000008 [INF] Request finished in 348.7826ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:10.5541759+03:00 0HM3LPJK8Q5CG:00000007 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290430377 (ca22a1cb)
2020-10-21T17:27:10.5545194+03:00 0HM3LPJK8Q5CG:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.5680562+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.6028485+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.6144089+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.6145958+03:00 0HM3LPJK8Q5CG:00000007 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:10.6147828+03:00 0HM3LPJK8Q5CG:00000007 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:10.6148448+03:00 0HM3LPJK8Q5CG:00000007 [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:10.6148981+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:10.6149261+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:10.6149532+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:10.8317393+03:00 0HM3LPJK8Q5CG:00000007 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:10.8318082+03:00 0HM3LPJK8Q5CG:00000007 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:10.8318334+03:00 0HM3LPJK8Q5CG:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.8503419+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:10.8861140+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.8977579+03:00 0HM3LPJK8Q5CG:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:10.8979496+03:00 0HM3LPJK8Q5CG:00000007 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:10.8979925+03:00 0HM3LPJK8Q5CG:00000007 [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:10.8980747+03:00 0HM3LPJK8Q5CG:00000007 [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:10.8981234+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.8981511+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.8981927+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:10.8982190+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:10.8982451+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:10.8982953+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:10.8983539+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:10.8985087+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:10.8987001+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:10.8987764+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.8988155+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:10.8988460+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:10.8989474+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:10.8999588+03:00 0HM3LPJK8Q5CG:00000007 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:10.8999957+03:00 0HM3LPJK8Q5CG:00000007 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:10.9000165+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:10.9000329+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:10.9000639+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:10.9000854+03:00 0HM3LPJK8Q5CG:00000007 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:10.9002220+03:00 0HM3LPJK8Q5CG:00000007 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:10.9003721+03:00 0HM3LPJK8Q5CG:00000007 [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 2.0751ms (afa2e885)
2020-10-21T17:27:10.9004239+03:00 0HM3LPJK8Q5CG:00000007 [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:10.9005595+03:00 0HM3LPJK8Q5CG:00000007 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:10.9006382+03:00 0HM3LPJK8Q5CG:00000007 [INF] Request finished in 346.4297ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:10.9705663+03:00 0HM3LPJK8Q5CH:00000007 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290430786 (ca22a1cb)
2020-10-21T17:27:10.9709532+03:00 0HM3LPJK8Q5CH:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:10.9846890+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.0201377+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.0318421+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.0320348+03:00 0HM3LPJK8Q5CH:00000007 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:11.0322090+03:00 0HM3LPJK8Q5CH:00000007 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:11.0322712+03:00 0HM3LPJK8Q5CH:00000007 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:11.0323135+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:11.0323350+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:11.1497642+03:00 0HM3LPJK8Q5CI:00000009 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290430971 (ca22a1cb)
2020-10-21T17:27:11.1501239+03:00 0HM3LPJK8Q5CI:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.1501336+03:00 0HM3LPJK8Q5CG:00000008 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290430972 (ca22a1cb)
2020-10-21T17:27:11.1503869+03:00 0HM3LPJK8Q5CG:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.1645079+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.1662407+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.2005562+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.2022955+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.2131379+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.2133930+03:00 0HM3LPJK8Q5CI:00000009 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:11.2135859+03:00 0HM3LPJK8Q5CI:00000009 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:11.2136874+03:00 0HM3LPJK8Q5CI:00000009 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:11.2137769+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:11.2138218+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:11.2148602+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.2150332+03:00 0HM3LPJK8Q5CG:00000008 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:11.2151752+03:00 0HM3LPJK8Q5CG:00000008 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:11.2152288+03:00 0HM3LPJK8Q5CG:00000008 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:11.2152875+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:11.2153285+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:11.2527627+03:00 0HM3LPJK8Q5CH:00000007 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:11.2528354+03:00 0HM3LPJK8Q5CH:00000007 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:11.2528767+03:00 0HM3LPJK8Q5CH:00000007 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.2654510+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.3014952+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.3132296+03:00 0HM3LPJK8Q5CH:00000007 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.3134258+03:00 0HM3LPJK8Q5CH:00000007 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:11.3134683+03:00 0HM3LPJK8Q5CH:00000007 [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:11.3135507+03:00 0HM3LPJK8Q5CH:00000007 [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:11.3135996+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.3136287+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.3136574+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:11.3136968+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.3137256+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.3137691+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:11.3138098+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:11.3139839+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:11.3142097+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:11.3143143+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.3143691+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.3144115+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:11.3144617+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:11.3149395+03:00 0HM3LPJK8Q5CH:00000007 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:11.3149907+03:00 0HM3LPJK8Q5CH:00000007 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:11.3150283+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:11.3150607+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:11.3151126+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:11.3151635+03:00 0HM3LPJK8Q5CH:00000007 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:11.3152604+03:00 0HM3LPJK8Q5CH:00000007 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:11.3154023+03:00 0HM3LPJK8Q5CH:00000007 [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.6291ms (afa2e885)
2020-10-21T17:27:11.3154522+03:00 0HM3LPJK8Q5CH:00000007 [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:11.3155500+03:00 0HM3LPJK8Q5CH:00000007 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:11.3156136+03:00 0HM3LPJK8Q5CH:00000007 [INF] Request finished in 345.0343ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:11.4333507+03:00 0HM3LPJK8Q5CG:00000008 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:11.4334292+03:00 0HM3LPJK8Q5CG:00000008 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:11.4334714+03:00 0HM3LPJK8Q5CG:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.4339136+03:00 0HM3LPJK8Q5CI:00000009 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:11.4339593+03:00 0HM3LPJK8Q5CI:00000009 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:11.4339849+03:00 0HM3LPJK8Q5CI:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.4466907+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.4483243+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.4826153+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.4843391+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.4977977+03:00 0HM3LPJK8Q5CG:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.4979955+03:00 0HM3LPJK8Q5CG:00000008 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:11.4980394+03:00 0HM3LPJK8Q5CG:00000008 [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:11.4981176+03:00 0HM3LPJK8Q5CG:00000008 [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:11.4981676+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.4981959+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.4982385+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:11.4982655+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.4982921+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.4983368+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:11.4983792+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:11.4984513+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:11.4985890+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:11.4986404+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.4986656+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.4986867+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:11.4987140+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:11.4995345+03:00 0HM3LPJK8Q5CG:00000008 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:11.4995875+03:00 0HM3LPJK8Q5CG:00000008 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:11.4996092+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:11.4996276+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:11.4996465+03:00 0HM3LPJK8Q5CI:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.4996712+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:11.4996966+03:00 0HM3LPJK8Q5CG:00000008 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:11.4998281+03:00 0HM3LPJK8Q5CI:00000009 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:11.4998692+03:00 0HM3LPJK8Q5CI:00000009 [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:11.4998996+03:00 0HM3LPJK8Q5CG:00000008 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:11.4999603+03:00 0HM3LPJK8Q5CI:00000009 [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:11.5000233+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.5000408+03:00 0HM3LPJK8Q5CG:00000008 [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.7041ms (afa2e885)
2020-10-21T17:27:11.5000752+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.5000805+03:00 0HM3LPJK8Q5CG:00000008 [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:11.5001479+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:11.5002074+03:00 0HM3LPJK8Q5CG:00000008 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:11.5002076+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.5002585+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.5002721+03:00 0HM3LPJK8Q5CG:00000008 [INF] Request finished in 350.1174ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:11.5003248+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:11.5003881+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:11.5004548+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:11.5005204+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:11.5005692+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.5006091+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.5006602+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:11.5007153+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:11.5011540+03:00 0HM3LPJK8Q5CI:00000009 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:11.5011900+03:00 0HM3LPJK8Q5CI:00000009 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:11.5012206+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:11.5012505+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:11.5012907+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:11.5013373+03:00 0HM3LPJK8Q5CI:00000009 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:11.5014207+03:00 0HM3LPJK8Q5CI:00000009 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:11.5015313+03:00 0HM3LPJK8Q5CI:00000009 [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.2171ms (afa2e885)
2020-10-21T17:27:11.5015759+03:00 0HM3LPJK8Q5CI:00000009 [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:11.5016768+03:00 0HM3LPJK8Q5CI:00000009 [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:11.5017370+03:00 0HM3LPJK8Q5CI:00000009 [INF] Request finished in 351.9744ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:11.5704234+03:00 0HM3LPJK8Q5CH:00000008 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290431389 (ca22a1cb)
2020-10-21T17:27:11.5707433+03:00 0HM3LPJK8Q5CH:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.5846422+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.6213782+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.6338753+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.6340664+03:00 0HM3LPJK8Q5CH:00000008 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:11.6342399+03:00 0HM3LPJK8Q5CH:00000008 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:11.6342891+03:00 0HM3LPJK8Q5CH:00000008 [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:11.6343274+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:11.6343501+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:11.6343798+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:11.8527168+03:00 0HM3LPJK8Q5CH:00000008 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:11.8527883+03:00 0HM3LPJK8Q5CH:00000008 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:11.8528162+03:00 0HM3LPJK8Q5CH:00000008 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.8664417+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:11.9011444+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.9135189+03:00 0HM3LPJK8Q5CH:00000008 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:11.9137225+03:00 0HM3LPJK8Q5CH:00000008 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:11.9137774+03:00 0HM3LPJK8Q5CH:00000008 [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:11.9138876+03:00 0HM3LPJK8Q5CH:00000008 [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:11.9139419+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.9139705+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.9140023+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:11.9140275+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:11.9140540+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:11.9140984+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:11.9141543+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:11.9142017+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:11.9142602+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:11.9142874+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.9143094+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:11.9143311+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:11.9143554+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:11.9153603+03:00 0HM3LPJK8Q5CH:00000008 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:11.9153969+03:00 0HM3LPJK8Q5CH:00000008 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:11.9154177+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:11.9154335+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:11.9154649+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:11.9154882+03:00 0HM3LPJK8Q5CH:00000008 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:11.9156060+03:00 0HM3LPJK8Q5CH:00000008 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:11.9157345+03:00 0HM3LPJK8Q5CH:00000008 [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.6417ms (afa2e885)
2020-10-21T17:27:11.9157735+03:00 0HM3LPJK8Q5CH:00000008 [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:11.9159037+03:00 0HM3LPJK8Q5CH:00000008 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:11.9159733+03:00 0HM3LPJK8Q5CH:00000008 [INF] Request finished in 345.5225ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:11.9722184+03:00 0HM3LPJK8Q5CG:00000009 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290431796 (ca22a1cb)
2020-10-21T17:27:11.9725285+03:00 0HM3LPJK8Q5CG:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:11.9855025+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.0202518+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.0318779+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.0321183+03:00 0HM3LPJK8Q5CG:00000009 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:12.0322839+03:00 0HM3LPJK8Q5CG:00000009 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:12.0323341+03:00 0HM3LPJK8Q5CG:00000009 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:12.0323681+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:12.0323895+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:12.1504000+03:00 0HM3LPJK8Q5CH:00000009 [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290431974 (ca22a1cb)
2020-10-21T17:27:12.1504000+03:00 0HM3LPJK8Q5CI:0000000A [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290431973 (ca22a1cb)
2020-10-21T17:27:12.1507980+03:00 0HM3LPJK8Q5CH:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.1507985+03:00 0HM3LPJK8Q5CI:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.1649990+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.1663647+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.2013673+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.2030717+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.2130317+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.2132533+03:00 0HM3LPJK8Q5CH:00000009 [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:12.2134389+03:00 0HM3LPJK8Q5CH:00000009 [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:12.2134994+03:00 0HM3LPJK8Q5CH:00000009 [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:12.2135623+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:12.2136006+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:12.2147867+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.2150029+03:00 0HM3LPJK8Q5CI:0000000A [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:12.2151403+03:00 0HM3LPJK8Q5CI:0000000A [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:12.2151920+03:00 0HM3LPJK8Q5CI:0000000A [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:12.2152403+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:12.2152781+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:12.2532354+03:00 0HM3LPJK8Q5CG:00000009 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:12.2533117+03:00 0HM3LPJK8Q5CG:00000009 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:12.2533545+03:00 0HM3LPJK8Q5CG:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.2662490+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.3033735+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.3152365+03:00 0HM3LPJK8Q5CG:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.3154412+03:00 0HM3LPJK8Q5CG:00000009 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:12.3154940+03:00 0HM3LPJK8Q5CG:00000009 [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:12.3156106+03:00 0HM3LPJK8Q5CG:00000009 [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:12.3156909+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.3157589+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.3158286+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:12.3158765+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.3159403+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.3160217+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:12.3161045+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:12.3161845+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:12.3162750+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:12.3163360+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.3163839+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.3164307+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:12.3164893+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:12.3170981+03:00 0HM3LPJK8Q5CG:00000009 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:12.3171448+03:00 0HM3LPJK8Q5CG:00000009 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:12.3171821+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:12.3172200+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:12.3172736+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:12.3173380+03:00 0HM3LPJK8Q5CG:00000009 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:12.3174451+03:00 0HM3LPJK8Q5CG:00000009 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:12.3175867+03:00 0HM3LPJK8Q5CG:00000009 [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.5862ms (afa2e885)
2020-10-21T17:27:12.3176414+03:00 0HM3LPJK8Q5CG:00000009 [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:12.3177532+03:00 0HM3LPJK8Q5CG:00000009 [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:12.3178277+03:00 0HM3LPJK8Q5CG:00000009 [INF] Request finished in 345.5838ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:12.4339193+03:00 0HM3LPJK8Q5CH:00000009 [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:12.4339953+03:00 0HM3LPJK8Q5CH:00000009 [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:12.4340338+03:00 0HM3LPJK8Q5CH:00000009 [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.4342685+03:00 0HM3LPJK8Q5CI:0000000A [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:12.4343148+03:00 0HM3LPJK8Q5CI:0000000A [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:12.4343359+03:00 0HM3LPJK8Q5CI:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.4477821+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.4491300+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.4937006+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.4953919+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.5053317+03:00 0HM3LPJK8Q5CI:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.5055403+03:00 0HM3LPJK8Q5CI:0000000A [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:12.5055832+03:00 0HM3LPJK8Q5CI:0000000A [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:12.5056680+03:00 0HM3LPJK8Q5CI:0000000A [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:12.5057440+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.5057762+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.5058172+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:12.5058413+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.5058675+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.5059122+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:12.5059635+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:12.5060132+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:12.5060753+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:12.5061050+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.5061250+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.5061465+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:12.5061720+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:12.5067495+03:00 0HM3LPJK8Q5CI:0000000A [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:12.5068247+03:00 0HM3LPJK8Q5CI:0000000A [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:12.5068588+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:12.5068929+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:12.5069434+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:12.5069846+03:00 0HM3LPJK8Q5CI:0000000A [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:12.5071085+03:00 0HM3LPJK8Q5CH:00000009 [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.5071277+03:00 0HM3LPJK8Q5CI:0000000A [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:12.5072451+03:00 0HM3LPJK8Q5CI:0000000A [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.3334ms (afa2e885)
2020-10-21T17:27:12.5072941+03:00 0HM3LPJK8Q5CI:0000000A [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:12.5073513+03:00 0HM3LPJK8Q5CH:00000009 [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:12.5073929+03:00 0HM3LPJK8Q5CH:00000009 [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:12.5074045+03:00 0HM3LPJK8Q5CI:0000000A [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:12.5074716+03:00 0HM3LPJK8Q5CI:0000000A [INF] Request finished in 357.0737ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:12.5074781+03:00 0HM3LPJK8Q5CH:00000009 [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:12.5075336+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.5075739+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.5076205+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:12.5076815+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.5077095+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.5077501+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:12.5077870+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:12.5078234+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:12.5078602+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:12.5078868+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.5079078+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.5079267+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:12.5079505+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:12.5085650+03:00 0HM3LPJK8Q5CH:00000009 [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:12.5085986+03:00 0HM3LPJK8Q5CH:00000009 [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:12.5086188+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:12.5086352+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:12.5086627+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:12.5086859+03:00 0HM3LPJK8Q5CH:00000009 [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:12.5088526+03:00 0HM3LPJK8Q5CH:00000009 [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:12.5089886+03:00 0HM3LPJK8Q5CH:00000009 [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.236ms (afa2e885)
2020-10-21T17:27:12.5090287+03:00 0HM3LPJK8Q5CH:00000009 [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:12.5091240+03:00 0HM3LPJK8Q5CH:00000009 [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:12.5092022+03:00 0HM3LPJK8Q5CH:00000009 [INF] Request finished in 358.7808ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:12.5657275+03:00 0HM3LPJK8Q5CG:0000000A [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290432389 (ca22a1cb)
2020-10-21T17:27:12.5660367+03:00 0HM3LPJK8Q5CG:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.5790312+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.6139710+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.6263326+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.6265191+03:00 0HM3LPJK8Q5CG:0000000A [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:12.6266937+03:00 0HM3LPJK8Q5CG:0000000A [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:12.6267618+03:00 0HM3LPJK8Q5CG:0000000A [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:12.6267955+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:12.6268168+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:12.6268467+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:12.6634566+03:00 [INF] Error executing job 72: Did not receive port from client process. at UniversalAutomation.ExecutionService.ExecutePowerShell(Script script, IEnumerable`1 parameters, Job job, Schedule schedule, Int32 port, ExecutionCallback callback) in D:\a\universal\universal\src\UniversalAutomation\Services\ExecutionService.cs:line 399
at UniversalAutomation.ExecutionService.TryExecute(Job job, Schedule schedule) in D:\a\universal\universal\src\UniversalAutomation\Services\ExecutionService.cs:line 290
at UniversalAutomation.ExecutionService.Execute(Job job, Schedule schedule) in D:\a\universal\universal\src\UniversalAutomation\Services\ExecutionService.cs:line 151 System.Exception (60a564cf)
2020-10-21T17:27:12.8435362+03:00 0HM3LPJK8Q5CG:0000000A [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:12.8436165+03:00 0HM3LPJK8Q5CG:0000000A [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:12.8436592+03:00 0HM3LPJK8Q5CG:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.8576312+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:12.8936186+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.9158178+03:00 0HM3LPJK8Q5CG:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:12.9160275+03:00 0HM3LPJK8Q5CG:0000000A [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:12.9160719+03:00 0HM3LPJK8Q5CG:0000000A [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:12.9161540+03:00 0HM3LPJK8Q5CG:0000000A [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:12.9162021+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.9162293+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.9162737+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:12.9162974+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:12.9163234+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:12.9163675+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:12.9164154+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:12.9164706+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:12.9165189+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:12.9165521+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.9165750+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:12.9165961+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:12.9166204+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:12.9176170+03:00 0HM3LPJK8Q5CG:0000000A [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:12.9176529+03:00 0HM3LPJK8Q5CG:0000000A [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:12.9176863+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:12.9177164+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:12.9177648+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:12.9177899+03:00 0HM3LPJK8Q5CG:0000000A [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:12.9179158+03:00 0HM3LPJK8Q5CG:0000000A [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:12.9180549+03:00 0HM3LPJK8Q5CG:0000000A [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.6866ms (afa2e885)
2020-10-21T17:27:12.9180990+03:00 0HM3LPJK8Q5CG:0000000A [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:12.9182257+03:00 0HM3LPJK8Q5CG:0000000A [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:12.9183009+03:00 0HM3LPJK8Q5CG:0000000A [INF] Request finished in 352.5701ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:12.9857629+03:00 0HM3LPJK8Q5CI:0000000B [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290432806 (ca22a1cb)
2020-10-21T17:27:12.9860779+03:00 0HM3LPJK8Q5CI:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:12.9999437+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.0362633+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.0486633+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.0488637+03:00 0HM3LPJK8Q5CI:0000000B [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:13.0490313+03:00 0HM3LPJK8Q5CI:0000000B [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:13.0490834+03:00 0HM3LPJK8Q5CI:0000000B [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:13.0491151+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:13.0491359+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:13.1621276+03:00 0HM3LPJK8Q5CH:0000000A [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290432975 (ca22a1cb)
2020-10-21T17:27:13.1624446+03:00 0HM3LPJK8Q5CH:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.1647282+03:00 0HM3LPJK8Q5CG:0000000B [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290432977 (ca22a1cb)
2020-10-21T17:27:13.1650225+03:00 0HM3LPJK8Q5CG:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.1773196+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.1790909+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.2154554+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.2171759+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.2279929+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.2282087+03:00 0HM3LPJK8Q5CH:0000000A [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:13.2283702+03:00 0HM3LPJK8Q5CH:0000000A [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:13.2284205+03:00 0HM3LPJK8Q5CH:0000000A [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:13.2284535+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:13.2284747+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:13.2297181+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.2299447+03:00 0HM3LPJK8Q5CG:0000000B [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:13.2300889+03:00 0HM3LPJK8Q5CG:0000000B [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:13.2301402+03:00 0HM3LPJK8Q5CG:0000000B [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:13.2301917+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:13.2302312+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:13.2692069+03:00 0HM3LPJK8Q5CI:0000000B [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:13.2692801+03:00 0HM3LPJK8Q5CI:0000000B [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:13.2693219+03:00 0HM3LPJK8Q5CI:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.2885480+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.3238830+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.3355960+03:00 0HM3LPJK8Q5CI:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.3358509+03:00 0HM3LPJK8Q5CI:0000000B [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:13.3359025+03:00 0HM3LPJK8Q5CI:0000000B [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:13.3360170+03:00 0HM3LPJK8Q5CI:0000000B [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:13.3360778+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.3361413+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.3362205+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:13.3362773+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.3363321+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.3364066+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:13.3364887+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:13.3365696+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:13.3366546+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:13.3367027+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.3367462+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.3367974+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:13.3368471+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:13.3374444+03:00 0HM3LPJK8Q5CI:0000000B [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:13.3374887+03:00 0HM3LPJK8Q5CI:0000000B [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:13.3375230+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:13.3375596+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:13.3376145+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:13.3376717+03:00 0HM3LPJK8Q5CI:0000000B [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:13.3377930+03:00 0HM3LPJK8Q5CI:0000000B [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:13.3379311+03:00 0HM3LPJK8Q5CI:0000000B [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.5402ms (afa2e885)
2020-10-21T17:27:13.3379804+03:00 0HM3LPJK8Q5CI:0000000B [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:13.3380790+03:00 0HM3LPJK8Q5CI:0000000B [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:13.3381796+03:00 0HM3LPJK8Q5CI:0000000B [INF] Request finished in 352.3785ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:13.4504544+03:00 0HM3LPJK8Q5CG:0000000B [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:13.4505097+03:00 0HM3LPJK8Q5CG:0000000B [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:13.4505344+03:00 0HM3LPJK8Q5CG:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.4534957+03:00 0HM3LPJK8Q5CH:0000000A [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:13.4535625+03:00 0HM3LPJK8Q5CH:0000000A [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:13.4536006+03:00 0HM3LPJK8Q5CH:0000000A [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.4642893+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.4659610+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.4995800+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.5012738+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.5113877+03:00 0HM3LPJK8Q5CG:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.5116031+03:00 0HM3LPJK8Q5CG:0000000B [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:13.5116477+03:00 0HM3LPJK8Q5CG:0000000B [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:13.5117416+03:00 0HM3LPJK8Q5CG:0000000B [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:13.5117944+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.5118256+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.5118574+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:13.5118809+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.5119074+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.5119548+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:13.5120091+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:13.5120599+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:13.5121211+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:13.5121575+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.5121788+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.5122010+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:13.5122260+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:13.5131493+03:00 0HM3LPJK8Q5CH:0000000A [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.5131681+03:00 0HM3LPJK8Q5CG:0000000B [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:13.5132029+03:00 0HM3LPJK8Q5CG:0000000B [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:13.5132203+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:13.5132380+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:13.5132690+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:13.5132921+03:00 0HM3LPJK8Q5CG:0000000B [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:13.5134337+03:00 0HM3LPJK8Q5CH:0000000A [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:13.5134489+03:00 0HM3LPJK8Q5CG:0000000B [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:13.5134829+03:00 0HM3LPJK8Q5CH:0000000A [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:13.5135755+03:00 0HM3LPJK8Q5CG:0000000B [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.6295ms (afa2e885)
2020-10-21T17:27:13.5135829+03:00 0HM3LPJK8Q5CH:0000000A [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:13.5136009+03:00 0HM3LPJK8Q5CG:0000000B [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:13.5136432+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.5137022+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.5137262+03:00 0HM3LPJK8Q5CG:0000000B [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:13.5137755+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:13.5138008+03:00 0HM3LPJK8Q5CG:0000000B [INF] Request finished in 349.0432ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:13.5138278+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.5138835+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.5139639+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:13.5140398+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:13.5141015+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:13.5141811+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:13.5142310+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.5142565+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.5142782+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:13.5143016+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:13.5147347+03:00 0HM3LPJK8Q5CH:0000000A [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:13.5147871+03:00 0HM3LPJK8Q5CH:0000000A [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:13.5148068+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:13.5148252+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:13.5148530+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:13.5148771+03:00 0HM3LPJK8Q5CH:0000000A [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:13.5149457+03:00 0HM3LPJK8Q5CH:0000000A [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:13.5150370+03:00 0HM3LPJK8Q5CH:0000000A [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.1015ms (afa2e885)
2020-10-21T17:27:13.5150914+03:00 0HM3LPJK8Q5CH:0000000A [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:13.5151813+03:00 0HM3LPJK8Q5CH:0000000A [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:13.5152493+03:00 0HM3LPJK8Q5CH:0000000A [INF] Request finished in 353.1096ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:13.5811631+03:00 0HM3LPJK8Q5CI:0000000C [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290433399 (ca22a1cb)
2020-10-21T17:27:13.5815029+03:00 0HM3LPJK8Q5CI:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.5947094+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.6296702+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.6420592+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.6422471+03:00 0HM3LPJK8Q5CI:0000000C [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:13.6424168+03:00 0HM3LPJK8Q5CI:0000000C [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:13.6424642+03:00 0HM3LPJK8Q5CI:0000000C [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:13.6424973+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:13.6425196+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:13.6425479+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:13.8599082+03:00 0HM3LPJK8Q5CI:0000000C [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:13.8599700+03:00 0HM3LPJK8Q5CI:0000000C [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:13.8599989+03:00 0HM3LPJK8Q5CI:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:13.8735457+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:13.9140790+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.9265225+03:00 0HM3LPJK8Q5CI:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:13.9267128+03:00 0HM3LPJK8Q5CI:0000000C [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:13.9267649+03:00 0HM3LPJK8Q5CI:0000000C [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:13.9268526+03:00 0HM3LPJK8Q5CI:0000000C [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:13.9268988+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.9269292+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.9269709+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:13.9269968+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:13.9270208+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:13.9270726+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:13.9271302+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:13.9271793+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:13.9272398+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:13.9272691+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.9272887+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:13.9273098+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:13.9273358+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:13.9283454+03:00 0HM3LPJK8Q5CI:0000000C [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:13.9283819+03:00 0HM3LPJK8Q5CI:0000000C [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:13.9284022+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:13.9284178+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:13.9284487+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:13.9284699+03:00 0HM3LPJK8Q5CI:0000000C [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:13.9285958+03:00 0HM3LPJK8Q5CI:0000000C [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:13.9287172+03:00 0HM3LPJK8Q5CI:0000000C [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.6564ms (afa2e885)
2020-10-21T17:27:13.9287534+03:00 0HM3LPJK8Q5CI:0000000C [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:13.9288956+03:00 0HM3LPJK8Q5CI:0000000C [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:13.9289677+03:00 0HM3LPJK8Q5CI:0000000C [INF] Request finished in 347.7975ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:13.9993392+03:00 0HM3LPJK8Q5CG:0000000C [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290433814 (ca22a1cb)
2020-10-21T17:27:13.9996360+03:00 0HM3LPJK8Q5CG:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.0126008+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.0498358+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.0622029+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.0623945+03:00 0HM3LPJK8Q5CG:0000000C [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:14.0625674+03:00 0HM3LPJK8Q5CG:0000000C [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:14.0626183+03:00 0HM3LPJK8Q5CG:0000000C [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:14.0626516+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:14.0626749+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:14.1547275+03:00 0HM3LPJK8Q5CH:0000000B [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/log?t=1603290433975 (ca22a1cb)
2020-10-21T17:27:14.1550693+03:00 0HM3LPJK8Q5CH:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.1692155+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.1826926+03:00 0HM3LPJK8Q5CI:0000000D [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72?t=1603290433979 (ca22a1cb)
2020-10-21T17:27:14.1829791+03:00 0HM3LPJK8Q5CI:0000000D [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.1951705+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.2063652+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.2183550+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.2185876+03:00 0HM3LPJK8Q5CH:0000000B [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:14.2187749+03:00 0HM3LPJK8Q5CH:0000000B [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:14.2188477+03:00 0HM3LPJK8Q5CH:0000000B [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/log"' (9406aaa8)
2020-10-21T17:27:14.2189117+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/log"' is valid for the request path '"/api/v1/job/72/log"' (430aaaf2)
2020-10-21T17:27:14.2189543+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:14.2316779+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.2433810+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.2436036+03:00 0HM3LPJK8Q5CI:0000000D [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:14.2437559+03:00 0HM3LPJK8Q5CI:0000000D [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:14.2438239+03:00 0HM3LPJK8Q5CI:0000000D [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72"' (9406aaa8)
2020-10-21T17:27:14.2438737+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}"' is valid for the request path '"/api/v1/job/72"' (430aaaf2)
2020-10-21T17:27:14.2439113+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Request matched endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:14.2815592+03:00 0HM3LPJK8Q5CG:0000000C [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:14.2816338+03:00 0HM3LPJK8Q5CG:0000000C [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:14.2816762+03:00 0HM3LPJK8Q5CG:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.2940704+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.3289824+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.3405680+03:00 0HM3LPJK8Q5CG:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.3408153+03:00 0HM3LPJK8Q5CG:0000000C [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:14.3408667+03:00 0HM3LPJK8Q5CG:0000000C [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:14.3409758+03:00 0HM3LPJK8Q5CG:0000000C [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:14.3410386+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.3411021+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.3411691+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:14.3412143+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.3412658+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.3413432+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:14.3414215+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:14.3414981+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:14.3415802+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:14.3416390+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.3416840+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.3417268+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:14.3417730+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:14.3423427+03:00 0HM3LPJK8Q5CG:0000000C [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:14.3423867+03:00 0HM3LPJK8Q5CG:0000000C [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:14.3424216+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:14.3424566+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:14.3425085+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:14.3425716+03:00 0HM3LPJK8Q5CG:0000000C [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:14.3426743+03:00 0HM3LPJK8Q5CG:0000000C [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:14.3428183+03:00 0HM3LPJK8Q5CG:0000000C [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.4871ms (afa2e885)
2020-10-21T17:27:14.3428708+03:00 0HM3LPJK8Q5CG:0000000C [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:14.3429679+03:00 0HM3LPJK8Q5CG:0000000C [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:14.3430294+03:00 0HM3LPJK8Q5CG:0000000C [INF] Request finished in 343.6709ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:14.4404535+03:00 0HM3LPJK8Q5CH:0000000B [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:14.4405265+03:00 0HM3LPJK8Q5CH:0000000B [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:14.4405680+03:00 0HM3LPJK8Q5CH:0000000B [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.4531654+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.4651073+03:00 0HM3LPJK8Q5CI:0000000D [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:14.4651703+03:00 0HM3LPJK8Q5CI:0000000D [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:14.4652083+03:00 0HM3LPJK8Q5CI:0000000D [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.4784877+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.4891133+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.5013731+03:00 0HM3LPJK8Q5CH:0000000B [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.5015841+03:00 0HM3LPJK8Q5CH:0000000B [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:14.5016239+03:00 0HM3LPJK8Q5CH:0000000B [INF] Executing endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:14.5017252+03:00 0HM3LPJK8Q5CH:0000000B [INF] Route matched with "{action = \"GetLogOutput\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.JobLog GetLogOutput(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:14.5017843+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.5018175+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.5018467+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:14.5018718+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.5018972+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.5019478+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:14.5019904+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:14.5020445+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:14.5020938+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:14.5021198+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.5021418+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.5021614+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:14.5021881+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:14.5027698+03:00 0HM3LPJK8Q5CH:0000000B [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:14.5028088+03:00 0HM3LPJK8Q5CH:0000000B [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:14.5028296+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:14.5028469+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:14.5028758+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:14.5029004+03:00 0HM3LPJK8Q5CH:0000000B [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobLog"'. (8a1b66c8)
2020-10-21T17:27:14.5029829+03:00 0HM3LPJK8Q5CH:0000000B [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:14.5031301+03:00 0HM3LPJK8Q5CH:0000000B [INF] Executed action "UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)" in 1.1882ms (afa2e885)
2020-10-21T17:27:14.5031819+03:00 0HM3LPJK8Q5CH:0000000B [INF] Executed endpoint '"UniversalAutomation.JobController.GetLogOutput (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:14.5032854+03:00 0HM3LPJK8Q5CH:0000000B [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:14.5033618+03:00 0HM3LPJK8Q5CH:0000000B [INF] Request finished in 348.6139ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:14.5150304+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.5266480+03:00 0HM3LPJK8Q5CI:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.5268468+03:00 0HM3LPJK8Q5CI:0000000D [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:14.5268849+03:00 0HM3LPJK8Q5CI:0000000D [INF] Executing endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:14.5269578+03:00 0HM3LPJK8Q5CI:0000000D [INF] Route matched with "{action = \"Get\", controller = \"Job\"}". Executing controller action with signature "UniversalAutomation.Job Get(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:14.5270009+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.5270277+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.5270577+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:14.5270821+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.5271053+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.5271453+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:14.5271836+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:14.5272212+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:14.5272635+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:14.5272903+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.5273097+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.5273308+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:14.5273549+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:14.5280377+03:00 0HM3LPJK8Q5CI:0000000D [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:14.5280723+03:00 0HM3LPJK8Q5CI:0000000D [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:14.5280937+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:14.5281090+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:14.5281376+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:14.5281606+03:00 0HM3LPJK8Q5CI:0000000D [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Job"'. (8a1b66c8)
2020-10-21T17:27:14.5282999+03:00 0HM3LPJK8Q5CI:0000000D [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:14.5284181+03:00 0HM3LPJK8Q5CI:0000000D [INF] Executed action "UniversalAutomation.JobController.Get (UniversalAutomation)" in 1.2746ms (afa2e885)
2020-10-21T17:27:14.5284548+03:00 0HM3LPJK8Q5CI:0000000D [INF] Executed endpoint '"UniversalAutomation.JobController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:14.5285819+03:00 0HM3LPJK8Q5CI:0000000D [DBG] Connection id ""0HM3LPJK8Q5CI"" completed keep alive response. (9784cde9)
2020-10-21T17:27:14.5286382+03:00 0HM3LPJK8Q5CI:0000000D [INF] Request finished in 345.9309ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:14.5848627+03:00 0HM3LPJK8Q5CG:0000000D [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/script/1?t=1603290434408 (ca22a1cb)
2020-10-21T17:27:14.5851569+03:00 0HM3LPJK8Q5CG:0000000D [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.5982069+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.6377125+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.6492609+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.6494490+03:00 0HM3LPJK8Q5CG:0000000D [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:14.6496177+03:00 0HM3LPJK8Q5CG:0000000D [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:14.6496641+03:00 0HM3LPJK8Q5CG:0000000D [DBG] 2 candidate(s) found for the request path '"/api/v1/script/1"' (9406aaa8)
2020-10-21T17:27:14.6496967+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{id:long}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:14.6497176+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' with route pattern '"api/v1/script/{name}"' is valid for the request path '"/api/v1/script/1"' (430aaaf2)
2020-10-21T17:27:14.6497465+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Request matched endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:14.8667299+03:00 0HM3LPJK8Q5CG:0000000D [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:14.8668038+03:00 0HM3LPJK8Q5CG:0000000D [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:14.8668285+03:00 0HM3LPJK8Q5CG:0000000D [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:14.8807750+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:14.9174179+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.9290642+03:00 0HM3LPJK8Q5CG:0000000D [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:14.9292598+03:00 0HM3LPJK8Q5CG:0000000D [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:14.9293009+03:00 0HM3LPJK8Q5CG:0000000D [INF] Executing endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:14.9293819+03:00 0HM3LPJK8Q5CG:0000000D [INF] Route matched with "{action = \"Get\", controller = \"Script\"}". Executing controller action with signature "UniversalAutomation.Script Get(Int64)" on controller "UniversalAutomation.ScriptController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:14.9294299+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.9294589+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.9294997+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:14.9295232+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:14.9295486+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:14.9295931+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Executing controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:14.9296488+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Executed controller factory for controller "UniversalAutomation.ScriptController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:14.9297006+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:14.9297597+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:14.9298055+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.9298457+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:14.9298762+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:14.9299018+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:14.9309170+03:00 0HM3LPJK8Q5CG:0000000D [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:14.9309539+03:00 0HM3LPJK8Q5CG:0000000D [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:14.9309741+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:14.9309896+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:14.9310202+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:14.9310410+03:00 0HM3LPJK8Q5CG:0000000D [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.Script"'. (8a1b66c8)
2020-10-21T17:27:14.9311715+03:00 0HM3LPJK8Q5CG:0000000D [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:14.9313120+03:00 0HM3LPJK8Q5CG:0000000D [INF] Executed action "UniversalAutomation.ScriptController.Get (UniversalAutomation)" in 1.7171ms (afa2e885)
2020-10-21T17:27:14.9313616+03:00 0HM3LPJK8Q5CG:0000000D [INF] Executed endpoint '"UniversalAutomation.ScriptController.Get (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:14.9314823+03:00 0HM3LPJK8Q5CG:0000000D [DBG] Connection id ""0HM3LPJK8Q5CG"" completed keep alive response. (9784cde9)
2020-10-21T17:27:14.9315538+03:00 0HM3LPJK8Q5CG:0000000D [INF] Request finished in 346.6588ms 200 application/json; charset=utf-8 (791a596a)
2020-10-21T17:27:14.9948990+03:00 0HM3LPJK8Q5CH:0000000C [INF] Request starting HTTP/1.1 GET http://apptest.com/api/v1/job/72/parameter?t=1603290434814 (ca22a1cb)
2020-10-21T17:27:14.9952726+03:00 0HM3LPJK8Q5CH:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:15.0090364+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:15.0448053+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:15.0566675+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:15.0568775+03:00 0HM3LPJK8Q5CH:0000000C [DBG] The request is insecure. Skipping HSTS header. (6697811d)
2020-10-21T17:27:15.0570455+03:00 0HM3LPJK8Q5CH:0000000C [DBG] The request path "" does not match the path filter (c4ce145c)
2020-10-21T17:27:15.0570980+03:00 0HM3LPJK8Q5CH:0000000C [DBG] 1 candidate(s) found for the request path '"/api/v1/job/72/parameter"' (9406aaa8)
2020-10-21T17:27:15.0571317+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' with route pattern '"api/v1/job/{id:long}/parameter"' is valid for the request path '"/api/v1/job/72/parameter"' (430aaaf2)
2020-10-21T17:27:15.0571530+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Request matched endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (cbf60c4b)
2020-10-21T17:27:15.2753582+03:00 0HM3LPJK8Q5CH:0000000C [DBG] AuthenticationScheme: "Cookies" was not authenticated. (1152f827)
2020-10-21T17:27:15.2754323+03:00 0HM3LPJK8Q5CH:0000000C [DBG] AuthenticationScheme: "Bearer" was not authenticated. (1152f827)
2020-10-21T17:27:15.2754613+03:00 0HM3LPJK8Q5CH:0000000C [INF] Evaluting claims for AUTO\uib70046 (1b1cbb90)
2020-10-21T17:27:15.2892245+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Administrator (657339cf)
2020-10-21T17:27:15.3250349+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:15.3371351+03:00 0HM3LPJK8Q5CH:0000000C [INF] AUTO\uib70046 is part of role Execute (ef3a9fdc)
2020-10-21T17:27:15.3373438+03:00 0HM3LPJK8Q5CH:0000000C [INF] Authorization was successful. (0d575a54)
2020-10-21T17:27:15.3373901+03:00 0HM3LPJK8Q5CH:0000000C [INF] Executing endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (500cc934)
2020-10-21T17:27:15.3374799+03:00 0HM3LPJK8Q5CH:0000000C [INF] Route matched with "{action = \"GetParameters\", controller = \"Job\"}". Executing controller action with signature "System.Collections.Generic.IEnumerable`1[UniversalAutomation.JobParameter] GetParameters(Int64)" on controller "UniversalAutomation.JobController" ("UniversalAutomation"). (122b2fdf)
2020-10-21T17:27:15.3375335+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Execution plan of "authorization" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:15.3375643+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Execution plan of "resource" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:15.3375969+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Execution plan of "action" filters (in the following order): ["Microsoft.AspNetCore.Mvc.Filters.ControllerActionFilter (Order: -2147483648)", "Microsoft.AspNetCore.Mvc.ModelBinding.UnsupportedContentTypeFilter (Order: -3000)"] (6a7aea5c)
2020-10-21T17:27:15.3376207+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Execution plan of "exception" filters (in the following order): ["None"] (6a7aea5c)
2020-10-21T17:27:15.3376472+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Execution plan of "result" filters (in the following order): ["Microsoft.AspNetCore.Mvc.ViewFeatures.Filters.SaveTempDataFilter"] (6a7aea5c)
2020-10-21T17:27:15.3377014+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Executing controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (9650b6ae)
2020-10-21T17:27:15.3377495+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Executed controller factory for controller "UniversalAutomation.JobController" ("UniversalAutomation") (65418032)
2020-10-21T17:27:15.3378051+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' ... (0448c17b)
2020-10-21T17:27:15.3378814+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Attempting to bind parameter '"id"' of type '"System.Int64"' using the name '"id"' in request data ... (1d38b825)
2020-10-21T17:27:15.3379103+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:15.3379337+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Done attempting to bind parameter '"id"' of type '"System.Int64"'. (90fee3af)
2020-10-21T17:27:15.3379556+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Attempting to validate the bound parameter '"id"' of type '"System.Int64"' ... (ce60666b)
2020-10-21T17:27:15.3379811+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Done attempting to validate the bound parameter '"id"' of type '"System.Int64"'. (5d5b0261)
2020-10-21T17:27:15.3385512+03:00 0HM3LPJK8Q5CH:0000000C [DBG] List of registered output formatters, in the following order: ["Microsoft.AspNetCore.Mvc.Formatters.HttpNoContentOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StringOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.StreamOutputFormatter", "Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"] (17cbef5a)
2020-10-21T17:27:15.3385965+03:00 0HM3LPJK8Q5CH:0000000C [DBG] No information found on request to perform content negotiation. (6aec0ec5)
2020-10-21T17:27:15.3386156+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Attempting to select an output formatter without using a content type as no explicit content types were specified for the response. (ded1a4c8)
2020-10-21T17:27:15.3386337+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Attempting to select the first formatter in the output formatters list which can write the result. (5fc928a5)
2020-10-21T17:27:15.3386675+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Selected output formatter '"Microsoft.AspNetCore.Mvc.Formatters.NewtonsoftJsonOutputFormatter"' and content type '"application/json"' to write the response. (fcc32779)
2020-10-21T17:27:15.3387018+03:00 0HM3LPJK8Q5CH:0000000C [INF] Executing ObjectResult, writing value of type '"UniversalAutomation.JobParameter[]"'. (8a1b66c8)
2020-10-21T17:27:15.3387949+03:00 0HM3LPJK8Q5CH:0000000C [DBG] The response will be compressed with '"gzip"'. (468e3546)
2020-10-21T17:27:15.3389241+03:00 0HM3LPJK8Q5CH:0000000C [INF] Executed action "UniversalAutomation.JobController.GetParameters (UniversalAutomation)" in 1.2359ms (afa2e885)
2020-10-21T17:27:15.3389625+03:00 0HM3LPJK8Q5CH:0000000C [INF] Executed endpoint '"UniversalAutomation.JobController.GetParameters (UniversalAutomation)"' (99874f2b)
2020-10-21T17:27:15.3390699+03:00 0HM3LPJK8Q5CH:0000000C [DBG] Connection id ""0HM3LPJK8Q5CH"" completed keep alive response. (9784cde9)
2020-10-21T17:27:15.3391246+03:00 0HM3LPJK8Q5CH:0000000C [INF] Request finished in 344.2361ms 200 application/json; charset=utf-8 (791a596a)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment