-- Log file for all dbTracef messages --

21:41:33.49   AppInitNetwork::InitSteam: Initializing Steam...
21:41:33.49   AppInitNetwork::InitSteam: Steam has been initialized.
21:41:33.49   RLINK -- NetworkManager::Create - creating network manager
21:41:34.53   RLINK -- WorldwideLoginService::WorldwideLoginService - initializing
21:41:34.53   RLINK -- RLink::WorldwideLoginService::LongPoller::ThreadFunction - Entering network thread function...
21:41:34.53   RLINK -- WinTransport - CreateSocket exclusive broadcast socket was available.
21:41:34.53   RLINK -- WinTransport - CreateSocket listening for broadcasts on default port
21:41:34.54   RLINK -- WinTransport - Host Name: Karnataki-PC, aliases: , type=AF_INET, len=4
21:41:34.54   RLINK -- WinTransport - Host IP Address #0: 192.168.2.134
21:41:34.54   RLINK -- WinTransport - Interface #0: ip:192.168.2.134, broadcast:192.168.2.134, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
21:41:34.54   RLINK -- WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
21:41:34.54   RLINK -- Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
21:41:34.54   RLINK -- SessionManager - Peer Header Size = 15 bytes
21:41:34.54   RLINK -- SessionManager - Game Data overhead = 4 bytes
21:41:34.54   RLINK -- SessionManager - Proxy overhead = 7 bytes
21:41:34.54   RLINK -- AutomatchInternal: Instantiating
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel fffffffe
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel fffffffb
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel fffffffd
21:41:34.54   RLINK -- RLink::ThreadFunction - Entering network thread function...
21:41:34.54   Loaded 589 badwords from data:OnlineConfig\Badwords.lua
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000000
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000001
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000002
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000003
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000004
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000005
21:41:34.54   RLINK -- MessageInternal::CreateChannel: Created channel 00000006
21:41:34.54   GAME -- Available memory: 32714MB Physical RAM, 0MB Pagefile, 4095 Virtual Address Space
21:41:35.36   DLLDriverLinker -- Adding driver 'spDx10.dll'.
21:41:35.36   DLLDriverLinker -- Adding driver 'spDx9.dll'.
21:41:35.36   DLLDriverLinker -- 2 DLL drivers found.
21:41:35.39   SPDx10 -- Adapter [AMD Radeon HD 7900 Series]: 3054MB dedicated video memory, 0MB dedicated system memory and 1041MB shared system memory.
21:41:36.72   DLLDriverLinker -- 2 DLL drivers found.
21:41:36.78   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
21:41:36.78   GAME -- Resolution set to 1920x1080 (fullscreen).
21:41:36.81   SPDx9 -- Driver Name = aticfx32.dll  Desc = AMD Radeon HD 7900 Series
21:41:36.81   SPDx9 -- Driver Vendor = 0x1002  Device = 0x6798  SubSys = 0x254D1458  Rev = 0x0000
21:41:36.81   SPDx9 -- Driver Version  Product = 0x0008  Version = 0x0011  SubVersion = 0x00  Build = 13.15
21:41:36.81   SPDx9 -- Driver GUID = {D7B71EE2-24D8-11CF-CB72-4705BEC2C535}
21:41:37.10   SPDx9 -- 2770MB available Texture Memory
21:41:37.10   ShaderDatabase: using shader profile [ps30]
21:41:37.37   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
21:41:37.47   GameObjLoader 0ab410b0 - resetting counters
21:41:37.47   GameObjLoader 0ab410b0 - Created loader
21:41:37.47   GameObjLoader 0ab41210 - resetting counters
21:41:37.47   GameObjLoader 0ab41210 - Created loader
21:41:37.47   GAME -- Beginning FE
21:41:37.47   UIFrontEnd - Loading Front End
21:41:37.47   THREAD: Hyper-Threading Technology Processors are not detected.
21:41:37.77   SOUND -- Initializing ...
21:41:37.81   INNIMapDCA Key not found: sp_speechducker::time
21:41:38.10   SOUND -- Initialization completed!
21:41:38.10   UIFrontEnd - Initializing Forms
21:41:38.95   CampaignFilter::BindFilterSpecificWidgets()
21:41:39.01   Activating screen: AppLoadingForm
21:41:39.01   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:41:39.51   GAME -- (worldmanager) Cannot find original scenario "4p_vyazma_challenge" referenced from data:scenarios\mp\challenge_vyazma.scenref
21:41:39.53   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
21:41:39.53   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
21:41:39.53   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
21:41:39.53   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
21:41:39.53   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
21:41:39.53   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
21:41:39.72   GAME -- Using player profile KARNATAKI-PC
21:41:40.00   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
21:41:40.09   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
21:41:40.35   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:41:40.35   Activating screen: FEMovie
21:41:40.35   Activating screen: OnlineWidget
21:41:40.35   CRC & Version Info : 000002bc:6809f4f5:9233461d eastern_front:700:factionfix.dll 1
21:41:40.35   Logging in using Steam credentials...
21:41:40.35   Activating screen: FE_mm_01
21:41:40.40   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:41:40.40   GAME -- Setting campaign state to 'coh'
21:41:40.40   GAME -- Closing state 'coh'
21:41:40.40   GAME -- Setting campaign state to 'cxp2'
21:41:40.40   GAME -- Closing state 'cxp2'
21:41:40.41   GAME -- Setting campaign state to 'cxp1'
21:41:40.41   GAME -- Closing state 'cxp1'
21:41:40.41   GAME -- Setting campaign state to 'dlc1'
21:41:40.41   GAME -- Closing state 'dlc1'
21:41:40.41   GAME -- Setting campaign state to 'dlc2'
21:41:40.41   GAME -- Closing state 'dlc2'
21:41:40.41   GAME -- Setting campaign state to 'dlc3'
21:41:40.41   GAME -- Closing state 'dlc3'
21:41:40.42   RLINK -- Requesting ticket
21:41:40.42   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.46   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.46   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.46   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.46   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.47   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.48   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.49   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.50   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.50   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.50   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.50   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.50   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.51   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.52   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.53   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.54   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.55   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.56   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.57   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.58   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.59   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.60   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.61   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.62   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.63   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.64   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.65   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
21:41:40.65   RLINK -- OnRequest app ticket returned N
21:41:40.65   RLINK -- SteamAuth received ticket at t=6105
21:41:40.65   RLINK -- SteamAuthManager::GetAuthToken state ID : 2
21:41:41.55   Activating screen: MessageBoxPopup
21:41:42.05   RLINK -- Found 1 profiles for account /steam/76561198023393842
21:41:42.05   RLINK -- Found profile: /steam/76561198023393842
21:41:42.05   THREAD: Hyper-Threading Technology Processors are not detected.
21:41:42.05   Activating screen: MessageBoxPopup
21:41:42.05   RLINK -- starting online hosting
21:41:42.06   RLINK -- SlotManager::GetStringFromSlots: compressed = 25 bytes / 350 bytes
21:41:43.71   RLINK -- BT! - SockInit: SOCK_FD_SET_SIZE = 64
21:41:43.71   RLINK -- DBG - SockConnect: 0/s->stHandle=2580
21:41:43.71   RLINK -- DBG - SockConnect: 0/2580 connect deferred (in progress)
21:41:43.85   RLINK -- DBG - SockAnimateAll: socket 0/2580 connection complete.
21:41:44.02   RLINK -- battleserverrelay - Connected: 
Connection [ 1/ 1] - local=192.168.2.134:58994, remote=54.208.245.53:50007, type=CONNECT, timeTookToConnectMS=302, silentTimeMS=0, lastSockError=0
21:41:44.03   RLINK -- Session::Initialize - info, initializing session object, using threads.
21:41:44.03   RLINK -- SessionManager::RegisterSession - Registering RL_NEW session 109fd8d0
21:41:44.03   RLINK -- Created Matchinfo for sessionID 15339529
21:41:44.03   RLINK -- OnJoinAdvertisementSuccess - joined online match, server leave notification required
21:41:44.03   RLINK -- starting local hosting
21:41:44.03   RLINK -- Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
21:41:44.03   RLINK -- Allocated route ID=0 for PeerID 1 at WINaddr:192.168.2.134:6112;
21:41:44.03   RLINK -- Transport::OpenInternal request to WINaddr:192.168.2.134:6112;
21:41:44.03   RLINK -- Session::Host sid = EA1009, hostURL = , local addresses = WINaddr:192.168.2.134:6112;
21:41:44.03   RLINK -- Session::GetState - info, session [15339529]'s state changed to [2:STATE_CONNECTING].
21:41:44.03   RLINK -- ValidateCustomData: called with 463 bytes of custom data
21:41:44.03   RLINK -- Host accepted Peer 1 into the match at address list=WINaddr:192.168.2.134:6112;, routes=WINaddr:192.168.2.134:6112;
21:41:44.03   RLINK -- WorldwideAdvertisementService::Process - EVENT_NEWPEER
21:41:44.03   RLINK -- Sending matchinfo change #2
21:41:44.04   RLINK -- Session Connection Event - ReasonID: 0 ReasonDebug: SessionOperationInfo::SUCCESS
21:41:44.04   RLINK -- HostAsync - got operation info 0:SessionOperationInfo::SUCCESS
21:41:44.04   RLINK -- hosting - Session is connected
21:41:44.04   RLINK -- HostAsync - completed with HostResult = 0
21:41:44.04   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
21:41:44.04   Activating screen: OnlineGameSetup
21:41:44.04   GameSetupForm::SetScenarioFile -- the big defensive v2
21:41:44.04   RLINK -- Session::GetState - info, session [15339529]'s state changed to [3:STATE_CONNECTED].
21:41:44.04   GameSetupForm::OnMatchCategorySelected
21:41:44.04   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:41:44.05   GameSetupForm::OnMapSelected
21:41:44.05   GameSetupForm::SetScenarioFile -- the big defensive v2
21:41:44.05   RLINK -- WorldWidePartyService::SetVisible -- TRUE
21:41:44.05   RLINK -- WorldwideAdvertisementService::PublishSession -- Publishing Visible match
21:41:44.06   RLINK -- local host PeerID 1 LOCL ack=  0 (  0ms~0) unack=  3, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=0/2
21:41:44.06   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=1/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=1/0, Pdel=0/0, drop=0/0, data=1/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=2/0, PPrx=1/0, ping=0/0, Pfrg=0/0, rely=2/0, lb_p=0/0, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:41:44.06   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:41:44.06   Activating screen: RelicOnlineChat
21:41:44.07   Activating screen: RelicOnlineNewsScreen
21:41:44.07   Activating screen: RelicOnlineStatsScreen
21:41:44.07   Activating screen: Achievements
21:41:44.07   GAME -- Setting campaign state to 'coh'
21:41:44.07   GAME -- Closing state 'coh'
21:41:44.07   GAME -- Setting campaign state to 'cxp2'
21:41:44.07   GAME -- Closing state 'cxp2'
21:41:44.07   GAME -- Setting campaign state to 'cxp1'
21:41:44.07   GAME -- Closing state 'cxp1'
21:41:44.07   GAME -- Setting campaign state to 'dlc1'
21:41:44.07   GAME -- Closing state 'dlc1'
21:41:44.07   GAME -- Setting campaign state to 'dlc2'
21:41:44.07   GAME -- Closing state 'dlc2'
21:41:44.08   GAME -- Setting campaign state to 'dlc3'
21:41:44.08   GAME -- Closing state 'dlc3'
21:41:44.08   GAME -- Setting campaign state to 'dlc1'
21:41:44.08   GAME -- Closing state 'dlc1'
21:41:44.08   Activating screen: GameHistory
21:41:44.08   GAME -- Setting campaign state to 'coh'
21:41:44.08   GAME -- Closing state 'coh'
21:41:44.08   GAME -- Setting campaign state to 'cxp2'
21:41:44.08   GAME -- Closing state 'cxp2'
21:41:44.09   GAME -- Setting campaign state to 'cxp1'
21:41:44.09   GAME -- Closing state 'cxp1'
21:41:44.09   GAME -- Setting campaign state to 'dlc1'
21:41:44.09   GAME -- Closing state 'dlc1'
21:41:44.09   GAME -- Setting campaign state to 'dlc2'
21:41:44.09   GAME -- Closing state 'dlc2'
21:41:44.09   GAME -- Setting campaign state to 'dlc3'
21:41:44.09   GAME -- Closing state 'dlc3'
21:41:44.09   Activating screen: OnlineGameSetup
21:41:44.09   Activating screen: RelicOnlineTabs
21:41:44.09   GameSetupForm::OnAdvertisementEvent - AET_Host - Ignorning match making party event.
21:41:44.09   RLINK -- WorldwideAutomatchService::OnHostComplete - automatcher is no longer active - stopPollPending 0 automatchPollID 18446744073709551615
21:41:44.09   RLINK -- SlotManager::GetStringFromSlots: compressed = 280 bytes / 925 bytes
21:41:44.14   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:41:44.14   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:41:44.14   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:41:44.14   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:41:44.14   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 0]
21:41:44.14   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.14   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.14   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.14   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.14   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.14   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.14   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.14   PopulateGameInfoInternal - Team #0 Player Count: 4
21:41:44.14   PopulateGameInfoInternal - Team #1 Player Count: 4
21:41:44.14   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:41:44.15   RLINK -- Sending matchinfo change #41
21:41:44.17   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:41:44.17   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:41:44.17   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:41:44.17   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:41:44.17   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 0]
21:41:44.17   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.17   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.17   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.17   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.17   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.17   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:41:44.17   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:41:44.17   PopulateGameInfoInternal - Team #0 Player Count: 4
21:41:44.17   PopulateGameInfoInternal - Team #1 Player Count: 4
21:41:44.17   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:41:44.18   RLINK -- Session - rcv'd Join request - address noaddr/relay/PID=433E6CE77AFC313 in use by existing peer (ignoring)
21:41:44.18   RLINK -- Session::PollTransportEvents AddPeerMessage ignored, peer 1 already in m_peers
21:41:44.20   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:41:44.36   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:41:44.42   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        262, transmitAckLastTimeMS       9874 | Peer ---E- M#00000000 Sack00000003 NSack00000000 (C0.0% S:0.0) [  ]
21:41:53.69   GameSetupForm::OnMapSelected
21:41:53.69   GameSetupForm::SetScenarioFile -- 8P_SCHLACHT_AM_RHEIN
21:41:53.70   RLINK -- WorldWidePartyService::SetVisible -- TRUE
21:41:53.70   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:41:53.70   RLINK -- Sending matchinfo change #51
21:41:53.70   RLINK -- SlotManager::GetStringFromSlots: compressed = 280 bytes / 925 bytes
21:41:53.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:41:53.72   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:41:53.72   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:41:53.72   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:41:53.72   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 0]
21:41:53.72   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:41:53.72   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:41:53.72   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:41:53.72   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:41:53.72   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:41:53.72   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:41:53.72   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:41:53.72   PopulateGameInfoInternal - Team #0 Player Count: 4
21:41:53.72   PopulateGameInfoInternal - Team #1 Player Count: 4
21:41:53.72   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:41:53.88   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:41:53.96   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        255, transmitAckLastTimeMS      19415 | Peer ---E- M#00000000 Sack00000004 NSack00000000 (C0.0% S:0.0) [  ]
21:42:00.17   RLINK -- Sending matchinfo change #52
21:42:00.17   RLINK -- SlotManager::GetStringFromSlots: compressed = 280 bytes / 925 bytes
21:42:00.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:00.18   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:00.18   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:00.18   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:00.18   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 0]
21:42:00.18   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:00.18   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:42:00.18   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:00.18   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:42:00.18   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:00.18   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:00.18   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:00.18   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:00.18   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:00.18   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:00.36   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:00.44   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        265, transmitAckLastTimeMS      25895 | Peer ---E- M#00000000 Sack00000005 NSack00000000 (C0.0% S:0.0) [  ]
21:42:02.33   Activating screen: RaceSelectionPopup
21:42:03.19   RLINK -- Sending matchinfo change #53
21:42:03.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:03.20   RLINK -- WorldWidePartyService::SetVisible -- TRUE
21:42:03.20   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:03.20   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:03.20   RLINK -- SlotManager::GetStringFromSlots: compressed = 282 bytes / 925 bytes
21:42:03.20   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:03.20   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:03.20   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:03.20   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:03.20   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:03.20   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.20   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.20   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.20   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.20   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.20   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.20   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.20   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:03.20   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:03.20   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:03.32   RLINK -- Sending matchinfo change #54
21:42:03.33   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:03.33   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:03.33   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:03.33   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:03.33   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:03.33   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.33   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.33   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.33   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.33   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.33   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:03.33   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:03.33   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:03.33   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:03.33   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:03.36   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:03.50   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:03.58   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        256, transmitAckLastTimeMS      29035 | Peer ---E- M#00000000 Sack00000007 NSack00000000 (C0.0% S:0.0) [  ]
21:42:03.73   Activating screen: DynamicPopupMenu
21:42:05.10   RLINK -- Sending matchinfo change #55
21:42:05.10   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:05.10   RLINK -- WorldWidePartyService::SetVisible -- TRUE
21:42:05.10   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:05.10   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:05.10   RLINK -- SlotManager::GetStringFromSlots: compressed = 289 bytes / 925 bytes
21:42:05.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:05.11   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:05.11   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:05.11   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:05.11   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:05.11   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.11   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:05.11   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.11   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:42:05.11   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.11   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:05.11   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.11   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:05.11   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:05.11   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:05.23   RLINK -- Sending matchinfo change #56
21:42:05.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:05.23   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:05.23   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:05.23   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:05.23   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:05.23   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.23   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:05.23   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.23   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
21:42:05.23   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.23   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:05.23   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:05.23   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:05.23   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:05.23   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:05.28   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:05.40   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:05.48   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        252, transmitAckLastTimeMS      30935 | Peer ---E- M#00000000 Sack00000009 NSack00000000 (C0.0% S:0.0) [  ]
21:42:05.65   Activating screen: DynamicPopupMenu
21:42:06.47   RLINK -- Sending matchinfo change #57
21:42:06.48   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:06.48   RLINK -- WorldWidePartyService::SetVisible -- TRUE
21:42:06.48   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:06.48   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:06.48   RLINK -- SlotManager::GetStringFromSlots: compressed = 289 bytes / 925 bytes
21:42:06.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:06.48   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:06.48   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:06.48   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:06.48   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:06.48   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.48   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:06.48   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.48   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:06.48   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.48   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:06.48   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.48   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:06.48   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:06.48   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:06.60   RLINK -- Sending matchinfo change #58
21:42:06.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:06.61   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:06.61   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:06.61   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:06.61   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:06.61   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.61   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:06.61   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.61   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:06.61   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.61   PopulateGameInfoInternal - Player #3 - [Id -1, Type 6, Team 0, Race 0]
21:42:06.61   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:06.61   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:06.61   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:06.61   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:06.70   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:06.83   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:06.86   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        255, transmitAckLastTimeMS      32315 | Peer ---E- M#00000000 Sack00000011 NSack00000000 (C0.0% S:0.0) [  ]
21:42:06.90   Activating screen: DynamicPopupMenu
21:42:07.71   RLINK -- Sending matchinfo change #59
21:42:07.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:07.71   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:07.71   RLINK -- WorldwideAdvertisementService::PublishSession -- Delisting Invisible match
21:42:07.71   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:07.71   RLINK -- SlotManager::GetStringFromSlots: compressed = 284 bytes / 925 bytes
21:42:07.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:07.72   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:07.72   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:07.72   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:07.72   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:07.72   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.72   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.72   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.72   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.72   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.72   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.72   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.72   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:07.72   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:07.72   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:07.84   RLINK -- Sending matchinfo change #61
21:42:07.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:07.84   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:07.84   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:07.84   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:07.84   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:07.84   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.84   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.84   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.84   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.84   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.84   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:07.84   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:07.84   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:07.84   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:07.84   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:07.90   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:08.03   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:08.10   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        260, transmitAckLastTimeMS      33555 | Peer ---E- M#00000000 Sack00000013 NSack00000000 (C0.0% S:0.0) [  ]
21:42:08.19   Activating screen: DynamicPopupMenu
21:42:09.17   RLINK -- Sending matchinfo change #62
21:42:09.17   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:09.17   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:09.17   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:09.17   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:09.17   RLINK -- SlotManager::GetStringFromSlots: compressed = 287 bytes / 925 bytes
21:42:09.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:09.18   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:09.18   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:09.18   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:09.18   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:09.18   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.18   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.18   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.18   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.18   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.18   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.18   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.18   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:09.18   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:09.18   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:09.30   RLINK -- Sending matchinfo change #63
21:42:09.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:09.31   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:09.31   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:09.31   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:09.31   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:09.31   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.31   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.31   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.31   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.31   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.31   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:09.31   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:09.31   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:09.31   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:09.31   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:09.37   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:09.53   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:09.56   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        257, transmitAckLastTimeMS      35016 | Peer ---E- M#00000000 Sack00000015 NSack00000000 (C0.0% S:0.0) [  ]
21:42:09.82   Activating screen: DynamicPopupMenu
21:42:10.87   RLINK -- Sending matchinfo change #64
21:42:10.87   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:10.87   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:10.87   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:10.87   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:10.87   RLINK -- SlotManager::GetStringFromSlots: compressed = 288 bytes / 925 bytes
21:42:10.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:10.87   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:10.87   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:10.87   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:10.87   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:10.87   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:10.87   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:10.87   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:10.87   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:10.87   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:10.87   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:10.87   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:10.87   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:10.87   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:10.87   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:10.99   RLINK -- Sending matchinfo change #65
21:42:11.00   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:11.00   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:11.00   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:11.00   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:11.00   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:11.00   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:11.00   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:11.00   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:11.00   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:11.00   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:11.00   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:11.00   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:11.00   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:11.00   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:11.00   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:11.06   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:11.17   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:11.26   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        265, transmitAckLastTimeMS      36716 | Peer ---E- M#00000000 Sack00000017 NSack00000000 (C0.0% S:0.0) [  ]
21:42:11.54   Activating screen: DynamicPopupMenu
21:42:12.44   RLINK -- Sending matchinfo change #66
21:42:12.44   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:12.44   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:12.44   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:12.44   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:12.44   RLINK -- SlotManager::GetStringFromSlots: compressed = 286 bytes / 925 bytes
21:42:12.44   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:12.44   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:12.44   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:12.44   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:12.45   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:12.45   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.45   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.45   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.45   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.45   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.45   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.45   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.45   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:12.45   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:12.45   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:12.57   RLINK -- Sending matchinfo change #67
21:42:12.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:12.57   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:12.57   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:12.57   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:12.57   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:12.57   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.57   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.57   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.57   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.57   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.57   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:12.57   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:12.57   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:12.57   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:12.57   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:12.64   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:12.74   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:12.82   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        252, transmitAckLastTimeMS      38276 | Peer ---E- M#00000000 Sack00000019 NSack00000000 (C0.0% S:0.0) [  ]
21:42:13.08   Activating screen: DynamicPopupMenu
21:42:14.28   RLINK -- Sending matchinfo change #68
21:42:14.28   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:14.28   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:14.28   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:14.28   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:14.28   RLINK -- SlotManager::GetStringFromSlots: compressed = 284 bytes / 925 bytes
21:42:14.29   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:14.29   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:14.29   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:14.29   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:14.29   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:14.29   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.29   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.29   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.29   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.29   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.29   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.29   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.29   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:14.29   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:14.29   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:14.41   RLINK -- Sending matchinfo change #69
21:42:14.41   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:14.41   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:14.41   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:14.41   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:14.42   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:14.42   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.42   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.42   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.42   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.42   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.42   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:14.42   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 1]
21:42:14.42   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:14.42   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:14.42   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:14.48   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:14.58   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:14.68   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        269, transmitAckLastTimeMS      40136 | Peer ---E- M#00000000 Sack00000021 NSack00000000 (C0.0% S:0.0) [  ]
21:42:15.17   Activating screen: RaceSelectionPopup
21:42:16.23   RLINK -- Sending matchinfo change #70
21:42:16.23   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:16.23   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:16.23   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:16.23   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:16.23   RLINK -- SlotManager::GetStringFromSlots: compressed = 286 bytes / 925 bytes
21:42:16.24   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:16.24   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:16.24   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:16.24   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:16.24   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:16.24   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.24   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.24   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.24   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.24   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.24   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.24   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:16.24   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:16.24   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:16.24   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:16.36   RLINK -- Sending matchinfo change #71
21:42:16.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:16.37   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:16.37   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:16.37   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:16.37   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:16.37   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.37   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.37   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.37   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.37   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:16.37   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:16.37   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:16.37   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:16.37   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:16.37   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:16.41   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:16.52   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:16.62   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        263, transmitAckLastTimeMS      42076 | Peer ---E- M#00000000 Sack00000023 NSack00000000 (C0.0% S:0.0) [  ]
21:42:16.97   Activating screen: RaceSelectionPopup
21:42:18.21   Activating screen: RaceSelectionPopup
21:42:19.03   RLINK -- Sending matchinfo change #72
21:42:19.04   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:19.04   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:19.04   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:19.04   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:19.04   RLINK -- SlotManager::GetStringFromSlots: compressed = 289 bytes / 925 bytes
21:42:19.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:19.04   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:19.04   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:19.04   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:19.04   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:19.04   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:19.04   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.04   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:19.04   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.04   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:19.04   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.04   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:19.04   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:19.04   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:19.04   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:19.16   RLINK -- Sending matchinfo change #73
21:42:19.17   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:19.17   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:19.17   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:19.17   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:19.17   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:19.17   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:19.17   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.17   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:19.17   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.17   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 1]
21:42:19.17   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:19.17   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:19.17   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:19.17   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:19.17   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:19.24   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:19.35   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:19.42   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        256, transmitAckLastTimeMS      44876 | Peer ---E- M#00000000 Sack00000025 NSack00000000 (C0.0% S:0.0) [  ]
21:42:19.74   Activating screen: RaceSelectionPopup
21:42:20.63   RLINK -- Sending matchinfo change #74
21:42:20.63   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:20.63   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:20.63   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:20.63   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:20.63   RLINK -- SlotManager::GetStringFromSlots: compressed = 291 bytes / 925 bytes
21:42:20.64   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:20.64   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:20.64   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:20.64   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:20.64   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:20.64   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:20.64   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.64   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:20.64   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.64   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:42:20.64   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.64   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:20.64   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:20.64   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:20.64   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:20.76   RLINK -- Sending matchinfo change #75
21:42:20.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:20.76   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:20.76   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:20.76   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:20.76   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:20.76   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:20.76   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.76   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:20.76   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.76   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:42:20.76   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 0]
21:42:20.76   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:20.76   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:20.76   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:20.76   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:20.81   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:20.96   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:21.02   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        260, transmitAckLastTimeMS      46476 | Peer ---E- M#00000000 Sack00000027 NSack00000000 (C0.0% S:0.0) [  ]
21:42:21.95   Activating screen: RaceSelectionPopup
21:42:22.83   RLINK -- Sending matchinfo change #76
21:42:22.83   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:42:22.83   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:42:22.83   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:42:22.83   GetMaxFrameTimeFromProfile: players=8 expected FPS=14.951836, bars=4, max avg=0.044, sd=0.023, 4 samples =  0.04 0.08 0.02 0.04
21:42:22.83   RLINK -- SlotManager::GetStringFromSlots: compressed = 294 bytes / 925 bytes
21:42:22.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:22.84   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:22.84   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:22.84   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:22.84   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:22.84   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:22.84   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:22.84   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:22.84   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:22.84   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:42:22.84   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:42:22.84   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:22.84   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:22.84   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:22.84   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:22.96   RLINK -- Sending matchinfo change #77
21:42:22.97   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:22.97   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:22.97   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:22.97   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:22.97   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:22.97   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:22.97   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:22.97   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:22.97   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:22.97   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:42:22.97   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:42:22.97   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:22.97   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:22.97   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:22.97   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:23.10   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:23.16   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:23.22   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        258, transmitAckLastTimeMS      48676 | Peer ---E- M#00000000 Sack00000029 NSack00000000 (C0.0% S:0.0) [  ]
21:42:23.62   Activating screen: RaceSelectionPopup
21:42:28.98   Activating screen: Achievements
21:42:28.98   Activating screen: RelicOnlineTabs
21:42:28.98   Activating screen: ScreenTipPopup
21:42:35.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:42:45.00   RLINK -- local host PeerID 1 LOCL ack= 30 (512ms~86) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=29/29
21:42:45.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/2, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/2, Pdel=0/0, drop=0/0, data=27/28, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=43/47, PPrx=42/86, ping=0/0, Pfrg=0/0, rely=0/1, lb_p=10/10, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:42:50.94   RLINK -- Sending matchinfo change #78
21:42:50.95   RLINK -- SlotManager::GetStringFromSlots: compressed = 285 bytes / 895 bytes
21:42:50.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:42:50.95   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:42:50.95   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:42:50.95   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:42:50.95   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:42:50.95   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:42:50.95   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:42:50.95   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:42:50.95   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:42:50.95   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:42:50.95   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:42:50.95   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:42:50.95   PopulateGameInfoInternal - Team #0 Player Count: 4
21:42:50.95   PopulateGameInfoInternal - Team #1 Player Count: 4
21:42:50.95   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:42:51.12   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:42:51.20   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        258, transmitAckLastTimeMS      76658 | Peer ---E- M#00000000 Sack00000030 NSack00000000 (C0.0% S:0.0) [  ]
21:43:18.22   RLINK -- Sending matchinfo change #79
21:43:18.22   RLINK -- SlotManager::GetStringFromSlots: compressed = 280 bytes / 855 bytes
21:43:18.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:43:18.23   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:43:18.23   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:43:18.23   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:43:18.23   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:43:18.23   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:43:18.23   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:43:18.23   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:43:18.23   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:43:18.23   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:43:18.23   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:43:18.23   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:43:18.23   PopulateGameInfoInternal - Team #0 Player Count: 4
21:43:18.23   PopulateGameInfoInternal - Team #1 Player Count: 4
21:43:18.23   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:43:18.39   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:43:18.48   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        260, transmitAckLastTimeMS     103939 | Peer ---E- M#00000000 Sack00000031 NSack00000000 (C0.0% S:0.0) [  ]
21:43:36.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:43:46.00   RLINK -- local host PeerID 1 LOCL ack= 32 (447ms~67) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=31/31
21:43:46.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=2/2, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=4/4, PPrx=4/8, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=18/18, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:43:53.01   Activating screen: OnlineGameSetup
21:43:53.01   Activating screen: RelicOnlineTabs
21:43:57.88   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:43:57.88   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:43:57.88   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:43:57.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:43:57.88   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:43:57.88   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:43:57.88   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:43:57.88   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:43:57.88   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:43:57.88   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:43:57.88   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:43:57.88   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:43:57.88   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:43:57.88   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:43:57.88   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:43:57.88   PopulateGameInfoInternal - Team #0 Player Count: 4
21:43:57.88   PopulateGameInfoInternal - Team #1 Player Count: 4
21:43:57.88   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:43:57.88   RLINK -- WorldwidePartyService::SetMatchState - state 1 - updating server
21:43:57.88   RLINK -- WorldWidePartyService::SetVisible -- FALSE
21:43:57.88   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
21:43:57.88   RLINK -- WorldWidePartyService::SetJoinable -- FALSE
21:43:57.88   MatchSetup: Sending start game message!
21:43:57.88   GameSetupForm - Starting game
21:43:57.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:43:57.88   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
21:43:57.88   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
21:43:57.88   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
21:43:57.88   PopulateGameInfoInternal - Player #0 - [Id 510961, Type 0, Team 0, Race 6]
21:43:57.88   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
21:43:57.88   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
21:43:57.88   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 3]
21:43:57.88   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
21:43:57.88   PopulateGameInfoInternal - Player #6 - [Id -1, Type 1, Team 1, Race 7]
21:43:57.88   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 0, Race 2]
21:43:57.88   PopulateGameInfoInternal - Player #7 - [Id -1, Type 1, Team 1, Race 3]
21:43:57.88   PopulateGameInfoInternal - Team #0 Player Count: 4
21:43:57.88   PopulateGameInfoInternal - Team #1 Player Count: 4
21:43:57.89   PopulateGameInfoInternal - Forcing singleplayer skirmish
21:43:57.89   PopulateGameInfo - random seed:[1416969837], guid:[{a0218eb0-f2d4-4714-8c20-acc33eec2e27}], sync level:[0]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   Error loading [DATA:levelingCurve.lua]
21:43:57.89   MOD - Setting player (0) race to: allies_soviets
21:43:57.89   MOD - Setting player (0) race to: 2
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 0...
21:43:57.89       adding reward 'upgrade\upgrade_axis_geschutzwagen'
21:43:57.89       adding reward 'upgrade\upgrade_allied_hellcat'
21:43:57.89       adding reward 'upgrade\upgrade_panzer_elite_hotchkiss'
21:43:57.89       adding reward 'upgrade\upgrade_british_kangaroo'
21:43:57.89       adding reward 'upgrade\upgrade_axis_schwimmwagen'
21:43:57.89       adding reward 'upgrade\upgrade_panzer_elite_schwimmwagen'
21:43:57.89       adding reward 'upgrade\upgrade_allied_staghound'
21:43:57.89       adding reward 'upgrade\upgrade_allied_105'
21:43:57.89       adding reward 'upgrade\upgrade_british_comet'
21:43:57.89       adding reward 'upgrade\upgrade_panzer_elite_jagdpanzer'
21:43:57.89       adding reward 'upgrade\upgrade_panzer_elite_jagdtiger'
21:43:57.89       adding reward 'upgrade\upgrade_panzer_elite_nashorn'
21:43:57.89       adding reward 'upgrade\upgrade_axis_officer'
21:43:57.89       adding reward 'upgrade\upgrade_axis_tiger_ace'
21:43:57.89   MOD - Setting player (1) race to: allies
21:43:57.89   MOD - Setting player (1) race to: 1
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 1...
21:43:57.89   MOD - Setting player (2) race to: allies
21:43:57.89   MOD - Setting player (2) race to: 1
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 2...
21:43:57.89   MOD - Setting player (3) race to: allies_commonwealth
21:43:57.89   MOD - Setting player (3) race to: 0
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 3...
21:43:57.89   MOD - Setting player (4) race to: axis
21:43:57.89   MOD - Setting player (4) race to: 3
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 4...
21:43:57.89   MOD - Setting player (5) race to: axis_panzer_elite
21:43:57.89   MOD - Setting player (5) race to: 5
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 5...
21:43:57.89   MOD - Setting player (6) race to: axis_ostheer
21:43:57.89   MOD - Setting player (6) race to: 4
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 6...
21:43:57.89   MOD - Setting player (7) race to: axis_panzer_elite
21:43:57.89   MOD - Setting player (7) race to: 5
21:43:57.89   ModDllSetup::PlayerSetRewardUnits - playerIndex 7...
21:43:57.90   RLINK -- Sending matchinfo change #80
21:43:57.90   RLINK -- WorldwideAutomatchService::OnStartComplete - detected successful game start
21:43:57.90   RLINK -- Match Started - [00000000:0007cbf1 /steam/76561198023393842], slot =  0, ranking =   -1
21:43:57.90   APP -- Game Start
21:43:57.90   GAME -- Setting campaign state to 'coh'
21:43:57.90   GAME -- Closing state 'coh'
21:43:57.91   GAME -- Setting campaign state to 'cxp2'
21:43:57.91   GAME -- Closing state 'cxp2'
21:43:57.91   GAME -- Setting campaign state to 'cxp1'
21:43:57.91   GAME -- Closing state 'cxp1'
21:43:57.91   GAME -- Setting campaign state to 'dlc1'
21:43:57.91   GAME -- Closing state 'dlc1'
21:43:57.91   GAME -- Setting campaign state to 'dlc2'
21:43:57.91   GAME -- Closing state 'dlc2'
21:43:57.91   GAME -- Setting campaign state to 'dlc3'
21:43:57.91   GAME -- Closing state 'dlc3'
21:43:57.91   GAME -- Ending FE
21:43:57.91   UIFrontEnd - Unloading Front End
21:43:57.93   SOUND -- Shutting down ...
21:43:57.98   SOUND -- Shutdown completed!
21:43:57.99
21:43:57.99   GAME -- *** Beginning mission 8P_SCHLACHT_AM_RHEIN (1 Humans, 7 Computers) ***
21:43:57.99
21:43:57.99   GAME -- Recording game
21:43:58.02   Activating screen: GameLoadScreen
21:43:58.09   RLINK -- Rejecting packet type 0 that claims to come from ourself
21:43:58.14   THREAD: Hyper-Threading Technology Processors are not detected.
21:43:58.17   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        268, transmitAckLastTimeMS     143624 | Peer ---E- M#00000000 Sack00000033 NSack00000000 (C0.0% S:0.0) [  ]
21:43:58.18   SOUND -- Initializing ...
21:43:58.50   SOUND -- Initialization completed!
21:43:58.51   PHYSICS: detected processor(s) capable of handling 4 threads.
21:43:58.53   MOD -- Locating MOD for scenario 'DATA:Scenarios\MP\8P_SCHLACHT_AM_RHEIN'
21:43:58.53   MOD -- Using Mod 'Eastern_Front'
21:43:58.53   Unable to load/parse precache file [DATA:Scenarios\MP\8P_SCHLACHT_AM_RHEIN_precache.lua]
21:43:59.45   GameObjLoader - upgrading load_count from 0 to 1363
21:44:01.43   GameObjLoader - upgrading load_count from 1363 to 2304
21:44:01.48   PHYSICS -- Created node factory 'HVOK'
21:44:01.48   PHYSICS -- Created node factory 'DMMY'
21:44:05.99   GameObjLoader - upgrading load_count from 2304 to 2728
21:44:13.02   SPDx9 -- 2746MB available Texture Memory.  Unable to create 2x2 texture.
21:44:13.12   GameObjLoader - upgrading load_count from 2728 to 6137
21:44:16.35   GameObjLoader 0ab410b0 - resetting counters
21:44:16.35   GameObjLoader 0ab410b0 - LOAD_DONE
21:44:16.35   GAME - SessionSetup
21:44:16.35   GAME -- Can't initialize scenario pack more than once.
21:44:16.69   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
21:44:16.69   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 2048 x 2048
21:44:16.69   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
21:44:18.58   GAME - CreateGEWorld in 2235 ms
21:44:18.58   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
21:44:18.72   GAME - SessionSetup finished in 2375 ms
21:44:18.72   GAME - WaterReflectionManagerSetup
21:44:18.72   GAME - WaterReflectionManagerSetup finished in 0 ms
21:44:19.11   Regenerating ImpassMap data...
21:44:19.11       Impass Data was already valid, but regenerating...
21:44:19.33   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
21:44:19.33   Regenerating CanBuildMap data...
21:44:19.33   Generating CanShoot Map.
21:44:19.33   Pathfinder::Regenerate()...
21:44:19.39   Generating PathSectorMap...
21:44:19.76   Pathfinder::Regenerate() Done.
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x07e3dfd0
[Cope FactionFix] - hooked @0x77c2e2e8
[Cope FactionFix] - patched @0x77c2e540
[Cope FactionFix] - hooked @0x77c2e546
[Cope FactionFix] - patched @0x77c2d927
[Cope FactionFix] - hooked @0x77c2d927
[Cope FactionFix] - Hook installed
21:44:19.82   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
21:44:20.82   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:44:20.83   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:44:20.83   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:44:20.83   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:44:20.83   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:44:20.98   SPEECHMANAGER -- Loaded in 0.132838 seconds
21:44:21.78   GameObjLoader - upgrading load_count from 0 to 215
21:44:22.08   GameObjLoader 0ab41210 - resetting counters
21:44:22.08   GameObjLoader 0ab41210 - LOAD_DONE
21:44:22.55   PreloadResources took 412ms.
21:44:23.35   GAME -- Loading completed (25 seconds)
21:44:23.35   SIM -- Setting SyncErrorChecking level to Low
21:44:26.07   Activating screen: GameScreen
21:44:26.07   Activating screen: Decorators_widescreen
21:44:26.07   Activating screen: Taskbar_widescreen
21:44:26.07   Activating screen: SubtitleScreen
21:44:26.07   Activating screen: TextOverlayScreen
21:44:26.13   PerformanceRecorder::StartRecording for game size 8
21:44:26.13   GAME -- Starting mission...
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:26.80   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:44:31.53   Warning: non auto-match upgrade not found in AE, tuning
21:44:36.13   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
21:44:37.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:44:43.92   Activating screen: Command_Tree
21:44:45.43   Activating screen: Command_Branch
21:44:47.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:44:47.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=2/2, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=3/3, PPrx=3/6, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:44:48.64   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
21:45:38.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:45:48.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:45:48.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:46:28.88   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
21:46:39.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:46:49.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:46:49.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:47:40.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:47:50.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:47:50.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=20/20, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:48:12.46   Was already stealing a skeleton when told to steal another [flak38_sync].
21:48:41.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:48:47.93   Unabled to do upgrade, CANPRODUCE_NoResources
21:48:47.93   Unabled to do upgrade, CANPRODUCE_NoResources
21:48:48.93   Unabled to do upgrade, CANPRODUCE_NoResources
21:48:49.94   Unabled to do upgrade, CANPRODUCE_NoResources
21:48:51.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:48:51.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:49:42.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:49:52.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:49:52.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:50:43.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:50:53.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:50:53.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:51:44.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:51:54.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:51:54.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=20/20, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:52:45.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:52:55.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:52:55.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:52:55.92   Activating screen: Command_Branch
21:53:02.08   Activating screen: NewObjective_widescreen
21:53:30.35   Was already stealing a skeleton when told to steal another [88mmflakcannon_sync].
21:53:34.38   Was already stealing a skeleton when told to steal another [88mmflakcannon_sync].
21:53:46.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:53:56.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:53:56.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:54:47.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:54:57.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:54:57.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=20/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:55:46.95   Was already stealing a skeleton when told to steal another [mortar_target].
21:55:48.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:55:52.06   Was already stealing a skeleton when told to steal another [mortar_target].
21:55:58.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:55:58.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/20, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:56:49.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:56:59.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:56:59.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:57:24.56   Warning: binding repeat_5(Production Item: sbps\races\allies_soviets\vehicles\t-34-85) -- widget 'command_button_06' already occupied by 'repeat_1:Production Item: sbps\races\allies_soviets\vehicles\t-34'
21:57:26.36   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:26.36   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:26.36   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
21:57:29.55   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:29.55   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:29.55   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
21:57:30.41   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:30.41   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:30.41   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
21:57:38.68   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
21:57:38.68   Muting spew of bind updater.  Fix art and re-test.
21:57:50.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:58:00.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:58:00.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:58:17.88   Activating screen: Command_Branch
21:58:20.25   Activating screen: NewObjective_widescreen
21:58:24.64   Activating screen: Command_Branch
21:58:51.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:59:01.00   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
21:59:01.00   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=20/20, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
21:59:01.71   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
21:59:04.09   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
21:59:52.00   RLINK -- Transport - median kBPS [hi/cur] sent = 0.0/0.0, recvd = 0.0/0.0, #p/sec[s/r] = 0.0/0.0, max unsent 0, version err 0, merge 0
21:59:54.28   Was already stealing a skeleton when told to steal another [mortar_target].
21:59:59.40   Was already stealing a skeleton when told to steal another [mortar_target].
21:59:59.60   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
21:59:59.89   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
21:59:59.89   GAME -- SimulationController::Pause 0
22:00:02.01   RLINK -- local host PeerID 1 LOCL ack= 34 (436ms~25) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.2.134:6112;), pending=0, dead=0, RS#=33/33
22:00:02.01   RLINK -- MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/0, Pdel=0/0, drop=0/0, data=0/0, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=0/0, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=0/0, lb_p=19/19, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0
22:00:02.68   Activating screen: pause_menu
22:00:02.68   GAME -- SimulationController::Pause 1
22:00:07.82   Activating screen: prompt_generic
22:00:08.74   MOD -- Player Terry Lennox (network abort) (frame 7463) (KillPlayer)
22:00:08.74   GameApp::ReportStats
22:00:08.74   ReportMatchResults - onlyReportOnWin = 0
22:00:08.74   ReportMatchResults - SimID:1005, raceID:6, teamID:0, uid:0:510961, result:1:PS_ABORTED
22:00:08.74   ReportMatchResults - SimID:1007, raceID:0, teamID:0, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1004, raceID:0, teamID:0, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1006, raceID:2, teamID:0, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1000, raceID:1, teamID:1, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1001, raceID:3, teamID:1, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1002, raceID:7, teamID:1, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - SimID:1003, raceID:3, teamID:1, uid:4294967295:4294967295, AI player, ignoring
22:00:08.74   ReportMatchResults - reporting normal game results for match 0:15339529
22:00:08.74   ReportSimStats - storing simulation results for match 0:15339529
22:00:08.74   ModWorld::ReportSimStats complete:
22:00:08.74   8 player entries
22:00:08.74   0 player reward entries
22:00:08.74   0 player endgame entries
22:00:08.74   0 player skipped NIS entries
22:00:08.74   0 player production entries
22:00:08.74   0 player entity death entries
22:00:08.74   0 player resource entries
22:00:08.74   0 player objectives entries
22:00:08.74   0 player PBG stat entries
22:00:08.74   0 player PBG ability use entries
22:00:08.74   GameApp::Quit( exitValue = 0 )
22:00:08.76   GAME -- SimulationController::Pause 1
22:00:08.76   Activating screen: AppRestartingForm
22:00:08.76   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:00:08.76   Widget attempting to remove a non-existance listener. Widget:bkg_COH
22:00:08.76   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
22:00:08.76   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
22:00:08.76   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
22:00:08.76   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
22:00:08.76   GameApp::ShutFrontEnd
22:00:08.76   GameObj::ShutdownGameObj
22:00:08.76   Calling disconnect...
22:00:08.76   RLINK -- SessionID : ea1009 - Disconnect called with reasonID 1004 - aborted
22:00:08.76   RLINK -- WorldWidePartyService::SetJoinable -- FALSE
22:00:08.76   RLINK -- SetVisible called while !IsConnected
22:00:08.76   RLINK -- WorldwideLeaveAdvertisementAsync: Match id = 15339529 started, nothing to do
22:00:08.76   GAME -- Ending mission (Game over)
22:00:08.76   GameObjLoader 0ab41210 - Unload
22:00:08.76   GameObjLoader 0ab41210 - resetting counters
22:00:08.81   MOD -- Game Over at frame 7463
22:00:09.01   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        251, transmitAckLastTimeMS    1114470 | Peer ---E- M#00000000 Sack00000034 NSack00000000 (C0.0% S:0.0) [  ]
22:00:09.54   GameObjLoader 0ab410b0 - Unload
22:00:09.54   GameObjLoader 0ab410b0 - resetting counters
22:00:09.63   SOUND -- Shutting down ...
22:00:09.68   SOUND -- Shutdown completed!
22:00:09.69   ~FEAppListener - Flushing queued online notifications
22:00:10.36   DLLDriverLinker -- 2 DLL drivers found.
22:00:10.36   ActionDatabase : [2620] global actions, [94] dummy actions.
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000000
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000001
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000002
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000003
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000004
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000005
22:00:10.36   RLINK -- MessageInternal::DestroyChannel: Destroyed channel 00000006
22:00:10.36   RLINK -- NetworkManager::Destroy - exit allocation counts Network (cur/max) = 0 / 0, Session = 0 / 0
22:00:10.36   RLINK -- SessionID : ea1009 - Disconnect called with reasonID 116 - NetworkManagerInternal::Uninitalize()
22:00:10.36   RLINK -- WorldwideLeaveAdvertisementAsync: Match id = 15339529 started, nothing to do
22:00:10.36   RLINK -- Disconnect process already running
22:00:10.36   RLINK -- MessageInternal::PrepareMessage: Channel 00000002 does not exist
22:00:10.37   RLINK -- Session::SchedulePeerRemove - Scheduling peerID: 1 to disconnect, reasonCode:1004, reason:aborted
22:00:10.37   RLINK -- Session Destroy Peer Event - ReasonID: 1004 ReasonDebug: aborted
22:00:10.37   RLINK -- Session::GetEvent DestroyPeer success Peer 1 removed, reasonCode 1004, reasonDebug aborted
22:00:10.37   RLINK -- Session::DestroyPeer - deallocating peer 1
22:00:10.37   RLINK -- Session - Requested Disconnect for connectionID 1
22:00:10.37   RLINK -- Deallocated route ID=2 for PeerID 1 at WINaddr:192.168.2.134:6112;
22:00:10.37   RLINK -- Session - Requested Disconnect for connectionID 2
22:00:10.37   RLINK -- Closed route 2<>2 for PeerID 1 at WINaddr:192.168.2.134:6112;
22:00:10.37   RLINK -- WorldwideAdvertisementService::Process - EVENT_DESTROYPEER
22:00:10.37   RLINK -- peerremove - peerIDRemoved=[00000000:0007cbf1], reasonID=1004, reason debug hint - aborted
22:00:10.37   RLINK -- Session::GetState - info, session [15339529]'s state changed to [1:STATE_DISCONNECTED].
22:00:10.37   RLINK -- PeerRemoveAll - flushing local session peer data
22:00:10.37   RLINK -- Session::Reset with reason WorldwidePartyService::PeerRemoveAll
22:00:10.37   RLINK -- LeaveSessionInternal - no action taken, needLeave=0, service=0
22:00:10.37   RLINK -- Destroyed Matchinfo
22:00:10.37   RLINK -- DBG - _SockFree: socket 0/2580 sending graceful shutdown request. reason: SockCollection::DisconnectAll forceFree
22:00:10.37   RLINK -- DBG - _SockClose: socket 0/2580 initiating close
22:00:10.37   RLINK -- DBG - _SockClose: socket 0/2580 close complete. debugReason SockCollection::DisconnectAll forceFree
22:00:10.37   RLINK -- DBG - _SockFree: socket 0/2580 _SockFree complete
22:00:10.47   RLINK -- BT! - SockUnInit - sending shutdown notification & close with linger for all 0 active sockets
22:00:10.47   RLINK -- SessionManager::UnregisterSession - Unregistering session 109fd8d0
22:00:10.47   RLINK -- OnDestroyPartyNotification - partyID = [00000000:00ea1009], prevID = [ffffffff:ffffffff]
22:00:10.47   RLINK -- Transport - Largest sent is now 8
22:00:10.48   RLINK -- Transport - Largest received is now 8
22:00:11.32   RLINK -- MessageInternal::DestroyChannel: Destroyed channel fffffffd
22:00:11.32   RLINK -- AutomatchInternal: Fade to black
22:00:11.32   RLINK -- SessionManager::~SessionManager - uninitializing
22:00:11.32   RLINK -- RLink::ThreadFunction - Returning from the network thread function...
22:00:11.32   RLINK -- Transport::~Transport - shutting down transport
22:00:11.32   RLINK -- Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
22:00:11.32   RLINK -- Transport::~Connection - closing WINaddr:192.168.2.134:6112;,WINaddr:192.168.2.134:6112;
22:00:11.33   RLINK -- AsyncJobDriver::~AsyncJobDriver() - dynamically allocated job LogoutAsync is still running
22:00:11.33   RLINK -- WorldwideLoginService::~WorldwideLoginService - uninitializing
22:00:11.37   RLINK -- RLink::WorldwideLoginService::LongPoller::ThreadFunction - Returning from the network thread function...
22:00:11.37   RLINK -- AsyncJobDriver::~AsyncJobDriver() - dynamically allocated job HttpRequestAsync is still running
