IW4M-Admin/Application/Server.cs

1004 lines
39 KiB
C#
Raw Normal View History

using System;
2015-03-08 17:20:10 -04:00
using System.Collections.Generic;
using System.Threading;
2015-03-08 17:20:10 -04:00
using System.IO;
using System.Linq;
using System.Threading.Tasks;
using System.Text.RegularExpressions;
2018-04-08 02:44:42 -04:00
using SharedLibraryCore;
using SharedLibraryCore.Interfaces;
using SharedLibraryCore.Objects;
using SharedLibraryCore.Database.Models;
using SharedLibraryCore.Dtos;
using SharedLibraryCore.Configuration;
2015-03-08 17:20:10 -04:00
using IW4MAdmin.Application.Misc;
using Application.RconParsers;
using Application.EventParsers;
2018-04-14 00:51:38 -04:00
using SharedLibraryCore.Exceptions;
2015-03-08 17:20:10 -04:00
namespace IW4MAdmin
{
public class IW4MServer : Server
2015-03-08 17:20:10 -04:00
{
private CancellationToken cts;
public IW4MServer(IManager mgr, ServerConfiguration cfg) : base(mgr, cfg) { }
public override int GetHashCode()
{
// todo: make this better with collisions
int id = Math.Abs($"{IP}:{Port.ToString()}".Select(a => (int)a).Sum());
// this is a nasty fix for get hashcode being changed
2018-04-14 00:51:38 -04:00
switch (id)
{
case 765:
return 886229536;
case 760:
return 1645744423;
case 761:
return 1645809959;
}
return id;
}
override public async Task<bool> AddPlayer(Player polledPlayer)
2015-03-08 17:20:10 -04:00
{
if (polledPlayer.Ping == 999 || polledPlayer.Ping < 1 || polledPlayer.ClientNumber > (MaxClients) || polledPlayer.ClientNumber < 0)
{
//Logger.WriteDebug($"Skipping client not in connected state {P}");
return true;
}
if (Players[polledPlayer.ClientNumber] != null &&
Players[polledPlayer.ClientNumber].NetworkId == polledPlayer.NetworkId)
{
// update their ping & score
Players[polledPlayer.ClientNumber].Ping = polledPlayer.Ping;
Players[polledPlayer.ClientNumber].Score = polledPlayer.Score;
return true;
}
#if !DEBUG
if (polledPlayer.Name.Length < 3)
2017-11-13 16:58:23 -05:00
{
Logger.WriteDebug($"Kicking {polledPlayer} because their name is too short");
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, polledPlayer.ClientNumber, "Your name must contain atleast 3 characters.");
await this.ExecuteCommandAsync(formattedKick);
2017-11-13 16:58:23 -05:00
return false;
}
if (Players.FirstOrDefault(p => p != null && p.Name == polledPlayer.Name) != null)
{
Logger.WriteDebug($"Kicking {polledPlayer} because their name is already in use");
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, polledPlayer.ClientNumber, "Your name is being used by someone else.");
await this.ExecuteCommandAsync(formattedKick);
return false;
}
if (polledPlayer.Name == "Unknown Soldier" ||
2018-03-09 03:01:12 -05:00
polledPlayer.Name == "UnknownSoldier" ||
polledPlayer.Name == "CHEATER")
{
Logger.WriteDebug($"Kicking {polledPlayer} because their name is generic");
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, polledPlayer.ClientNumber, "Please change your name using /name.");
await this.ExecuteCommandAsync(formattedKick);
return false;
}
if (polledPlayer.Name.Where(c => Char.IsControl(c)).Count() > 0)
{
Logger.WriteDebug($"Kicking {polledPlayer} because their contains control characters");
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, polledPlayer.ClientNumber, "Your name cannot contain control characters.");
await this.ExecuteCommandAsync(formattedKick);
return false;
}
#endif
Logger.WriteDebug($"Client slot #{polledPlayer.ClientNumber} now reserved");
2015-03-08 17:20:10 -04:00
try
{
Player player = null;
2017-11-29 19:35:50 -05:00
var client = await Manager.GetClientService().GetUnique(polledPlayer.NetworkId);
2015-03-08 17:20:10 -04:00
// first time client is connecting to server
if (client == null)
{
Logger.WriteDebug($"Client {polledPlayer} first time connecting");
player = (await Manager.GetClientService().Create(polledPlayer)).AsPlayer();
}
// client has connected in the past
else
2015-03-08 17:20:10 -04:00
{
client.LastConnection = DateTime.UtcNow;
client.Connections += 1;
var existingAlias = client.AliasLink.Children
.FirstOrDefault(a => a.Name == polledPlayer.Name && a.IPAddress == polledPlayer.IPAddress);
if (existingAlias == null)
{
Logger.WriteDebug($"Client {polledPlayer} has connected previously under a different ip/name");
client.CurrentAlias = new EFAlias()
{
2017-11-29 19:35:50 -05:00
IPAddress = polledPlayer.IPAddress,
Name = polledPlayer.Name,
2017-11-29 19:35:50 -05:00
};
// we need to update their new ip and name to the virtual property
client.Name = polledPlayer.Name;
client.IPAddress = polledPlayer.IPAddress;
2017-11-29 19:35:50 -05:00
await Manager.GetClientService().Update(client);
}
2018-03-06 02:22:19 -05:00
else if (existingAlias.Name == polledPlayer.Name)
{
client.CurrentAlias = existingAlias;
client.CurrentAliasId = existingAlias.AliasId;
await Manager.GetClientService().Update(client);
}
player = client.AsPlayer();
}
// Do the player specific stuff
2017-11-29 19:35:50 -05:00
player.ClientNumber = polledPlayer.ClientNumber;
player.Score = polledPlayer.Score;
player.CurrentServer = this;
2017-11-29 19:35:50 -05:00
Players[player.ClientNumber] = player;
var activePenalties = await Manager.GetPenaltyService().GetActivePenaltiesAsync(player.AliasLinkId, player.IPAddress);
2018-02-15 23:01:28 -05:00
var currentBan = activePenalties.FirstOrDefault(b => b.Expires > DateTime.UtcNow);
2018-02-15 23:01:28 -05:00
if (currentBan != null)
{
Logger.WriteInfo($"Banned client {player} trying to connect...");
var autoKickClient = (await Manager.GetClientService().Get(1)).AsPlayer();
autoKickClient.CurrentServer = this;
2018-02-15 23:01:28 -05:00
if (currentBan.Type == Penalty.PenaltyType.TempBan)
{
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, polledPlayer.ClientNumber, $"You are temporarily banned. ({(currentBan.Expires - DateTime.UtcNow).TimeSpanText()} left)");
await this.ExecuteCommandAsync(formattedKick);
}
else
2018-02-15 23:01:28 -05:00
await player.Kick($"Previously banned for {currentBan.Offense}", autoKickClient);
2018-02-15 23:01:28 -05:00
if (player.Level != Player.Permission.Banned && currentBan.Type == Penalty.PenaltyType.Ban)
await player.Ban($"Previously banned for {currentBan.Offense}", autoKickClient);
return true;
}
Logger.WriteInfo($"Client {player} connecting...");
await ExecuteEvent(new GameEvent(GameEvent.EventType.Connect, "", player, null, this));
2018-03-09 03:01:12 -05:00
if (!Manager.GetApplicationSettings().Configuration().EnableClientVPNs &&
await VPNCheck.UsingVPN(player.IPAddressString, Manager.GetApplicationSettings().Configuration().IPHubAPIKey))
2018-03-09 03:01:12 -05:00
{
await player.Kick("VPNs are not allowed on this server", new Player() { ClientId = 1 });
}
2015-03-08 17:20:10 -04:00
return true;
}
2017-05-28 21:54:46 -04:00
2015-03-08 17:20:10 -04:00
catch (Exception E)
{
Manager.GetLogger().WriteError($"Unable to add player {polledPlayer.Name}::{polledPlayer.NetworkId}");
2017-05-28 21:54:46 -04:00
Manager.GetLogger().WriteDebug(E.StackTrace);
2015-03-08 17:20:10 -04:00
return false;
}
}
//Remove player by CLIENT NUMBER
override public async Task RemovePlayer(int cNum)
2015-03-08 17:20:10 -04:00
{
2017-11-29 19:35:50 -05:00
if (cNum >= 0 && Players[cNum] != null)
2015-03-16 16:40:30 -04:00
{
Player Leaving = Players[cNum];
2018-03-06 02:22:19 -05:00
Logger.WriteInfo($"Client {Leaving} disconnecting...");
await ExecuteEvent(new GameEvent(GameEvent.EventType.Disconnect, "", Leaving, null, this));
2018-03-06 02:22:19 -05:00
Leaving.TotalConnectionTime += (int)(DateTime.UtcNow - Leaving.ConnectionTime).TotalSeconds;
Leaving.LastConnection = DateTime.UtcNow;
await Manager.GetClientService().Update(Leaving);
Players[cNum] = null;
2015-03-16 16:40:30 -04:00
}
2015-03-08 17:20:10 -04:00
}
//Process requested command correlating to an event
// todo: this needs to be removed out of here
override public async Task<Command> ValidateCommand(GameEvent E)
2015-03-08 17:20:10 -04:00
{
string CommandString = E.Data.Substring(1, E.Data.Length - 1).Split(' ')[0];
E.Message = E.Data;
Command C = null;
foreach (Command cmd in Manager.GetCommands())
{
if (cmd.Name == CommandString.ToLower() || cmd.Alias == CommandString.ToLower())
C = cmd;
}
if (C == null)
{
await E.Origin.Tell("You entered an unknown command");
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} entered unknown command \"{CommandString}\"");
}
E.Data = E.Data.RemoveWords(1);
String[] Args = E.Data.Trim().Split(new char[] { ' ' }, StringSplitOptions.RemoveEmptyEntries);
if (E.Origin.Level < C.Permission)
2015-03-08 17:20:10 -04:00
{
2018-03-09 03:01:12 -05:00
await E.Origin.Tell("You do not have access to that command");
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} does not have access to \"{C.Name}\"");
2015-03-08 17:20:10 -04:00
}
if (Args.Length < (C.RequiredArgumentCount))
2015-03-08 17:20:10 -04:00
{
2018-03-09 03:01:12 -05:00
await E.Origin.Tell($"Not enough arguments supplied");
await E.Origin.Tell(C.Syntax);
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} did not supply enough arguments for \"{C.Name}\"");
2015-03-08 17:20:10 -04:00
}
if (C.RequiresTarget || Args.Length > 0)
2015-03-08 17:20:10 -04:00
{
int cNum = -1;
try
{
cNum = Convert.ToInt32(Args[0]);
}
2018-02-15 23:01:28 -05:00
catch (FormatException)
{
}
2015-03-08 17:20:10 -04:00
2015-03-16 16:40:30 -04:00
if (Args[0][0] == '@') // user specifying target by database ID
2015-03-08 17:20:10 -04:00
{
int dbID = -1;
int.TryParse(Args[0].Substring(1, Args[0].Length - 1), out dbID);
var found = await Manager.GetClientService().Get(dbID);
2015-03-08 17:20:10 -04:00
if (found != null)
2015-03-16 16:40:30 -04:00
{
E.Target = found.AsPlayer();
E.Target.CurrentServer = this as IW4MServer;
E.Owner = this as IW4MServer;
2017-11-29 19:35:50 -05:00
E.Data = String.Join(" ", Args.Skip(1));
2015-03-16 16:40:30 -04:00
}
2015-03-08 17:20:10 -04:00
}
else if (Args[0].Length < 3 && cNum > -1 && cNum < MaxClients) // user specifying target by client num
2015-03-08 17:20:10 -04:00
{
if (Players[cNum] != null)
{
E.Target = Players[cNum];
E.Data = String.Join(" ", Args.Skip(1));
}
2015-03-08 17:20:10 -04:00
}
List<Player> matchingPlayers;
if (E.Target == null) // Find active player including quotes (multiple words)
{
matchingPlayers = GetClientByName(E.Data.Trim());
if (matchingPlayers.Count > 1)
{
await E.Origin.Tell("Multiple players match that name");
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} had multiple players found for {C.Name}");
}
else if (matchingPlayers.Count == 1)
{
E.Target = matchingPlayers.First();
string escapedName = Regex.Escape(E.Target.Name);
var reg = new Regex($"(\"{escapedName}\")|({escapedName})", RegexOptions.IgnoreCase);
E.Data = reg.Replace(E.Data, "", 1).Trim();
if (E.Data.Length == 0 && C.RequiredArgumentCount > 1)
{
await E.Origin.Tell($"Not enough arguments supplied!");
await E.Origin.Tell(C.Syntax);
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} did not supply enough arguments for \"{C.Name}\"");
}
}
}
if (E.Target == null) // Find active player as single word
{
matchingPlayers = GetClientByName(Args[0]);
if (matchingPlayers.Count > 1)
{
await E.Origin.Tell("Multiple players match that name");
foreach (var p in matchingPlayers)
await E.Origin.Tell($"[^3{p.ClientNumber}^7] {p.Name}");
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} had multiple players found for {C.Name}");
}
else if (matchingPlayers.Count == 1)
{
E.Target = matchingPlayers.First();
string escapedName = Regex.Escape(E.Target.Name);
string escapedArg = Regex.Escape(Args[0]);
var reg = new Regex($"({escapedName})|({escapedArg})", RegexOptions.IgnoreCase);
E.Data = reg.Replace(E.Data, "", 1).Trim();
if ((E.Data.Trim() == E.Target.Name.ToLower().Trim() ||
E.Data == String.Empty) &&
C.RequiresTarget)
{
await E.Origin.Tell($"Not enough arguments supplied!");
await E.Origin.Tell(C.Syntax);
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} did not supply enough arguments for \"{C.Name}\"");
}
}
}
2015-03-08 17:20:10 -04:00
if (E.Target == null && C.RequiresTarget)
2015-03-08 17:20:10 -04:00
{
await E.Origin.Tell("Unable to find specified player.");
2018-04-14 00:51:38 -04:00
throw new CommandException($"{E.Origin} specified invalid player for \"{C.Name}\"");
2015-03-08 17:20:10 -04:00
}
}
E.Data = E.Data.Trim();
2015-03-08 17:20:10 -04:00
return C;
}
public override async Task ExecuteEvent(GameEvent E)
{
if (Throttled)
return;
await ProcessEvent(E);
Manager.GetEventApi().OnServerEvent(this, E);
2018-04-08 02:44:42 -04:00
foreach (IPlugin P in SharedLibraryCore.Plugins.PluginImporter.ActivePlugins)
{
#if !DEBUG
try
#endif
2015-08-20 15:23:13 -04:00
{
if (cts.IsCancellationRequested)
break;
await P.OnEventAsync(E, this);
}
#if !DEBUG
catch (Exception Except)
{
2017-05-27 19:29:20 -04:00
Logger.WriteError(String.Format("The plugin \"{0}\" generated an error. ( see log )", P.Name));
Logger.WriteDebug(String.Format("Error Message: {0}", Except.Message));
Logger.WriteDebug(String.Format("Error Trace: {0}", Except.StackTrace));
while (Except.InnerException != null)
{
Except = Except.InnerException;
Logger.WriteDebug($"Inner exception: {Except.Message}");
}
continue;
2015-08-20 15:23:13 -04:00
}
#endif
}
}
async Task<int> PollPlayersAsync()
2015-03-08 17:20:10 -04:00
{
2018-03-06 02:22:19 -05:00
var now = DateTime.Now;
List<Player> CurrentPlayers = null;
try
{
CurrentPlayers = await this.GetStatusAsync();
}
// when the server has lost connection
2018-04-14 00:51:38 -04:00
catch (NetworkException)
{
Throttled = true;
return ClientNum;
}
2018-03-06 02:22:19 -05:00
#if DEBUG
Logger.WriteInfo($"Polling players took {(DateTime.Now - now).TotalMilliseconds}ms");
#endif
Throttled = false;
for (int i = 0; i < Players.Count; i++)
{
if (CurrentPlayers.Find(p => p.ClientNumber == i) == null && Players[i] != null)
await RemovePlayer(i);
}
for (int i = 0; i < CurrentPlayers.Count; i++)
{
await AddPlayer(CurrentPlayers[i]);
}
return CurrentPlayers.Count;
}
2015-03-08 17:20:10 -04:00
long l_size = -1;
String[] lines = new String[8];
String[] oldLines = new String[8];
DateTime start = DateTime.Now;
DateTime playerCountStart = DateTime.Now;
DateTime lastCount = DateTime.Now;
DateTime tickTime = DateTime.Now;
bool firstRun = true;
2015-03-08 17:20:10 -04:00
override public async Task<bool> ProcessUpdatesAsync(CancellationToken cts)
{
this.cts = cts;
2018-03-06 02:22:19 -05:00
//#if DEBUG == false
try
2018-03-06 02:22:19 -05:00
//#endif
{
// first start
if (firstRun)
{
await ExecuteEvent(new GameEvent(GameEvent.EventType.Start, "Server started", null, null, this));
firstRun = false;
}
if ((DateTime.Now - LastPoll).TotalMinutes < 2 && ConnectionErrors >= 1)
return true;
try
{
int polledPlayerCount = await PollPlayersAsync();
if (ConnectionErrors > 0)
{
2017-11-13 16:58:23 -05:00
Logger.WriteVerbose($"Connection has been reestablished with {IP}:{Port}");
Throttled = false;
}
ConnectionErrors = 0;
LastPoll = DateTime.Now;
}
2018-04-14 00:51:38 -04:00
catch (NetworkException e)
{
ConnectionErrors++;
if (ConnectionErrors == 1)
{
Logger.WriteError($"{e.Message} {IP}:{Port}, reducing polling rate");
2017-11-13 16:58:23 -05:00
Logger.WriteDebug($"Internal Exception: {e.Data["internal_exception"]}");
Throttled = true;
}
return true;
}
LastMessage = DateTime.Now - start;
lastCount = DateTime.Now;
if ((DateTime.Now - tickTime).TotalMilliseconds >= 1000)
2015-03-08 17:20:10 -04:00
{
2018-04-08 02:44:42 -04:00
foreach (var Plugin in SharedLibraryCore.Plugins.PluginImporter.ActivePlugins)
{
if (cts.IsCancellationRequested)
break;
await Plugin.OnTickAsync(this);
}
tickTime = DateTime.Now;
}
2018-04-08 02:44:42 -04:00
if ((lastCount - playerCountStart).TotalMinutes >= SharedLibraryCore.Helpers.PlayerHistory.UpdateInterval)
{
2018-04-08 02:44:42 -04:00
while (PlayerHistory.Count > ((60 / SharedLibraryCore.Helpers.PlayerHistory.UpdateInterval) * 12)) // 12 times a hour for 12 hours
PlayerHistory.Dequeue();
2018-04-08 02:44:42 -04:00
PlayerHistory.Enqueue(new SharedLibraryCore.Helpers.PlayerHistory(ClientNum));
playerCountStart = DateTime.Now;
}
if (LastMessage.TotalSeconds > Manager.GetApplicationSettings().Configuration().AutoMessagePeriod
&& BroadcastMessages.Count > 0
&& ClientNum > 0)
{
await Broadcast(Utilities.ProcessMessageToken(Manager.GetMessageTokens(), BroadcastMessages[NextMessage]));
NextMessage = NextMessage == (BroadcastMessages.Count - 1) ? 0 : NextMessage + 1;
start = DateTime.Now;
}
if (LogFile == null)
return true;
if (l_size != LogFile.Length())
{
// this should be the longest running task
await Task.FromResult(lines = LogFile.Tail(12));
if (lines != oldLines)
2015-05-09 12:46:25 -04:00
{
l_size = LogFile.Length();
int end = (lines.Length == oldLines.Length) ? lines.Length - 1 : Math.Abs((lines.Length - oldLines.Length)) - 1;
2015-05-09 12:46:25 -04:00
for (int count = 0; count < lines.Length; count++)
2015-05-09 12:46:25 -04:00
{
if (lines.Length < 1 && oldLines.Length < 1)
continue;
2015-05-09 12:46:25 -04:00
if (lines[count] == oldLines[oldLines.Length - 1])
continue;
2015-05-09 12:46:25 -04:00
if (lines[count].Length < 10) // it's not a needed line
continue;
2015-03-08 17:20:10 -04:00
else
{
GameEvent event_ = EventParser.GetEvent(this, lines[count]);
if (event_ != null)
2015-03-08 17:20:10 -04:00
{
if (event_.Origin == null)
continue;
2015-03-08 17:20:10 -04:00
await ExecuteEvent(event_);
}
2015-03-08 17:20:10 -04:00
}
}
}
}
oldLines = lines;
l_size = LogFile.Length();
if (Manager.ShutdownRequested())
{
2018-04-08 02:44:42 -04:00
foreach (var plugin in SharedLibraryCore.Plugins.PluginImporter.ActivePlugins)
2018-02-15 23:01:28 -05:00
await plugin.OnUnloadAsync();
for (int i = 0; i < Players.Count; i++)
await RemovePlayer(i);
}
return true;
}
2018-03-06 02:22:19 -05:00
//#if !DEBUG
2018-04-14 00:51:38 -04:00
catch (NetworkException)
{
Logger.WriteError($"Could not communicate with {IP}:{Port}");
return false;
}
catch (Exception E)
{
Logger.WriteError($"Encountered error on {IP}:{Port}");
Logger.WriteDebug("Error Message: " + E.Message);
Logger.WriteDebug("Error Trace: " + E.StackTrace);
return false;
2015-03-08 17:20:10 -04:00
}
2018-03-06 02:22:19 -05:00
//#endif
2015-03-08 17:20:10 -04:00
}
public async Task Initialize()
2015-03-08 17:20:10 -04:00
{
RconParser = ServerConfig.UseT6MParser ? (IRConParser)new T6MRConParser() : new IW4RConParser();
EventParser = ServerConfig.UseT6MParser ? (IEventParser)new T6MEventParser() : new IW4EventParser();
var version = await this.GetDvarAsync<string>("version");
GameName = Utilities.GetGame(version.Value);
if (GameName == Game.UKN)
Logger.WriteWarning($"Game name not recognized: {version}");
var shortversion = await this.GetDvarAsync<string>("shortversion");
var hostname = await this.GetDvarAsync<string>("sv_hostname");
var mapname = await this.GetDvarAsync<string>("mapname");
var maxplayers = (GameName == Game.IW4) ? // gotta love IW4 idiosyncrasies
await this.GetDvarAsync<int>("party_maxplayers") :
await this.GetDvarAsync<int>("sv_maxclients");
var gametype = await this.GetDvarAsync<string>("g_gametype");
var basepath = await this.GetDvarAsync<string>("fs_basepath");
2018-03-06 02:22:19 -05:00
WorkingDirectory = basepath.Value;
var game = await this.GetDvarAsync<string>("fs_game");
var logfile = await this.GetDvarAsync<string>("g_log");
var logsync = await this.GetDvarAsync<int>("g_logsync");
Dvar<int> onelog = null;
if (GameName == Game.IW4)
{
try
{
onelog = await this.GetDvarAsync<int>("iw4x_onelog");
}
catch (Exception)
{
onelog = new Dvar<int>("iw4x_onelog")
{
Value = -1
};
}
}
try
{
var website = await this.GetDvarAsync<string>("_website");
Website = website.Value;
}
2015-10-10 22:32:12 -04:00
2018-04-08 02:44:42 -04:00
catch (SharedLibraryCore.Exceptions.DvarException)
{
Website = "this server's website";
}
2015-08-23 17:58:48 -04:00
2018-03-14 14:22:04 -04:00
InitializeMaps();
this.Hostname = hostname.Value.StripColors();
2018-03-14 14:22:04 -04:00
this.CurrentMap = Maps.Find(m => m.Name == mapname.Value) ?? new Map() { Alias = mapname.Value, Name = mapname.Value };
this.MaxClients = maxplayers.Value;
this.FSGame = game.Value;
2015-08-23 17:58:48 -04:00
2017-11-13 16:58:23 -05:00
await this.SetDvarAsync("sv_kickbantime", 60);
if (logsync.Value == 0 || logfile.Value == string.Empty)
{
// this DVAR isn't set until the a map is loaded
await this.SetDvarAsync("logfile", 2);
await this.SetDvarAsync("g_logsync", 2); // set to 2 for continous in other games, clamps to 1 for IW4
await this.SetDvarAsync("g_log", "games_mp.log");
Logger.WriteWarning("Game log file not properly initialized, restarting map...");
await this.ExecuteCommandAsync("map_restart");
logfile = await this.GetDvarAsync<string>("g_log");
}
CustomCallback = await ScriptLoaded();
2018-03-14 14:22:04 -04:00
string mainPath = (GameName == Game.IW4 && onelog.Value >= 0) ? "userraw" : "main";
// patch for T5M:V2 log path
mainPath = (GameName == Game.T5M) ? "rzodemo" : mainPath;
// patch for T6M:PLUTONIUM
mainPath = (GameName == Game.T6M) ? $"t6r{Path.DirectorySeparatorChar}data" : mainPath;
#if DEBUG
2018-04-14 00:51:38 -04:00
// basepath.Value = @"\\192.168.88.253\Call of Duty Black Ops II";
#endif
string logPath = (game.Value == "" || onelog?.Value == 1) ?
$"{basepath.Value.Replace('\\', Path.DirectorySeparatorChar)}{Path.DirectorySeparatorChar}{mainPath}{Path.DirectorySeparatorChar}{logfile.Value}" :
$"{basepath.Value.Replace('\\', Path.DirectorySeparatorChar)}{Path.DirectorySeparatorChar}{game.Value.Replace('/', Path.DirectorySeparatorChar)}{Path.DirectorySeparatorChar}{logfile.Value}";
if (!File.Exists(logPath))
2015-03-08 17:20:10 -04:00
{
2017-05-27 19:29:20 -04:00
Logger.WriteError($"Gamelog {logPath} does not exist!");
#if !DEBUG
2018-04-08 02:44:42 -04:00
throw new SharedLibraryCore.Exceptions.ServerException($"Invalid gamelog file {logPath}");
#endif
2015-03-08 17:20:10 -04:00
}
else
{
LogFile = new IFile(logPath);
}
Logger.WriteInfo($"Log file is {logPath}");
#if DEBUG
// LogFile = new RemoteFile("https://raidmax.org/IW4MAdmin/getlog.php");
#else
await Broadcast("IW4M Admin is now ^2ONLINE");
2015-10-10 19:31:24 -04:00
#endif
2015-03-08 17:20:10 -04:00
}
2015-03-08 17:20:10 -04:00
//Process any server event
override protected async Task ProcessEvent(GameEvent E)
2015-03-08 17:20:10 -04:00
{
if (E.Type == GameEvent.EventType.Connect)
{
2018-03-09 03:01:12 -05:00
ChatHistory.Add(new ChatInfo()
{
Name = E.Origin.Name,
Message = "CONNECTED",
Time = DateTime.UtcNow
});
2018-02-15 23:01:28 -05:00
if (E.Origin.Level > Player.Permission.Moderator)
await E.Origin.Tell($"There are ^5{Reports.Count} ^7recent reports");
}
else if (E.Type == GameEvent.EventType.Disconnect)
2015-03-08 17:20:10 -04:00
{
2018-03-09 03:01:12 -05:00
ChatHistory.Add(new ChatInfo()
{
Name = E.Origin.Name,
Message = "DISCONNECTED",
Time = DateTime.UtcNow
});
2015-03-08 17:20:10 -04:00
}
else if (E.Type == GameEvent.EventType.Script)
{
await ExecuteEvent(new GameEvent(GameEvent.EventType.Kill, E.Data, E.Origin, E.Target, this));
}
if (E.Type == GameEvent.EventType.Say && E.Data.Length >= 2)
2015-03-08 17:20:10 -04:00
{
if (E.Data.Substring(0, 1) == "!" || E.Data.Substring(0, 1) == "@" || E.Origin.Level == Player.Permission.Console)
2015-03-16 16:40:30 -04:00
{
Command C = null;
try
{
C = await ValidateCommand(E);
}
2015-03-08 17:20:10 -04:00
2018-04-14 00:51:38 -04:00
catch (CommandException e)
{
Logger.WriteInfo(e.Message);
}
if (C != null)
{
if (C.RequiresTarget && E.Target == null)
{
Logger.WriteWarning("Requested event (command) requiring target does not have a target!");
}
try
{
2018-04-14 00:51:38 -04:00
if (!E.Remote && E.Origin.Level != Player.Permission.Console)
{
await ExecuteEvent(new GameEvent()
{
Type = GameEvent.EventType.Command,
Data = string.Empty,
Origin = E.Origin,
Target = E.Target,
Owner = this,
Extra = C,
Remote = E.Remote
});
}
await C.ExecuteAsync(E);
}
2015-03-08 17:20:10 -04:00
2018-04-14 00:51:38 -04:00
catch (AuthorizationException e)
{
await E.Origin.Tell($"You are not authorized to execute that command - {e.Message}");
}
catch (Exception Except)
{
Logger.WriteError(String.Format("A command request \"{0}\" generated an error.", C.Name));
Logger.WriteDebug(String.Format("Error Message: {0}", Except.Message));
Logger.WriteDebug(String.Format("Error Trace: {0}", Except.StackTrace));
await E.Origin.Tell("^1An internal error occured while processing your command^7");
#if DEBUG
await E.Origin.Tell(Except.Message);
#endif
}
2015-03-08 17:20:10 -04:00
}
}
else // Not a command
{
E.Data = E.Data.StripColors();
2018-03-09 03:01:12 -05:00
ChatHistory.Add(new ChatInfo()
{
Name = E.Origin.Name,
Message = E.Data,
Time = DateTime.UtcNow
});
}
2015-03-08 17:20:10 -04:00
}
if (E.Type == GameEvent.EventType.MapChange)
2015-03-08 17:20:10 -04:00
{
2017-05-27 19:29:20 -04:00
Logger.WriteInfo($"New map loaded - {ClientNum} active players");
Gametype = (await this.GetDvarAsync<string>("g_gametype")).Value.StripColors();
Hostname = (await this.GetDvarAsync<string>("sv_hostname")).Value.StripColors();
FSGame = (await this.GetDvarAsync<string>("fs_game")).Value.StripColors();
string mapname = this.GetDvarAsync<string>("mapname").Result.Value;
2018-03-14 14:22:04 -04:00
CurrentMap = Maps.Find(m => m.Name == mapname) ?? new Map() { Alias = mapname, Name = mapname };
2015-03-08 17:20:10 -04:00
}
if (E.Type == GameEvent.EventType.MapEnd)
2015-03-08 17:20:10 -04:00
{
2017-05-27 19:29:20 -04:00
Logger.WriteInfo("Game ending...");
}
//todo: move
while (ChatHistory.Count > Math.Ceiling((double)ClientNum / 2))
ChatHistory.RemoveAt(0);
// the last client hasn't fully disconnected yet
// so there will still be at least 1 client left
if (ClientNum < 2)
ChatHistory.Clear();
2015-03-08 17:20:10 -04:00
}
public override async Task Warn(String Reason, Player Target, Player Origin)
{
2017-11-29 19:35:50 -05:00
// ensure player gets warned if command not performed on them in game
if (Target.ClientNumber < 0)
{
var ingameClient = Manager.GetActiveClients()
.FirstOrDefault(c => c.ClientId == Target.ClientId);
2017-11-29 19:35:50 -05:00
if (ingameClient != null)
{
2017-11-29 19:35:50 -05:00
await Warn(Reason, ingameClient, Origin);
return;
}
}
else
{
if (Target.Warnings >= 4)
{
2017-11-29 19:35:50 -05:00
await Target.Kick("Too many warnings!", (await Manager.GetClientService().Get(1)).AsPlayer());
return;
}
2017-11-29 19:35:50 -05:00
Target.Warnings++;
String Message = String.Format("^1WARNING ^7[^3{0}^7]: ^3{1}^7, {2}", Target.Warnings, Target.Name, Reason);
2017-11-29 19:35:50 -05:00
await Target.CurrentServer.Broadcast(Message);
}
2017-11-29 19:35:50 -05:00
Penalty newPenalty = new Penalty()
{
Type = Penalty.PenaltyType.Warning,
Expires = DateTime.UtcNow,
Offender = Target,
Offense = Reason,
Punisher = Origin,
Active = true,
When = DateTime.UtcNow,
Link = Target.AliasLink
};
await Manager.GetPenaltyService().Create(newPenalty);
}
public override async Task Kick(String Reason, Player Target, Player Origin)
{
2017-11-29 19:35:50 -05:00
// ensure player gets kicked if command not performed on them in game
if (Target.ClientNumber < 0)
{
var ingameClient = Manager.GetActiveClients()
.FirstOrDefault(c => c.ClientId == Target.ClientId);
2017-11-29 19:35:50 -05:00
if (ingameClient != null)
{
2017-11-29 19:35:50 -05:00
await Kick(Reason, ingameClient, Origin);
return;
}
}
2018-02-21 20:29:23 -05:00
#if !DEBUG
2017-11-29 19:35:50 -05:00
else
{
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, Target.ClientNumber, $"You were Kicked - ^5{Reason}^7");
await Target.CurrentServer.ExecuteCommandAsync(formattedKick);
}
2018-02-21 20:29:23 -05:00
#endif
2017-11-29 19:35:50 -05:00
#if DEBUG
await Target.CurrentServer.RemovePlayer(Target.ClientNumber);
#endif
var newPenalty = new Penalty()
{
Type = Penalty.PenaltyType.Kick,
Expires = DateTime.UtcNow,
Offender = Target,
Offense = Reason,
Punisher = Origin,
Active = true,
When = DateTime.UtcNow,
Link = Target.AliasLink
};
await Manager.GetPenaltyService().Create(newPenalty);
}
public override async Task TempBan(String Reason, TimeSpan length, Player Target, Player Origin)
{
2017-11-29 19:35:50 -05:00
// ensure player gets banned if command not performed on them in game
if (Target.ClientNumber < 0)
{
2018-02-21 20:29:23 -05:00
var ingameClient = Manager.GetActiveClients()
.FirstOrDefault(c => c.ClientId == Target.ClientId);
2017-11-29 19:35:50 -05:00
if (ingameClient != null)
{
await TempBan(Reason, length, ingameClient, Origin);
return;
}
}
#if !DEBUG
2017-11-29 19:35:50 -05:00
else
{
string formattedKick = String.Format(RconParser.GetCommandPrefixes().Kick, Target.ClientNumber, $"^7You're Temporarily Banned - ^5{Reason}");
await Target.CurrentServer.ExecuteCommandAsync(formattedKick);
}
#else
2017-11-29 19:35:50 -05:00
await Target.CurrentServer.RemovePlayer(Target.ClientNumber);
#endif
Penalty newPenalty = new Penalty()
{
Type = Penalty.PenaltyType.TempBan,
Expires = DateTime.UtcNow + length,
Offender = Target,
Offense = Reason,
Punisher = Origin,
Active = true,
When = DateTime.UtcNow,
Link = Target.AliasLink
};
await Manager.GetPenaltyService().Create(newPenalty);
}
override public async Task Ban(String Message, Player Target, Player Origin)
{
2017-11-29 19:35:50 -05:00
// ensure player gets banned if command not performed on them in game
if (Target.ClientNumber < 0)
{
Player ingameClient = null;
ingameClient = Manager.GetServers()
.Select(s => s.GetPlayersAsList())
.FirstOrDefault(l => l.FirstOrDefault(c => c.ClientId == Target.ClientId) != null)
?.First(c => c.ClientId == Target.ClientId);
if (ingameClient != null)
{
await Ban(Message, ingameClient, Origin);
return;
}
}
else
{
// this is set only because they're still in the server.
Target.Level = Player.Permission.Banned;
#if !DEBUG
string formattedString = String.Format(RconParser.GetCommandPrefixes().Kick, Target.ClientNumber, $"You're Banned - ^5{Message} ^7(appeal at {Website})^7");
await Target.CurrentServer.ExecuteCommandAsync(formattedString);
#else
2017-11-29 19:35:50 -05:00
await Target.CurrentServer.RemovePlayer(Target.ClientNumber);
#endif
}
Penalty newPenalty = new Penalty()
{
Type = Penalty.PenaltyType.Ban,
Expires = DateTime.MaxValue,
Offender = Target,
Offense = Message,
Punisher = Origin,
Active = true,
When = DateTime.UtcNow,
Link = Target.AliasLink
};
2017-11-29 19:35:50 -05:00
await Manager.GetPenaltyService().Create(newPenalty);
2015-03-08 17:20:10 -04:00
}
override public async Task Unban(string reason, Player Target, Player Origin)
2015-03-08 17:20:10 -04:00
{
var unbanPenalty = new Penalty()
{
Type = Penalty.PenaltyType.Unban,
Expires = DateTime.UtcNow,
Offender = Target,
Offense = reason,
Punisher = Origin,
When = DateTime.UtcNow,
Active = true,
Link = Target.AliasLink
};
await Manager.GetPenaltyService().Create(unbanPenalty);
await Manager.GetPenaltyService().RemoveActivePenalties(Target.AliasLink.AliasLinkId);
}
override public void InitializeTokens()
{
2018-04-08 02:44:42 -04:00
Manager.GetMessageTokens().Add(new SharedLibraryCore.Helpers.MessageToken("TOTALPLAYERS", Manager.GetClientService().GetTotalClientsAsync().Result.ToString));
Manager.GetMessageTokens().Add(new SharedLibraryCore.Helpers.MessageToken("VERSION", Application.Program.Version.ToString));
}
2015-03-08 17:20:10 -04:00
}
}