Heya, I once reported an issue that our Cloud Script calls sometimes take 6+ seconds when they usually only take 1 second. I didn't have an example back then. But now it once happened and I want to share the data for further investigations. The title was queried with Cloud Scripts before, so it was definitely loaded on the PlayFab Servers.
Title ID: D73D
Here's the exceeding limits data:
{ "EventName": "title_exceeded_limit", "LimitId": "CloudScript:ScriptExecutionTime", "LimitDisplayName": "Processing time for a CloudScript function called by the ExecuteCloudScript API.", "Unit": "Seconds", "LimitValue": 5, "Value": 6.7623138, "AssociatedEntities": { "player": [ "A447F9DAE211F33C" ] }, "Details": { "Function": "ReportMatchBegin" }, "EventNamespace": "com.playfab", "EntityType": "title", "Source": "PlayFab", "EventId": "3c552a7ec68b448cb7e421cbb2840ac6", "EntityId": "D73D", "SourceType": "BackEnd", "Timestamp": "2017-05-30T23:19:35.6742706Z", "History": null, "CustomTags": null, "Reserved": null }
And here the actual call data:
p.p1 {margin: 0.0px 0.0px 0.0px 0.0px; font: 12.0px 'Helvetica Neue'; color: #454545} { "EventName": "player_executed_cloudscript", "Source": "CloudScript", "FunctionName": "ReportMatchBegin", "CloudScriptExecutionResult": { "FunctionName": "ReportMatchBegin", "Revision": 1328, "FunctionResult": true, "FunctionResultTooLarge": null, "Logs": [ { "Level": "Debug", "Message": "NewEntryKey: ADBEDA889CBCAC97#1081635934", "Data": null }, { "Level": "Debug", "Message": "Local Entry:{\"State\":\"Open\",\"OpntID\":\"ADBEDA889CBCAC97\",\"LclPlyrID\":\"A447F9DAE211F33C\",\"LclPlyrDN\":\"Player1496140\",\"OpntDN\":\"Player1496164\",\"OpntMMR\":479,\"LPlyrMMR\":633,\"LPlyrMMRRange\":250,\"MStrtPhTme\":1081635934,\"CDateInS\":1496186368,\"GameValHsh\":655795716,\"MatchType\":\"VsPlayer\",\"BMinRyCHash\":3471906759,\"MinCVer\":73,\"CDateStr\":\"Tue, 30 May 2017 23:19:28 GMT\"}", "Data": null }, { "Level": "Debug", "Message": "MaintenancePerform: EvaluateOpen, Counter:3", "Data": null }, { "Level": "Debug", "Message": "EvaluateOpenMatchesModifyDataOnly", "Data": null }, { "Level": "Debug", "Message": "EvaluateOpenMatches: This piece of data is not old enough yet:ADBEDA889CBCAC97#1081635934 ageInSeconds: 7", "Data": null } ], "LogsTooLarge": null, "ExecutionTimeSeconds": 6.762313799999999, "ProcessorTimeSeconds": 0.016, "MemoryConsumedBytes": 4294856224, "APIRequestsIssued": 15, "HttpRequestsIssued": 0, "Error": null }, "EventNamespace": "com.playfab", "EntityType": "player", "TitleId": "D73D", "EventId": "9f21ba85b99f498dab6b043dd2eb1a47", "EntityId": "A447F9DAE211F33C", "SourceType": "BackEnd", "Timestamp": "2017-05-30T23:19:35.6872924Z", "History": null, "CustomTags": null, "Reserved": null }
I hope this helps finding the issue, or at least discovering what mistake we might have made.