Speed Issue

[fiendy]

Hi,
I know there was a post a while back about Uaseco slowing down - was this issue ever resolved? Only my server has started experiencing this over the past few weeks, & seems to be getting worse especially this week.
Screen updates start to get slower, so much so that that the "Good Luck Have Fun" message appears more than a minute after a change of map.
A restart of Uaseco will solve problem for a while.
As an example, I was playing for around 1hour this evening with ~8 players when it started to slow up quite bad. I restarted and the speed issues disappeared (even when player count doubled to 16, so don't think it's related to number of players).

My (Linux) server at the time was pretty much idle-memory was fine, barely any CPU usage/disk IO, or network traffic, although was a spike in network packets, but speed of network link was fine. This was end of log before I restarted:-

Code: Select all

[UASECO Exception] Error returned: "No new replay." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(9) "jensvloon"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [jensvloon]: skipped [0:12.038]
[UASECO Exception] Error returned: "No new replay." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(5) "yalex"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [yalex]: skipped [0:12.127]
[UASECO Exception] Error returned: "No new replay." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(8) "mrnugget"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [mrnugget]: skipped [0:12.373]
[UASECO Exception] Error returned: "No new replay." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(9) "jellyclaw"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [jellyclaw]: skipped [0:13.178]
[UASECO Exception] Error returned: "Could not find player score." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(6) "venzys"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [venzys]: skipped [0:20.242]
[UASECO Exception] Error returned: "No new replay." [-1000] at GbxRemote::query() for method "GetValidationReplay" with arguments:
array(1) {
  [0]=>
  string(8) "grdlorie"
}

[2017-08-08 22:19:54] [Dedimania] Unable to get validation replay for Player [grdlorie]: skipped [0:21.542]
[2017-08-08 22:19:54] [RaspJukebox] Setting next map to [bcs| fun dirt #1] as requested by [bcs|fѥภdץ]
[2017-08-08 22:19:55] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:55] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:55] [Event] Begin Podium
[2017-08-08 22:19:55] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:55] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:55] [Event] End Podium
[2017-08-08 22:19:55] [Event] Begin Channel Progression
[2017-08-08 22:19:55] [Event] End Channel Progression
[2017-08-08 22:19:55] [Event] Unloading Map
[2017-08-08 22:19:55] [PlayerList] Calculating and updating server ranks for players...
[2017-08-08 22:19:56] [PlayerList] ...finished!
[2017-08-08 22:19:57] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:57] [Event] End Match [518]
[2017-08-08 22:19:57] [Event] Begin Match [519]
[2017-08-08 22:19:57] [Event] Player Ranking Updated (Players)
[2017-08-08 22:19:58] [Map] Changing from Map [ÐĘЯЯ@ Ay Ke SeNsiyA! 17.2.16] to [ÐĘЯЯ@  KoRtA 19-7-17] [Env: Stadium, Uid: ipxxp7qPlynKGAjHuwcKZShJ5_8, Id: 4378]
[2017-08-08 22:19:58] [Event] Loading Map
[2017-08-08 22:19:58] [LocalRecords] Current record on Map [ÐĘЯЯ@  KoRtA 19-7-17] is [0:15.605] and held by Player [jeanbof]
[2017-08-08 22:20:00] [Event] Begin Map
[2017-08-08 22:20:01] synced
[2017-08-08 22:20:16] [Event] Begin Round [1]
[2017-08-08 22:20:16] [Event] Begin Turn [1]
[2017-08-08 22:20:16] [Event] Begin Playing [1]
[2017-08-08 22:21:02] [Event] Player Ranking Updated (Players)
[2017-08-08 22:21:12] [LocalRecords] Player [jellyclaw] finished with [0:17.750] and took the 9. Local Record!
[2017-08-08 22:21:16] [LocalRecords] Player [mrnugget] finished with [0:18.185] and took the 10. Local Record!
[2017-08-08 22:21:37] [LocalRecords] Player [mrnugget] finished with [0:17.141] and took the 9. Local Record!
[2017-08-08 22:21:51] [Webaccess] (dedimania.net:8082/Dedimania.8111): Request timeout, in _receive (63 > 40s)
[2017-08-08 22:21:51] [Webaccess] (dedimania.net:8082/Dedimania.8111): [OPENED,RECEIVE]: -1.000 / 0.000 / -1.000 (0.000) / 239 [727,0,0]
XmlrpcDB->_callCB() - no response message:
a:4:{s:3:"Url";s:35:"http://dedimania.net:8082/Dedimania";s:8:"Requests";a:2:{i:0;a:2:{s:10:"methodName";s:26:"dedimania.PlayerDisconnect";s:6:"params";a:3:{i:0;s:21:"s2313:1501885801.3229";i:1;s:6:"venzys";i:2;s:0:"";}}i:1;a:2:{s:10:"methodName";s:24:"dedimania.WarningsAndTTR";s:6:"params";a:0:{}}}s:9:"Callbacks";a:2:{i:0;N;i:1;N;}s:8:"Response";s:0:"";}
[2017-08-08 22:21:52] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:05] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:11] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:14] [LocalRecords] Player [jensvloon] finished with [0:16.147] and took the 6. Local Record!
[2017-08-08 22:22:16] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:28] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:30] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:41] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:49] [Event] Player Ranking Updated (Players)
[2017-08-08 22:22:57] [LocalRecords] Player [mrnugget] finished with [0:16.561] and took the 10. Local Record!
[2017-08-08 22:23:01] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:11] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:11] [LocalRecords] Player [jellyclaw] finished with [0:17.318] and took the 11. Local Record!
[2017-08-08 22:23:15] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:20] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:31] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:33] [LocalRecords] Player [jellyclaw] finished with [0:16.838] and took the 11. Local Record!
[2017-08-08 22:23:35] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:46] [LocalRecords] Player [mrnugget] finished with [0:16.258] and took the 9. Local Record!
[2017-08-08 22:23:46] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:50] [LocalRecords] Player [jellyclaw] finished with [0:16.735] and took the 11. Local Record!
[2017-08-08 22:23:54] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:55] [LocalRecords] Player [chrisscatt] finished with [0:16.148] and took the 7. Local Record!
[2017-08-08 22:23:58] [Event] Player Ranking Updated (Players)
[2017-08-08 22:23:58] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:02] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:06] [LocalRecords] Player [mrnugget] finished with [0:16.205] and took the 9. Local Record!
[2017-08-08 22:24:13] [LocalRecords] Player [jensvloon] finished with [0:15.992] and took the 6. Local Record!
[2017-08-08 22:24:17] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:28] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:30] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:38] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:44] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:45] [Event] Player Ranking Updated (Players)
[2017-08-08 22:24:57] [Event] Player Ranking Updated (Players)

Using latest released version 0.9.5 & latest (04/08/17) Dedicated Server.

[speedychris]

We have this Performance Problems too, no fix in sight.

[undef.de]

I guess I told it somewhere in the other threads related to this problem that I need more information: Please enable in config/UASECO.xml the <developer_options><debug> and upload the complete logfile somewhere.

[speedychris]

Already done on 21.7.2017 with wetransfer, send a pm at this time too.

[undef.de]

Already done on 21.7.2017 with wetransfer, send a pm at this time too.

I know, but I still need more input.

[hackie]

[fiendy]

I've enabled debug mode now so will post log next time I see it go slow.

[speedychris]

Send PM and Log.

[fiendy]

I've also not forgot this, just not had much chance to play since I enabled debug so not seen issue happen yet...

[speedychris]

One note: we have gone back from php7 to php5 and the Speed is mostly better. but it seems to be affected with dedimania too.