Misreports in Modmanager.log

[panpantom]

Noticing some odd misreporting in the modmanager.log file. Nearly always if two kicks are reported at the same time (for idle, neg score, TK or ping) , then the player nick from the first kick shows up again in the message on the second kick.
Not sure if this is aesthetic or something deeper so just letting you know.

--ppt.

[K]

Interesting can u post a log snipet with this in please.

[panpantom]

Examples from todays log. Theres something odd going on here. The problem doesn't happen everytime but when it does you can see a message pairing and the 'twinned' message always has a ten second separation and the player featured in the second of the kicks was not on the server at the time (according to my cross-checking the punkbuster logs). The punkbuster log shows that the first message each time corresponds with the pb kick, the second message is somehow a ghost message aimed at a ghost player.

Example 1. megaspeed has one too many punishes and results in a neg score kick. But ten seconds later another player is kicked but the message is from the previous negscore kick. The player MOLDO was never on the server.
[2006-02-22 09:04:00] Info: TKPUNISH: LlagavullinDrinker punishes meg@speed for a teamkill (LlagavullinDrinker has 1 punishes and 2 forgives)
[2006-02-22 09:04:25] Info: Kicked 'meg@speed'[60356637] => 'Sorry 'meg@speed' you are being kicked (negative score)'
[2006-02-22 09:04:35] Info: Kicked '(AUT) MOLDO'[46981288] => 'Sorry 'meg@speed' you are being kicked (negative score)'

Example 2. Two players correctly kicked for idle. The punkbuster log confirms these disconnections actually happened. 20 second separation.
[2006-02-22 10:22:23] Info: Kicked 'Sillentkiller(Dutch)'[44408635] => 'Sorry 'Sillentkiller(Dutch)' you are being kicked (idler)'
[2006-02-22 10:22:43] Info: Kicked 'Dahlqvist'[59612727] => 'Sorry 'Dahlqvist' you are being kicked (idler)'

Example 3. Here a player is kicked for idling but then after 10 seconds another message emerges. Note that Dorfklause was never on the server.
[2006-02-22 11:04:47] Info: Kicked 'rus xXxKROTxXx'[43605087] => 'Sorry 'rus xXxKROTxXx' you are being kicked (idler)'
[2006-02-22 11:04:57] Info: Kicked '[SDiv] Dorfklause'[44869229] => 'Sorry 'rus xXxKROTxXx' you are being kicked (idler)'

Example 4. again. note that Snake****81 was never on the server.
[2006-02-22 11:13:38] Info: Kicked 'LorD <xa>'[45288547] => 'Sorry 'LorD <xa>' you are being kicked (idler)'
[2006-02-22 11:13:48] Info: Kicked 'Snake****81'[44009243] => 'Sorry 'LorD <xa>' you are being kicked (idler)'

Example 5. again. note that Wirri actually left the server at 11:16:32
[2006-02-22 12:26:04] Info: Kicked '[FR] Spyke69'[48447182] => 'Sorry '[FR] Spyke69' you are being kicked (idler)'
[2006-02-22 12:26:14] Info: Kicked 'Wirri'[43867518] => 'Sorry '[FR] Spyke69' you are being kicked (idler)'

Example 6. This block of four shows the problem in the second line with a ten second gap but line 3 and 4 is perfectly ok. Note that player Berserker was on the server and lost connection at 12:42:12 which does not match the time in the logfile.
[2006-02-22 12:37:14] Info: Kicked 'NERO IMP.CAES.AVG.'[61955539] => 'Sorry 'NERO IMP.CAES.AVG.' you are being kicked (idler)'
[2006-02-22 12:37:24] Info: Kicked '-=[R]=-Berserker'[38990417] => 'Sorry 'NERO IMP.CAES.AVG.' you are being kicked (idler)'
[2006-02-22 12:37:44] Info: Kicked 'Micky KaiTomGa'[58144156] => 'Sorry 'Micky KaiTomGa' you are being kicked (idler)'
[2006-02-22 12:40:34] Info: Kicked 'orTix orTix'[65810282] => 'Sorry 'orTix orTix' you are being kicked (idler)'

Example 7. A consecutive pair but this time no problem (and not a 10 second separation)
[2006-02-22 13:05:35] Info: Kicked 'suomiTAPPAJA'[43650161] => 'Sorry 'suomiTAPPAJA' you are being kicked (idler)'
[2006-02-22 13:06:05] Info: Kicked 'BLITZ* shaymaca'[48682589] => 'Sorry 'BLITZ* shaymaca' you are being kicked (idler)'

Example 8. A pair for high ping not idling. But! a 10 second delay and a twin message. note that player evilterintubby was never on the server.
[2006-02-22 13:07:35] Info: Kicked 'AEK_FC Katafraktos'[44629558] => 'Sorry 'AEK_FC Katafraktos' you are being kicked (ping too high)'
[2006-02-22 13:07:45] Info: Kicked 'evilteringtubby'[47541316] => 'Sorry 'AEK_FC Katafraktos' you are being kicked (ping too high)'

[K]

Ah yes, it is actuallying kicking two people. The problem is down to the fact your kickDelay is greater than your sampleRate hence you can queue two kicks for the same playerid before they are actually kicked.

If this happens and someone joins and gets put in the same player slot they will then get kicked for the previous players offences.

I'm currently testing a version which will prevent this.

[panpantom]

OK thanks in the meantime today I've made the sample rate 20 and the delay 15.