-- Log file for all dbTracef messages --

23:05:05.89   AppInitNetwork::InitSteam: Initializing Steam...
23:05:05.89   AppInitNetwork::InitSteam: Steam has been initialized.
23:05:05.89   RLINK -- NetworkManager::Create - creating network manager
23:05:06.43   RLINK -- WorldwideLoginService::WorldwideLoginService - initializing
23:05:06.43   RLINK -- RLink::WorldwideLoginService::LongPoller::ThreadFunction - Entering network thread function...
23:05:06.46   RLINK -- WinTransport - CreateSocket exclusive broadcast socket was available.
23:05:06.46   RLINK -- WinTransport - CreateSocket listening for broadcasts on default port
23:05:06.48   RLINK -- WinTransport - Host Name: jeleznyak, aliases: , type=AF_INET, len=4
23:05:06.48   RLINK -- WinTransport - Host IP Address #0: 192.168.1.2
23:05:06.48   RLINK -- WinTransport - Interface #0: ip:192.168.1.2, broadcast:192.168.1.2, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
23:05:06.48   RLINK -- WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_BROADCAST IFF_LOOPBACK IFF_MULTICAST
23:05:06.48   RLINK -- Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:05:06.48   RLINK -- SessionManager - Peer Header Size = 15 bytes
23:05:06.48   RLINK -- SessionManager - Game Data overhead = 4 bytes
23:05:06.48   RLINK -- SessionManager - Proxy overhead = 7 bytes
23:05:06.48   RLINK -- AutomatchInternal: Instantiating
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel fffffffe
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel fffffffb
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel fffffffd
23:05:06.48   RLINK -- RLink::ThreadFunction - Entering network thread function...
23:05:06.48   Loaded 589 badwords from data:OnlineConfig\Badwords.lua
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000000
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000001
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000002
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000003
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000004
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000005
23:05:06.48   RLINK -- MessageInternal::CreateChannel: Created channel 00000006
23:05:06.48   GAME -- Available memory: 3007MB Physical RAM, 1886MB Pagefile, 2047 Virtual Address Space
23:05:08.43   DLLDriverLinker -- Adding driver 'spDx9.dll'.
23:05:08.43   DLLDriverLinker -- 1 DLL drivers found.
23:05:08.84   DLLDriverLinker -- 1 DLL drivers found.
23:05:09.00   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
23:05:09.00   GAME -- Resolution set to 1024x768 (fullscreen).
23:05:09.01   SPDx9 -- Driver Name = nv4_disp.dll  Desc = NVIDIA GeForce 9500 GT
23:05:09.01   SPDx9 -- Driver Vendor = 0x10DE  Device = 0x0640  SubSys = 0x829A1043  Rev = 0x00A1
23:05:09.01   SPDx9 -- Driver Version  Product = 0x0006  Version = 0x000E  SubVersion = 0x00  Build = 340.52
23:05:09.01   SPDx9 -- Driver GUID = {D7B71E3E-4500-11CF-277C-97A200C2CB35}
23:05:09.34   SPDx9 -- 1508MB available Texture Memory
23:05:09.35   ShaderDatabase: using shader profile [ps15]
23:05:10.14   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
23:05:10.54   GameObjLoader 0baf3bb0 - resetting counters
23:05:10.54   GameObjLoader 0baf3bb0 - Created loader
23:05:10.54   GameObjLoader 0baf6958 - resetting counters
23:05:10.54   GameObjLoader 0baf6958 - Created loader
23:05:10.54   GAME -- Beginning FE
23:05:10.54   UIFrontEnd - Loading Front End
23:05:10.54   THREAD: Hyper-Threading Technology Processors are not detected.
23:05:10.60   SOUND -- Initializing ...
23:05:10.71   INNIMapDCA Key not found: sp_speechducker::time
23:05:11.34   SOUND -- Initialization completed!
23:05:11.34   UIFrontEnd - Initializing Forms
23:05:13.31   CampaignFilter::BindFilterSpecificWidgets()
23:05:13.53   Activating screen: AppLoadingForm
23:05:13.53   SetupProductLoadingArt - choosing bgArt = 1 (gold=0)
23:05:14.54   GAME -- (worldmanager) Cannot find original scenario "4p_vyazma_challenge" referenced from data:scenarios\mp\challenge_vyazma.scenref
23:05:15.21   GAME -- Loaded campaign 'Высадка в Нормандии' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
23:05:15.21   GAME -- Loaded campaign 'Освобождение Кан' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
23:05:15.21   GAME -- Loaded campaign 'Операция "Огород"' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
23:05:15.21   GAME -- Loaded campaign 'Ущелье Фалаис' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
23:05:15.21   GAME -- Loaded campaign 'Дамба' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
23:05:15.21   GAME -- Loaded campaign '"Сердце Тигра"' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
23:05:15.59   GAME -- Using player profile JELEZNYAK
23:05:15.73   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
23:05:15.85   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
23:05:17.01   SetupProductLoadingArt - choosing bgArt = 1 (gold=0)
23:05:17.01   Activating screen: FEMovie
23:05:17.01   Activating screen: OnlineWidget
23:05:17.03   CRC & Version Info : 000002bc:a0fb939c:9233461d eastern_front:700:factionfix.dll 1
23:05:17.03   Logging in using Steam credentials...
23:05:17.03   Activating screen: FE_mm_01
23:05:17.06   SetupProductLoadingArt - choosing bgArt = 1 (gold=0)
23:05:17.06   GAME -- Setting campaign state to 'cxp2'
23:05:17.06   GAME -- Closing state 'cxp2'
23:05:17.06   GAME -- Setting campaign state to 'cxp1'
23:05:17.06   GAME -- Closing state 'cxp1'
23:05:17.06   GAME -- Setting campaign state to 'dlc1'
23:05:17.06   GAME -- Closing state 'dlc1'
23:05:17.06   GAME -- Setting campaign state to 'dlc2'
23:05:17.06   GAME -- Closing state 'dlc2'
23:05:17.06   GAME -- Setting campaign state to 'dlc3'
23:05:17.06   GAME -- Closing state 'dlc3'
23:05:17.06   RLINK -- Requesting ticket
23:05:17.06   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.15   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.17   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.18   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.18   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.20   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.20   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.21   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.21   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.23   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.23   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.26   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.28   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.28   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.29   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.31   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.31   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.32   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.34   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.34   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.35   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.35   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.37   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.39   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.39   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.40   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.40   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.42   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.42   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.43   RLINK -- SteamAuthManager::GetAuthToken state ID : 1
23:05:17.45   RLINK -- OnRequest app ticket returned N
23:05:17.45   RLINK -- SteamAuth received ticket at t=10967
23:05:17.45   RLINK -- SteamAuthManager::GetAuthToken state ID : 2
23:05:18.50   RLINK -- Found 1 profiles for account /steam/76561198102964124
23:05:18.50   RLINK -- Found profile: /steam/76561198102964124
23:05:18.51   THREAD: Hyper-Threading Technology Processors are not detected.
23:05:18.60   Activating screen: MessageBoxPopup
23:05:18.60   RLINK -- starting online hosting
23:05:18.62   RLINK -- SlotManager::GetStringFromSlots: compressed = 25 bytes / 350 bytes
23:05:21.06   RLINK -- BT! - SockInit: SOCK_FD_SET_SIZE = 64
23:05:21.06   RLINK -- DBG - SockConnect: 0/s->stHandle=2960
23:05:21.06   RLINK -- DBG - SockConnect: 0/2960 connect deferred (in progress)
23:05:21.20   RLINK -- DBG - SockAnimateAll: socket 0/2960 connection complete.
23:05:21.39   RLINK -- battleserverrelay - Connected: 
Connection [ 1/ 1] - local=192.168.1.2:4677, remote=54.208.245.53:50007, type=CONNECT, timeTookToConnectMS=325, silentTimeMS=0, lastSockError=0
23:05:21.40   RLINK -- Session::Initialize - info, initializing session object, using threads.
23:05:21.40   RLINK -- SessionManager::RegisterSession - Registering RL_NEW session 0c52c850
23:05:21.40   RLINK -- Created Matchinfo for sessionID 12559819
23:05:21.40   RLINK -- OnJoinAdvertisementSuccess - joined online match, server leave notification required
23:05:21.40   RLINK -- starting local hosting
23:05:21.40   RLINK -- Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:05:21.40   RLINK -- Allocated route ID=0 for PeerID 1 at WINaddr:192.168.1.2:6112;
23:05:21.40   RLINK -- Transport::OpenInternal request to WINaddr:192.168.1.2:6112;
23:05:21.40   RLINK -- Session::Host sid = BFA5CB, hostURL = , local addresses = WINaddr:192.168.1.2:6112;
23:05:21.40   RLINK -- Session::GetState - info, session [12559819]'s state changed to [2:STATE_CONNECTING].
23:05:21.40   RLINK -- ValidateCustomData: called with 491 bytes of custom data
23:05:21.40   RLINK -- Host accepted Peer 1 into the match at address list=WINaddr:192.168.1.2:6112;, routes=WINaddr:192.168.1.2:6112;
23:05:21.40   RLINK -- WorldwideAdvertisementService::Process - EVENT_NEWPEER
23:05:21.42   RLINK -- Session::GetState - info, session [12559819]'s state changed to [3:STATE_CONNECTED].
23:05:21.42   RLINK -- Sending matchinfo change #2
23:05:21.42   RLINK -- Session Connection Event - ReasonID: 0 ReasonDebug: SessionOperationInfo::SUCCESS
23:05:21.42   RLINK -- HostAsync - got operation info 0:SessionOperationInfo::SUCCESS
23:05:21.42   RLINK -- hosting - Session is connected
23:05:21.43   RLINK -- local host PeerID 1 LOCL ack=  0 (  0ms~0) unack=  3, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=0/2
23:05:21.43   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
23:05:21.45   RLINK -- HostAsync - completed with HostResult = 0
23:05:21.45   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
23:05:21.45   Activating screen: OnlineGameSetup
23:05:21.46   GameSetupForm::SetScenarioFile -- 6p_kalach
23:05:21.46   GameSetupForm::OnMatchCategorySelected
23:05:21.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:21.54   GameSetupForm::OnMapSelected
23:05:21.54   GameSetupForm::SetScenarioFile -- 6p_kalach
23:05:21.56   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:21.56   RLINK -- WorldwideAdvertisementService::PublishSession -- Publishing Visible match
23:05:21.56   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:21.59   Activating screen: RelicOnlineChat
23:05:21.59   RLINK -- Session - rcv'd Join request - address noaddr/relay/PID=EFB48427395D8306 in use by existing peer (ignoring)
23:05:21.59   RLINK -- Session::PollTransportEvents AddPeerMessage ignored, peer 1 already in m_peers
23:05:21.60   Activating screen: RelicOnlineNewsScreen
23:05:21.60   Activating screen: RelicOnlineStatsScreen
23:05:21.60   Activating screen: Achievements
23:05:21.60   GAME -- Setting campaign state to 'cxp2'
23:05:21.60   GAME -- Closing state 'cxp2'
23:05:21.60   GAME -- Setting campaign state to 'cxp1'
23:05:21.60   GAME -- Closing state 'cxp1'
23:05:21.60   GAME -- Setting campaign state to 'dlc1'
23:05:21.60   GAME -- Closing state 'dlc1'
23:05:21.60   GAME -- Setting campaign state to 'dlc2'
23:05:21.60   GAME -- Closing state 'dlc2'
23:05:21.60   GAME -- Setting campaign state to 'dlc3'
23:05:21.60   GAME -- Closing state 'dlc3'
23:05:21.60   GAME -- Setting campaign state to 'dlc1'
23:05:21.60   GAME -- Closing state 'dlc1'
23:05:21.62   Activating screen: GameHistory
23:05:21.62   GAME -- Setting campaign state to 'cxp2'
23:05:21.62   GAME -- Closing state 'cxp2'
23:05:21.62   GAME -- Setting campaign state to 'cxp1'
23:05:21.62   GAME -- Closing state 'cxp1'
23:05:21.62   GAME -- Setting campaign state to 'dlc1'
23:05:21.62   GAME -- Closing state 'dlc1'
23:05:21.62   GAME -- Setting campaign state to 'dlc2'
23:05:21.62   GAME -- Closing state 'dlc2'
23:05:21.62   GAME -- Setting campaign state to 'dlc3'
23:05:21.62   GAME -- Closing state 'dlc3'
23:05:21.62   Activating screen: OnlineGameSetup
23:05:21.62   Activating screen: RelicOnlineTabs
23:05:21.62   GameSetupForm::OnAdvertisementEvent - AET_Host - Ignorning match making party event.
23:05:21.62   RLINK -- WorldwideAutomatchService::OnHostComplete - automatcher is no longer active - stopPollPending 0 automatchPollID 18446744073709551615
23:05:21.62   RLINK -- Sending matchinfo change #41
23:05:21.64   RLINK -- SlotManager::GetStringFromSlots: compressed = 240 bytes / 761 bytes
23:05:21.71   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:21.71   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:21.71   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:21.71   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:21.73   PopulateGameInfoInternal - Player #0 - [Id 25681, Type 0, Team 0, Race 0]
23:05:21.73   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:21.73   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:21.73   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:21.73   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:21.73   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
23:05:21.73   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:21.73   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:21.73   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:21.76   GAME -- Setting campaign state to 'cxp2'
23:05:21.76   GAME -- Closing state 'cxp2'
23:05:21.76   GAME -- Setting campaign state to 'cxp1'
23:05:21.76   GAME -- Closing state 'cxp1'
23:05:21.76   GAME -- Setting campaign state to 'dlc1'
23:05:21.76   GAME -- Closing state 'dlc1'
23:05:21.76   GAME -- Setting campaign state to 'dlc2'
23:05:21.76   GAME -- Closing state 'dlc2'
23:05:21.76   GAME -- Setting campaign state to 'dlc3'
23:05:21.76   GAME -- Closing state 'dlc3'
23:05:21.78   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:21.85   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:21.89   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        259, transmitAckLastTimeMS      15411 | Peer ---E- M#00000000 Sack00000003 NSack00000000 (C0.0% S:0.0) [  ]
23:05:22.76   Activating screen: RaceSelectionPopup
23:05:23.79   RLINK -- Sending matchinfo change #42
23:05:23.81   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:23.81   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:23.81   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:23.81   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:23.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:23.84   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:23.84   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:23.84   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:23.85   PopulateGameInfoInternal - Player #0 - [Id 25681, Type 0, Team 0, Race 6]
23:05:23.85   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:23.85   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:23.85   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:23.85   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:23.85   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
23:05:23.85   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:23.85   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:23.85   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:24.00   RLINK -- Sending matchinfo change #43
23:05:24.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:24.04   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:24.04   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:24.04   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:24.04   PopulateGameInfoInternal - Player #0 - [Id 25681, Type 0, Team 0, Race 6]
23:05:24.04   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:24.04   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:24.04   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:24.04   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:24.04   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 1]
23:05:24.04   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:24.04   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:24.04   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:24.07   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:24.25   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        253, transmitAckLastTimeMS      17772 | Peer ---E- M#00000000 Sack00000005 NSack00000000 (C0.0% S:0.0) [  ]
23:05:24.28   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:25.25   Activating screen: DynamicPopupMenu
23:05:26.10   RLINK -- Sending matchinfo change #46
23:05:26.12   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:26.12   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:26.12   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:26.12   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:26.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:26.18   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:26.18   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:26.18   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:26.18   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 6]
23:05:26.18   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:26.18   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:26.18   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:26.18   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:26.18   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 1]
23:05:26.18   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:26.18   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:26.18   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:26.28   RLINK -- Sending matchinfo change #47
23:05:26.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:26.31   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:26.31   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:26.31   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:26.31   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 6]
23:05:26.31   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:26.31   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:26.31   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:26.31   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:26.31   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 1]
23:05:26.31   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:26.31   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:26.31   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:26.34   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:26.54   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        267, transmitAckLastTimeMS      20064 | Peer ---E- M#00000000 Sack00000007 NSack00000000 (C0.0% S:0.0) [  ]
23:05:26.54   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:26.70   Activating screen: RaceSelectionPopup
23:05:27.73   RLINK -- Sending matchinfo change #48
23:05:27.75   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:27.75   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:27.75   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:27.75   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:27.78   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:27.78   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:27.78   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:27.78   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:27.78   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 6]
23:05:27.78   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:27.78   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:27.78   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:27.78   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:27.78   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:27.78   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:27.78   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:27.78   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:27.85   RLINK -- Sending matchinfo change #49
23:05:27.90   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:27.90   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:27.90   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:27.90   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:27.90   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 6]
23:05:27.90   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:27.90   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:27.90   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:27.90   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:27.90   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:27.90   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:27.90   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:27.90   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:27.98   RLINK -- SlotManager::GetStringFromSlots: compressed = 253 bytes / 761 bytes
23:05:27.98   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:28.07   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:28.12   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        252, transmitAckLastTimeMS      21637 | Peer ---E- M#00000000 Sack00000009 NSack00000000 (C0.0% S:0.0) [  ]
23:05:28.43   Activating screen: DynamicPopupMenu
23:05:29.71   RLINK -- Sending matchinfo change #50
23:05:29.73   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:29.73   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:29.73   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:29.73   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:29.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:29.78   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:29.78   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:29.78   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:29.78   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:29.78   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:29.78   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:29.78   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:29.78   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:29.78   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:29.78   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:29.78   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:29.78   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:29.85   RLINK -- Sending matchinfo change #51
23:05:29.90   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:29.90   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:29.90   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:29.90   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:29.90   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:29.90   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:29.90   PopulateGameInfoInternal - Player #1 - [Id -1, Type 6, Team 0, Race 0]
23:05:29.90   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:29.90   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:29.90   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:29.90   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:29.90   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:29.90   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:30.00   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:30.09   RLINK -- SlotManager::GetStringFromSlots: compressed = 254 bytes / 761 bytes
23:05:30.12   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        251, transmitAckLastTimeMS      23638 | Peer ---E- M#00000000 Sack00000011 NSack00000000 (C0.0% S:0.0) [  ]
23:05:30.12   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:30.17   Activating screen: DynamicPopupMenu
23:05:31.50   Activating screen: DynamicPopupMenu
23:05:32.29   RLINK -- Sending matchinfo change #52
23:05:32.31   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:32.31   RLINK -- WorldWidePartyService::SetVisible -- TRUE
23:05:32.31   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:32.31   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:32.31   RLINK -- SlotManager::GetStringFromSlots: compressed = 254 bytes / 761 bytes
23:05:32.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:32.32   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:32.32   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:32.32   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:32.34   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:32.34   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:32.34   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:32.34   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:32.34   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:32.34   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:32.34   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:32.34   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:32.34   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:32.46   RLINK -- Sending matchinfo change #53
23:05:32.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:32.51   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:32.51   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:32.51   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:32.51   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:32.51   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:32.51   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:32.51   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:32.51   PopulateGameInfoInternal - Player #2 - [Id -1, Type 6, Team 0, Race 0]
23:05:32.51   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:32.51   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:32.51   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:32.51   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:32.54   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:32.68   Activating screen: DynamicPopupMenu
23:05:32.71   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:32.73   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        262, transmitAckLastTimeMS      26257 | Peer ---E- M#00000000 Sack00000013 NSack00000000 (C0.0% S:0.0) [  ]
23:05:33.46   RLINK -- Sending matchinfo change #54
23:05:33.48   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:33.48   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:33.48   RLINK -- WorldwideAdvertisementService::PublishSession -- Delisting Invisible match
23:05:33.48   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:33.48   RLINK -- SlotManager::GetStringFromSlots: compressed = 255 bytes / 761 bytes
23:05:33.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:33.51   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:33.51   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:33.51   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:33.51   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.51   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:33.51   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.51   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:33.51   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.51   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:33.51   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:33.51   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:33.51   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:33.60   RLINK -- Sending matchinfo change #56
23:05:33.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:33.65   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:33.65   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:33.65   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:33.65   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.65   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:33.65   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.65   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:33.65   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:33.65   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:33.65   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:33.65   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:33.65   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:33.76   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:33.87   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:33.87   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        267, transmitAckLastTimeMS      27402 | Peer ---E- M#00000000 Sack00000015 NSack00000000 (C0.0% S:0.0) [  ]
23:05:35.39   Activating screen: RaceSelectionPopup
23:05:37.12   RLINK -- Sending matchinfo change #57
23:05:37.12   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:37.12   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:37.12   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:37.14   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:37.14   RLINK -- SlotManager::GetStringFromSlots: compressed = 258 bytes / 761 bytes
23:05:37.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:37.15   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:37.15   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:37.15   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:37.17   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:37.17   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:37.17   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:37.17   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:37.17   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:37.17   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:37.17   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:37.17   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:37.17   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:37.28   RLINK -- Sending matchinfo change #58
23:05:37.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:37.32   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:37.32   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:37.32   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:37.32   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:37.32   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:37.32   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 0]
23:05:37.32   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:37.32   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:37.32   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:37.32   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:37.32   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:37.32   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:37.35   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:37.54   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:37.54   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        270, transmitAckLastTimeMS      31072 | Peer ---E- M#00000000 Sack00000017 NSack00000000 (C0.0% S:0.0) [  ]
23:05:37.64   Activating screen: RaceSelectionPopup
23:05:38.39   RLINK -- Sending matchinfo change #59
23:05:38.39   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:38.39   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:38.39   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:38.39   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:38.40   RLINK -- SlotManager::GetStringFromSlots: compressed = 259 bytes / 761 bytes
23:05:38.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:38.42   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:38.42   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:38.42   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:38.42   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:38.42   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:38.42   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:38.42   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:38.42   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:38.42   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:38.42   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:38.42   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:38.42   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:38.53   RLINK -- Sending matchinfo change #60
23:05:38.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:38.57   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:38.57   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:38.57   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:38.57   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:38.57   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:38.57   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:38.57   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:38.57   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:38.57   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:38.57   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:38.57   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:38.57   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:38.62   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:38.78   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        261, transmitAckLastTimeMS      32308 | Peer ---E- M#00000000 Sack00000019 NSack00000000 (C0.0% S:0.0) [  ]
23:05:38.79   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:40.34   RLINK -- Sending matchinfo change #61
23:05:40.34   RLINK -- SlotManager::GetStringFromSlots: compressed = 259 bytes / 761 bytes
23:05:40.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:40.37   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 0]
23:05:40.37   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:40.37   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:40.37   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:40.37   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:40.37   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:40.37   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:40.37   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:40.37   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:40.37   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:40.37   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:40.37   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:40.60   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        265, transmitAckLastTimeMS      34126 | Peer ---E- M#00000000 Sack00000020 NSack00000000 (C0.0% S:0.0) [  ]
23:05:40.62   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:41.65   RLINK -- Sending matchinfo change #62
23:05:41.65   RLINK -- SlotManager::GetStringFromSlots: compressed = 259 bytes / 761 bytes
23:05:41.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:41.75   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:41.75   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 0]
23:05:41.75   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:41.75   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:41.75   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:41.75   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:41.75   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:41.75   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:41.75   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:41.75   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:41.75   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:41.75   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:41.90   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:41.90   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        263, transmitAckLastTimeMS      35432 | Peer ---E- M#00000000 Sack00000021 NSack00000000 (C0.0% S:0.0) [  ]
23:05:43.53   RLINK -- Sending matchinfo change #63
23:05:43.54   RLINK -- SlotManager::GetStringFromSlots: compressed = 259 bytes / 761 bytes
23:05:43.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:43.57   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:43.57   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:43.57   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:43.59   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:43.59   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 1]
23:05:43.59   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:43.59   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:43.59   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:43.59   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:43.59   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:43.59   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:43.59   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:43.75   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:43.79   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        266, transmitAckLastTimeMS      37322 | Peer ---E- M#00000000 Sack00000022 NSack00000000 (C0.0% S:0.0) [  ]
23:05:44.68   Activating screen: DynamicPopupMenu
23:05:45.40   RLINK -- Sending matchinfo change #64
23:05:45.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:45.40   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:45.40   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:45.42   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:45.42   RLINK -- SlotManager::GetStringFromSlots: compressed = 260 bytes / 761 bytes
23:05:45.45   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:45.45   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:45.45   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:45.45   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:45.45   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:45.45   PopulateGameInfoInternal - Player #3 - Closed
23:05:45.45   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:45.45   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:45.45   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:45.45   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:45.45   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:45.45   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:45.45   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:45.54   RLINK -- Sending matchinfo change #65
23:05:45.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:45.57   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:45.57   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:45.57   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:45.59   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:45.59   PopulateGameInfoInternal - Player #3 - Closed
23:05:45.59   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:45.59   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 1]
23:05:45.59   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:45.59   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:45.59   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:45.59   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:45.59   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:45.67   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:45.78   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:45.81   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        266, transmitAckLastTimeMS      39331 | Peer ---E- M#00000000 Sack00000024 NSack00000000 (C0.0% S:0.0) [  ]
23:05:45.85   Activating screen: DynamicPopupMenu
23:05:46.53   RLINK -- Sending matchinfo change #66
23:05:46.54   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:46.54   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:46.54   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:46.54   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:46.54   RLINK -- SlotManager::GetStringFromSlots: compressed = 256 bytes / 761 bytes
23:05:46.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:46.57   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:46.57   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:46.57   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:46.59   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:46.59   PopulateGameInfoInternal - Player #3 - Closed
23:05:46.59   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:46.59   PopulateGameInfoInternal - Player #4 - Closed
23:05:46.59   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:46.59   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:46.59   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:46.59   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:46.59   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:46.67   RLINK -- Sending matchinfo change #67
23:05:46.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:46.70   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:46.70   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:46.70   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:46.70   PopulateGameInfoInternal - Player #0 - [Id -1, Type 1, Team 0, Race 2]
23:05:46.70   PopulateGameInfoInternal - Player #3 - Closed
23:05:46.70   PopulateGameInfoInternal - Player #1 - [Id -1, Type 1, Team 0, Race 2]
23:05:46.70   PopulateGameInfoInternal - Player #4 - Closed
23:05:46.70   PopulateGameInfoInternal - Player #2 - [Id -1, Type 1, Team 0, Race 0]
23:05:46.70   PopulateGameInfoInternal - Player #5 - [Id 25681, Type 0, Team 1, Race 5]
23:05:46.70   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:46.70   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:46.70   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:46.79   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:46.89   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:46.93   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        264, transmitAckLastTimeMS      40451 | Peer ---E- M#00000000 Sack00000026 NSack00000000 (C0.0% S:0.0) [  ]
23:05:49.09   RLINK -- Sending matchinfo change #85
23:05:49.10   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:05:49.10   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:05:49.10   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:05:49.10   GetMaxFrameTimeFromProfile: players=6 expected FPS=7.474446, bars=1, max avg=0.088, sd=0.046, 5 samples =  0.14 0.12 0.08 0.09 0.01
23:05:49.10   RLINK -- SlotManager::GetStringFromSlots: compressed = 260 bytes / 761 bytes
23:05:49.12   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:49.14   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:49.14   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:49.14   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:49.14   PopulateGameInfoInternal - Player #0 - Closed
23:05:49.14   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 2]
23:05:49.14   PopulateGameInfoInternal - Player #1 - Closed
23:05:49.14   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 2]
23:05:49.14   PopulateGameInfoInternal - Player #2 - [Id 25681, Type 0, Team 0, Race 5]
23:05:49.14   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 0]
23:05:49.14   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:49.14   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:49.14   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:49.21   RLINK -- Sending matchinfo change #86
23:05:49.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:05:49.26   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:05:49.26   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:05:49.26   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:05:49.26   PopulateGameInfoInternal - Player #0 - Closed
23:05:49.26   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 2]
23:05:49.26   PopulateGameInfoInternal - Player #1 - Closed
23:05:49.26   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 2]
23:05:49.26   PopulateGameInfoInternal - Player #2 - [Id 25681, Type 0, Team 0, Race 5]
23:05:49.26   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 0]
23:05:49.26   PopulateGameInfoInternal - Team #0 Player Count: 3
23:05:49.26   PopulateGameInfoInternal - Team #1 Player Count: 3
23:05:49.26   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:05:49.35   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:49.46   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:05:49.50   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        269, transmitAckLastTimeMS      43012 | Peer ---E- M#00000000 Sack00000028 NSack00000000 (C0.0% S:0.0) [  ]
23:06:05.67   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:06:05.67   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:06:05.67   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:06:05.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:06:05.68   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:06:05.68   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:06:05.68   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:06:05.68   PopulateGameInfoInternal - Player #0 - Closed
23:06:05.68   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 2]
23:06:05.68   PopulateGameInfoInternal - Player #1 - Closed
23:06:05.68   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 2]
23:06:05.68   PopulateGameInfoInternal - Player #2 - [Id 25681, Type 0, Team 0, Race 5]
23:06:05.68   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 0]
23:06:05.68   PopulateGameInfoInternal - Team #0 Player Count: 3
23:06:05.68   PopulateGameInfoInternal - Team #1 Player Count: 3
23:06:05.68   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:06:05.68   RLINK -- WorldwidePartyService::SetMatchState - state 1 - updating server
23:06:05.68   RLINK -- WorldWidePartyService::SetVisible -- FALSE
23:06:05.68   RLINK -- WorldwideAdvertisementService::PublishSession -- Already Published
23:06:05.68   RLINK -- WorldWidePartyService::SetJoinable -- FALSE
23:06:05.68   MatchSetup: Sending start game message!
23:06:05.68   GameSetupForm - Starting game
23:06:05.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:06:05.68   PopulateGameInfoInternal - Setting Option #0 - [Id 1397509955, Value 1]
23:06:05.68   PopulateGameInfoInternal - Setting Option #1 - [Id 1381192532, Value 1]
23:06:05.68   PopulateGameInfoInternal - Setting Option #2 - [Id 1448105035, Value 1]
23:06:05.68   PopulateGameInfoInternal - Player #0 - Closed
23:06:05.68   PopulateGameInfoInternal - Player #3 - [Id -1, Type 1, Team 1, Race 2]
23:06:05.68   PopulateGameInfoInternal - Player #1 - Closed
23:06:05.68   PopulateGameInfoInternal - Player #4 - [Id -1, Type 1, Team 1, Race 2]
23:06:05.68   PopulateGameInfoInternal - Player #2 - [Id 25681, Type 0, Team 0, Race 5]
23:06:05.68   PopulateGameInfoInternal - Player #5 - [Id -1, Type 1, Team 1, Race 0]
23:06:05.68   PopulateGameInfoInternal - Team #0 Player Count: 3
23:06:05.68   PopulateGameInfoInternal - Team #1 Player Count: 3
23:06:05.68   PopulateGameInfoInternal - Forcing singleplayer skirmish
23:06:05.68   PopulateGameInfo - random seed:[1410721565], guid:[{db2fa217-4fd1-4565-8aa4-1f3457aef3ef}], sync level:[0]
23:06:05.68   Error loading [DATA:levelingCurve.lua]
23:06:05.70   Error loading [DATA:levelingCurve.lua]
23:06:05.70   Error loading [DATA:levelingCurve.lua]
23:06:05.70   Error loading [DATA:levelingCurve.lua]
23:06:05.70   MOD - Setting player (0) race to: allies_soviets
23:06:05.70   MOD - Setting player (0) race to: 2
23:06:05.70   ModDllSetup::PlayerSetRewardUnits - playerIndex 0...
23:06:05.70       adding reward 'upgrade\upgrade_axis_geschutzwagen'
23:06:05.70       adding reward 'upgrade\upgrade_panzer_elite_hotchkiss'
23:06:05.70       adding reward 'upgrade\upgrade_british_kangaroo'
23:06:05.70       adding reward 'upgrade\upgrade_axis_schwimmwagen'
23:06:05.70       adding reward 'upgrade\upgrade_british_comet'
23:06:05.70       adding reward 'upgrade\upgrade_panzer_elite_jagdpanzer'
23:06:05.70       adding reward 'upgrade\upgrade_panzer_elite_jagdtiger'
23:06:05.70       adding reward 'upgrade\upgrade_panzer_elite_nashorn'
23:06:05.70       adding reward 'upgrade\upgrade_axis_officer'
23:06:05.70       adding reward 'upgrade\upgrade_axis_tiger_ace'
23:06:05.70       adding reward 'upgrade\upgrade_british_staghound'
23:06:05.70   MOD - Setting player (1) race to: allies_commonwealth
23:06:05.70   MOD - Setting player (1) race to: 0
23:06:05.70   ModDllSetup::PlayerSetRewardUnits - playerIndex 1...
23:06:05.70   MOD - Setting player (2) race to: allies_commonwealth
23:06:05.70   MOD - Setting player (2) race to: 0
23:06:05.70   ModDllSetup::PlayerSetRewardUnits - playerIndex 2...
23:06:05.70   MOD - Setting player (3) race to: allies
23:06:05.70   MOD - Setting player (3) race to: 1
23:06:05.70   ModDllSetup::PlayerSetRewardUnits - playerIndex 3...
23:06:05.71   RLINK -- Sending matchinfo change #87
23:06:05.71   RLINK -- WorldwideAutomatchService::OnStartComplete - detected successful game start
23:06:05.71   RLINK -- Match Started - [00000000:00006451 /steam/76561198102964124], slot =  4, ranking =   -1
23:06:05.75   APP -- Game Start
23:06:05.75   GAME -- Setting campaign state to 'cxp2'
23:06:05.75   GAME -- Closing state 'cxp2'
23:06:05.75   GAME -- Setting campaign state to 'cxp1'
23:06:05.75   GAME -- Closing state 'cxp1'
23:06:05.75   GAME -- Setting campaign state to 'dlc1'
23:06:05.75   GAME -- Closing state 'dlc1'
23:06:05.75   GAME -- Setting campaign state to 'dlc2'
23:06:05.75   GAME -- Closing state 'dlc2'
23:06:05.76   GAME -- Setting campaign state to 'dlc3'
23:06:05.76   GAME -- Closing state 'dlc3'
23:06:05.76   GAME -- Ending FE
23:06:05.76   UIFrontEnd - Unloading Front End
23:06:05.79   SOUND -- Shutting down ...
23:06:05.84   SOUND -- Shutdown completed!
23:06:05.85
23:06:05.85   GAME -- *** Beginning mission 6p_kalach (1 Humans, 3 Computers) ***
23:06:05.85
23:06:05.98   RLINK -- SENDING FORCED ACK from Peer 1 to Peer 1 - timeSinceLastAckMS        260, transmitAckLastTimeMS      59502 | Peer ---E- M#00000000 Sack00000030 NSack00000000 (C0.0% S:0.0) [  ]
23:06:06.04   GAME -- Recording game
23:06:06.10   Activating screen: GameLoadScreen
23:06:06.10   RLINK -- Rejecting packet type 0 that claims to come from ourself
23:06:06.40   THREAD: Hyper-Threading Technology Processors are not detected.
23:06:06.42   SOUND -- Initializing ...
23:06:07.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
23:06:07.10   SOUND -- Initialization completed!
23:06:07.10   PHYSICS: detected processor(s) capable of handling 2 threads.
23:06:07.12   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_kalach'
23:06:07.12   MOD -- Using Mod 'Eastern_Front'
23:06:07.12   Unable to load/parse precache file [DATA:scenarios\mp\6p_kalach_precache.lua]
23:06:09.04   GameObjLoader - upgrading load_count from 0 to 1343
23:06:14.00   GameObjLoader - upgrading load_count from 1343 to 2231
23:06:14.21   PHYSICS -- Created node factory 'HVOK'
23:06:14.21   PHYSICS -- Created node factory 'DMMY'
23:06:22.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:06:22.01   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=28/29, mdat=0/0, voip=0/0, rchk=0/0, nudg=0/0, Thdr=0/0, Peer=45/49, PPrx=44/90, ping=0/0, Pfrg=0/0, rely=0/1, lb_p=11/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
23:06:32.60   GameObjLoader - upgrading load_count from 2131 to 5798
23:06:41.67   RLINK --         11 ms to complete - SockAnimateAll - process sockFdSet.
23:06:45.79   GameObjLoader 0baf3bb0 - resetting counters
23:06:45.79   GameObjLoader 0baf3bb0 - LOAD_DONE
23:06:45.79   GAME - SessionSetup
23:06:46.26   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
23:06:46.26   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
23:06:46.26   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
23:06:49.54   GAME - CreateGEWorld in 3740 ms
23:06:49.56   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
23:06:49.75   GAME - SessionSetup finished in 3942 ms
23:06:49.75   RLINK -- NetworkManager::DispatchEvents() - Warning - Time between calls was 3943 ms
23:06:49.76   GAME - WaterReflectionManagerSetup
23:06:49.78   GAME - WaterReflectionManagerSetup finished in 10 ms
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x05451b38
[Cope FactionFix] - hooked @0x08f1e2e8
[Cope FactionFix] - patched @0x08f1e540
[Cope FactionFix] - hooked @0x08f1e546
[Cope FactionFix] - patched @0x08f1d927
[Cope FactionFix] - hooked @0x08f1d927
[Cope FactionFix] - Hook installed
23:06:50.06   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilateNoPop.scar] succeeded.
23:06:50.64   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:06:50.64   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:06:50.65   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:06:50.65   MOD -- Player  (unused player) (frame 0) (KillPlayer)
23:06:52.35   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:06:52.35   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:06:52.35   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:06:52.35   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:06:52.35   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:06:52.65   SPEECHMANAGER -- Loaded in 0.236126 seconds
23:06:54.50   GameObjLoader - upgrading load_count from 0 to 394
23:06:56.14   GameObjLoader 0baf6958 - resetting counters
23:06:56.14   GameObjLoader 0baf6958 - LOAD_DONE
23:06:57.06   PreloadResources took 840ms.
23:06:57.21   GAME -- Loading completed (51 seconds)
23:06:57.21   SIM -- Setting SyncErrorChecking level to Low
23:06:58.14   Activating screen: GameScreen
23:06:58.14   Activating screen: Decorators
23:06:58.14   Activating screen: Taskbar
23:06:58.14   Activating screen: SubtitleScreen
23:06:58.14   Activating screen: TextOverlayScreen
23:06:58.35   PerformanceRecorder::StartRecording for game size 4
23:06:58.35   GAME -- Starting mission...
23:06:59.10   MOD -- Player
23:06:59.10   MOD -- Player
23:06:59.10   MOD -- Player
23:07:02.17   WorldViewSM::ProcessWVEvents - setting pause to 1
23:07:02.17   GAME -- SimulationController::Pause 0
23:07:04.60   Activating screen: Command_Tree
23:07:05.28   Activating screen: Command_Branch
23:07:07.06   Activating screen: Command_Branch
23:07:08.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
23:07:08.98   WorldViewSM::ProcessWVEvents - setting pause to 0
23:07:08.98   GAME -- SimulationController::Pause 1
23:07:09.43   Activating screen: Command_Branch
23:07:10.65   Warning: non auto-match upgrade not found in AE, tuning
23:07:11.46   WorldViewSM::ProcessWVEvents - setting pause to 1
23:07:11.46   GAME -- SimulationController::Pause 0
23:07:16.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:07:16.42   GAME -- SimulationController::Pause 1
23:07:23.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:07:23.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/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
23:07:30.50   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:07:30.56   Warning: binding repeat_2(Production Item: upgrade\allies_soviets\items\soviets_roks_flamethrower_dual) -- widget 'upgrade_button_01' already occupied by 'repeat_0:Production Item: upgrade\allies_soviets\items\soviets_roks_flamethrower'
23:07:35.70   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:07:44.28   WorldViewSM::ProcessWVEvents - setting pause to 1
23:07:44.28   GAME -- SimulationController::Pause 0
23:07:45.04   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:08:03.78   WorldViewSM::ProcessWVEvents - setting pause to 0
23:08:03.78   GAME -- SimulationController::Pause 1
23:08:08.23   WorldViewSM::ProcessWVEvents - setting pause to 1
23:08:08.23   GAME -- SimulationController::Pause 0
23:08:09.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
23:08:14.35   WorldViewSM::ProcessWVEvents - setting pause to 0
23:08:14.35   GAME -- SimulationController::Pause 1
23:08:18.07   WorldViewSM::ProcessWVEvents - setting pause to 1
23:08:18.07   GAME -- SimulationController::Pause 0
23:08:24.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:08:24.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=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
23:08:54.07   WorldViewSM::ProcessWVEvents - setting pause to 0
23:08:54.07   GAME -- SimulationController::Pause 1
23:08:56.81   WorldViewSM::ProcessWVEvents - setting pause to 1
23:08:56.81   GAME -- SimulationController::Pause 0
23:08:58.90   WorldViewSM::ProcessWVEvents - setting pause to 0
23:08:58.90   GAME -- SimulationController::Pause 1
23:09:07.59   WorldViewSM::ProcessWVEvents - setting pause to 1
23:09:07.59   GAME -- SimulationController::Pause 0
23:09:10.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
23:09:10.15   WorldViewSM::ProcessWVEvents - setting pause to 0
23:09:10.15   GAME -- SimulationController::Pause 1
23:09:25.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:09:25.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
23:09:28.34   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
23:09:40.37   WorldViewSM::ProcessWVEvents - setting pause to 1
23:09:40.37   GAME -- SimulationController::Pause 0
23:09:45.00   WorldViewSM::ProcessWVEvents - setting pause to 0
23:09:45.00   GAME -- SimulationController::Pause 1
23:09:46.18   WorldViewSM::ProcessWVEvents - setting pause to 1
23:09:46.18   GAME -- SimulationController::Pause 0
23:09:59.29   WorldViewSM::ProcessWVEvents - setting pause to 0
23:09:59.29   GAME -- SimulationController::Pause 1
23:10:09.85   WorldViewSM::ProcessWVEvents - setting pause to 1
23:10:09.85   GAME -- SimulationController::Pause 0
23:10:11.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
23:10:11.23   RLINK -- BattleServerRelay::Process - 242 ms between calls!
23:10:26.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:10:26.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
23:10:36.35   SPDx9 -- 1497MB available Texture Memory
23:10:38.79   WorldViewSM::ProcessWVEvents - setting pause to 0
23:10:38.79   GAME -- SimulationController::Pause 1
23:10:42.00   WorldViewSM::ProcessWVEvents - setting pause to 1
23:10:42.00   GAME -- SimulationController::Pause 0
23:10:48.50   WorldViewSM::ProcessWVEvents - setting pause to 0
23:10:48.50   GAME -- SimulationController::Pause 1
23:10:55.20   WorldViewSM::ProcessWVEvents - setting pause to 1
23:10:55.20   GAME -- SimulationController::Pause 0
23:10:58.34   WorldViewSM::ProcessWVEvents - setting pause to 0
23:10:58.34   GAME -- SimulationController::Pause 1
23:11:00.79   WorldViewSM::ProcessWVEvents - setting pause to 1
23:11:00.79   GAME -- SimulationController::Pause 0
23:11:01.48   WorldViewSM::ProcessWVEvents - setting pause to 0
23:11:01.48   GAME -- SimulationController::Pause 1
23:11:02.32   WorldViewSM::ProcessWVEvents - setting pause to 1
23:11:02.32   GAME -- SimulationController::Pause 0
23:11:12.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
23:11:18.53   WorldViewSM::ProcessWVEvents - setting pause to 0
23:11:18.53   GAME -- SimulationController::Pause 1
23:11:24.34   WorldViewSM::ProcessWVEvents - setting pause to 1
23:11:24.34   GAME -- SimulationController::Pause 0
23:11:27.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:11:27.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
23:11:34.57   WorldViewSM::ProcessWVEvents - setting pause to 0
23:11:34.57   GAME -- SimulationController::Pause 1
23:12:13.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
23:12:21.68   Warning: binding repeat_4(Ability: abilities\soviet_assault_ability) -- ui index '0' out of bounds; range is [1, 12]
23:12:28.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:12:28.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
23:12:48.64   WorldViewSM::ProcessWVEvents - setting pause to 1
23:12:48.64   GAME -- SimulationController::Pause 0
23:13:00.20   WorldViewSM::ProcessWVEvents - setting pause to 0
23:13:00.20   GAME -- SimulationController::Pause 1
23:13:02.04   WorldViewSM::ProcessWVEvents - setting pause to 1
23:13:02.04   GAME -- SimulationController::Pause 0
23:13:14.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
23:13:14.03   WorldViewSM::ProcessWVEvents - setting pause to 0
23:13:14.03   GAME -- SimulationController::Pause 1
23:13:24.85   WorldViewSM::ProcessWVEvents - setting pause to 1
23:13:24.85   GAME -- SimulationController::Pause 0
23:13:29.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:13:29.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
23:13:31.98   WorldViewSM::ProcessWVEvents - setting pause to 0
23:13:31.98   GAME -- SimulationController::Pause 1
23:13:51.87   WorldViewSM::ProcessWVEvents - setting pause to 1
23:13:51.87   GAME -- SimulationController::Pause 0
23:13:57.23   WorldViewSM::ProcessWVEvents - setting pause to 0
23:13:57.23   GAME -- SimulationController::Pause 1
23:14:15.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
23:14:30.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:14:30.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
23:14:30.85   WorldViewSM::ProcessWVEvents - setting pause to 1
23:14:30.85   GAME -- SimulationController::Pause 0
23:14:35.67   WorldViewSM::ProcessWVEvents - setting pause to 0
23:14:35.67   GAME -- SimulationController::Pause 1
23:14:38.82   WorldViewSM::ProcessWVEvents - setting pause to 1
23:14:38.82   GAME -- SimulationController::Pause 0
23:14:51.62   WorldViewSM::ProcessWVEvents - setting pause to 0
23:14:51.62   GAME -- SimulationController::Pause 1
23:15:06.78   WorldViewSM::ProcessWVEvents - setting pause to 1
23:15:06.78   GAME -- SimulationController::Pause 0
23:15:10.85   WorldViewSM::ProcessWVEvents - setting pause to 0
23:15:10.85   GAME -- SimulationController::Pause 1
23:15:12.95   WorldViewSM::ProcessWVEvents - setting pause to 1
23:15:12.95   GAME -- SimulationController::Pause 0
23:15:16.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
23:15:17.84   WorldViewSM::ProcessWVEvents - setting pause to 0
23:15:17.84   GAME -- SimulationController::Pause 1
23:15:20.07   WorldViewSM::ProcessWVEvents - setting pause to 1
23:15:20.07   GAME -- SimulationController::Pause 0
23:15:31.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:15:31.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
23:15:44.37   WorldViewSM::ProcessWVEvents - setting pause to 0
23:15:44.37   GAME -- SimulationController::Pause 1
23:15:50.79   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:15:53.62   WorldViewSM::ProcessWVEvents - setting pause to 1
23:15:53.62   GAME -- SimulationController::Pause 0
23:16:03.31   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:03.31   GAME -- SimulationController::Pause 1
23:16:05.15   WorldViewSM::ProcessWVEvents - setting pause to 1
23:16:05.15   GAME -- SimulationController::Pause 0
23:16:07.35   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:07.35   GAME -- SimulationController::Pause 1
23:16:09.06   WorldViewSM::ProcessWVEvents - setting pause to 1
23:16:09.06   GAME -- SimulationController::Pause 0
23:16:17.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
23:16:23.56   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:23.56   GAME -- SimulationController::Pause 1
23:16:27.75   WorldViewSM::ProcessWVEvents - setting pause to 1
23:16:27.75   GAME -- SimulationController::Pause 0
23:16:32.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:16:32.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
23:16:39.20   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:39.20   GAME -- SimulationController::Pause 1
23:16:43.90   WorldViewSM::ProcessWVEvents - setting pause to 1
23:16:43.90   GAME -- SimulationController::Pause 0
23:16:48.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:48.42   GAME -- SimulationController::Pause 1
23:16:52.34   WorldViewSM::ProcessWVEvents - setting pause to 1
23:16:52.34   GAME -- SimulationController::Pause 0
23:16:55.40   WorldViewSM::ProcessWVEvents - setting pause to 0
23:16:55.40   GAME -- SimulationController::Pause 1
23:17:15.10   WorldViewSM::ProcessWVEvents - setting pause to 1
23:17:15.10   GAME -- SimulationController::Pause 0
23:17:17.18   WorldViewSM::ProcessWVEvents - setting pause to 0
23:17:17.18   GAME -- SimulationController::Pause 1
23:17:18.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
23:17:19.56   WorldViewSM::ProcessWVEvents - setting pause to 1
23:17:19.56   GAME -- SimulationController::Pause 0
23:17:20.34   WorldViewSM::ProcessWVEvents - setting pause to 0
23:17:20.34   GAME -- SimulationController::Pause 1
23:17:33.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:17:33.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
23:17:42.60   WorldViewSM::ProcessWVEvents - setting pause to 1
23:17:42.60   GAME -- SimulationController::Pause 0
23:18:08.01   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:08.01   GAME -- SimulationController::Pause 1
23:18:19.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
23:18:24.57   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:24.57   GAME -- SimulationController::Pause 0
23:18:26.32   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:26.32   GAME -- SimulationController::Pause 1
23:18:33.76   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:33.76   GAME -- SimulationController::Pause 0
23:18:34.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:18:34.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
23:18:34.14   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:34.14   GAME -- SimulationController::Pause 1
23:18:34.92   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:34.92   GAME -- SimulationController::Pause 0
23:18:35.53   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:35.53   GAME -- SimulationController::Pause 1
23:18:38.37   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:38.37   GAME -- SimulationController::Pause 0
23:18:41.75   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:41.75   GAME -- SimulationController::Pause 1
23:18:47.03   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:47.03   GAME -- SimulationController::Pause 0
23:18:52.64   WorldViewSM::ProcessWVEvents - setting pause to 0
23:18:52.64   GAME -- SimulationController::Pause 1
23:18:59.92   WorldViewSM::ProcessWVEvents - setting pause to 1
23:18:59.92   GAME -- SimulationController::Pause 0
23:19:20.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
23:19:35.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:19:35.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
23:20:21.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
23:20:36.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:20:36.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
23:20:50.85   WorldViewSM::ProcessWVEvents - setting pause to 0
23:20:50.85   GAME -- SimulationController::Pause 1
23:21:07.98   WorldViewSM::ProcessWVEvents - setting pause to 1
23:21:07.98   GAME -- SimulationController::Pause 0
23:21:09.92   WorldViewSM::ProcessWVEvents - setting pause to 0
23:21:09.92   GAME -- SimulationController::Pause 1
23:21:11.17   WorldViewSM::ProcessWVEvents - setting pause to 1
23:21:11.17   GAME -- SimulationController::Pause 0
23:21:20.62   WorldViewSM::ProcessWVEvents - setting pause to 0
23:21:20.62   GAME -- SimulationController::Pause 1
23:21:22.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
23:21:22.96   WorldViewSM::ProcessWVEvents - setting pause to 1
23:21:22.96   GAME -- SimulationController::Pause 0
23:21:25.90   WorldViewSM::ProcessWVEvents - setting pause to 0
23:21:25.90   GAME -- SimulationController::Pause 1
23:21:37.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:21:37.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
23:21:40.73   WorldViewSM::ProcessWVEvents - setting pause to 1
23:21:40.73   GAME -- SimulationController::Pause 0
23:22:11.71   WorldViewSM::ProcessWVEvents - setting pause to 0
23:22:11.71   GAME -- SimulationController::Pause 1
23:22:21.42   WorldViewSM::ProcessWVEvents - setting pause to 1
23:22:21.42   GAME -- SimulationController::Pause 0
23:22:22.20   WorldViewSM::ProcessWVEvents - setting pause to 0
23:22:22.20   GAME -- SimulationController::Pause 1
23:22:23.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
23:22:24.65   WorldViewSM::ProcessWVEvents - setting pause to 1
23:22:24.65   GAME -- SimulationController::Pause 0
23:22:27.53   WorldViewSM::ProcessWVEvents - setting pause to 0
23:22:27.53   GAME -- SimulationController::Pause 1
23:22:35.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:22:35.50   GAME -- SimulationController::Pause 0
23:22:38.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:22:38.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
23:22:43.96   WorldViewSM::ProcessWVEvents - setting pause to 0
23:22:43.96   GAME -- SimulationController::Pause 1
23:22:56.78   WorldViewSM::ProcessWVEvents - setting pause to 1
23:22:56.78   GAME -- SimulationController::Pause 0
23:22:57.78   WorldViewSM::ProcessWVEvents - setting pause to 0
23:22:57.78   GAME -- SimulationController::Pause 1
23:22:58.84   WorldViewSM::ProcessWVEvents - setting pause to 1
23:22:58.84   GAME -- SimulationController::Pause 0
23:23:01.67   WorldViewSM::ProcessWVEvents - setting pause to 0
23:23:01.67   GAME -- SimulationController::Pause 1
23:23:13.25   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:23:15.59   WorldViewSM::ProcessWVEvents - setting pause to 1
23:23:15.59   GAME -- SimulationController::Pause 0
23:23:20.81   WorldViewSM::ProcessWVEvents - setting pause to 0
23:23:20.81   GAME -- SimulationController::Pause 1
23:23:21.25   Warning: binding repeat_5(Ability: abilities\soviet_assault_ability) -- ui index '0' out of bounds; range is [1, 12]
23:23:24.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
23:23:27.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:23:27.50   GAME -- SimulationController::Pause 0
23:23:28.87   WorldViewSM::ProcessWVEvents - setting pause to 0
23:23:28.87   GAME -- SimulationController::Pause 1
23:23:34.90   WorldViewSM::ProcessWVEvents - setting pause to 1
23:23:34.90   GAME -- SimulationController::Pause 0
23:23:35.65   WorldViewSM::ProcessWVEvents - setting pause to 0
23:23:35.65   GAME -- SimulationController::Pause 1
23:23:39.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:23:39.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
23:24:08.46   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:24:14.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:24:14.50   GAME -- SimulationController::Pause 0
23:24:21.32   WorldViewSM::ProcessWVEvents - setting pause to 0
23:24:21.32   GAME -- SimulationController::Pause 1
23:24:22.10   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:24:25.01   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
23:24:40.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:24:40.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
23:25:26.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
23:25:41.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:25:41.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
23:25:46.18   WorldViewSM::ProcessWVEvents - setting pause to 1
23:25:46.18   GAME -- SimulationController::Pause 0
23:25:47.46   WorldViewSM::ProcessWVEvents - setting pause to 0
23:25:47.46   GAME -- SimulationController::Pause 1
23:25:52.65   WorldViewSM::ProcessWVEvents - setting pause to 1
23:25:52.65   GAME -- SimulationController::Pause 0
23:25:53.70   WorldViewSM::ProcessWVEvents - setting pause to 0
23:25:53.70   GAME -- SimulationController::Pause 1
23:26:00.37   WorldViewSM::ProcessWVEvents - setting pause to 1
23:26:00.37   GAME -- SimulationController::Pause 0
23:26:01.73   RLINK --          9 ms to complete - SockAnimateAll - fd set sock.
23:26:04.71   WorldViewSM::ProcessWVEvents - setting pause to 0
23:26:04.71   GAME -- SimulationController::Pause 1
23:26:27.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
23:26:32.06   WorldViewSM::ProcessWVEvents - setting pause to 1
23:26:32.06   GAME -- SimulationController::Pause 0
23:26:42.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:26:42.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
23:26:54.23   WorldViewSM::ProcessWVEvents - setting pause to 0
23:26:54.23   GAME -- SimulationController::Pause 1
23:27:07.89   WorldViewSM::ProcessWVEvents - setting pause to 1
23:27:07.89   GAME -- SimulationController::Pause 0
23:27:08.64   WorldViewSM::ProcessWVEvents - setting pause to 0
23:27:08.64   GAME -- SimulationController::Pause 1
23:27:15.12   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:27:26.00   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:27:28.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
23:27:28.03   WorldViewSM::ProcessWVEvents - setting pause to 1
23:27:28.03   GAME -- SimulationController::Pause 0
23:27:35.71   WorldViewSM::ProcessWVEvents - setting pause to 0
23:27:35.71   GAME -- SimulationController::Pause 1
23:27:36.57   WorldViewSM::ProcessWVEvents - setting pause to 1
23:27:36.57   GAME -- SimulationController::Pause 0
23:27:43.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:27:43.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
23:27:44.28   WorldViewSM::ProcessWVEvents - setting pause to 0
23:27:44.28   GAME -- SimulationController::Pause 1
23:27:48.79   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:27:53.93   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:27:58.73   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:28:26.87   WorldViewSM::ProcessWVEvents - setting pause to 1
23:28:26.87   GAME -- SimulationController::Pause 0
23:28:27.96   WorldViewSM::ProcessWVEvents - setting pause to 0
23:28:27.96   GAME -- SimulationController::Pause 1
23:28:29.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
23:28:29.14   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:28:29.14   Muting spew of bind updater.  Fix art and re-test.
23:28:35.09   Warning: binding primary selection commands_child2() -- widget 'command_button_02' already occupied by 'command_stop_child0:'
23:28:44.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:28:44.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
23:28:47.79   WorldViewSM::ProcessWVEvents - setting pause to 1
23:28:47.79   GAME -- SimulationController::Pause 0
23:28:48.31   WorldViewSM::ProcessWVEvents - setting pause to 0
23:28:48.31   GAME -- SimulationController::Pause 1
23:29:04.75   WorldViewSM::ProcessWVEvents - setting pause to 1
23:29:04.75   GAME -- SimulationController::Pause 0
23:29:08.45   WorldViewSM::ProcessWVEvents - setting pause to 0
23:29:08.45   GAME -- SimulationController::Pause 1
23:29:14.10   WorldViewSM::ProcessWVEvents - setting pause to 1
23:29:14.10   GAME -- SimulationController::Pause 0
23:29:16.79   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'
23:29:21.32   WorldViewSM::ProcessWVEvents - setting pause to 0
23:29:21.32   GAME -- SimulationController::Pause 1
23:29:28.73   WorldViewSM::ProcessWVEvents - setting pause to 1
23:29:28.73   GAME -- SimulationController::Pause 0
23:29:30.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
23:29:31.31   WorldViewSM::ProcessWVEvents - setting pause to 0
23:29:31.31   GAME -- SimulationController::Pause 1
23:29:45.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:29:45.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
23:29:59.20   WorldViewSM::ProcessWVEvents - setting pause to 1
23:29:59.20   GAME -- SimulationController::Pause 0
23:29:59.76   WorldViewSM::ProcessWVEvents - setting pause to 0
23:29:59.76   GAME -- SimulationController::Pause 1
23:30:05.17   WorldViewSM::ProcessWVEvents - setting pause to 1
23:30:05.17   GAME -- SimulationController::Pause 0
23:30:08.28   WorldViewSM::ProcessWVEvents - setting pause to 0
23:30:08.28   GAME -- SimulationController::Pause 1
23:30:26.03   WorldViewSM::ProcessWVEvents - setting pause to 1
23:30:26.03   GAME -- SimulationController::Pause 0
23:30:31.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
23:30:38.31   WorldViewSM::ProcessWVEvents - setting pause to 0
23:30:38.31   GAME -- SimulationController::Pause 1
23:30:41.98   WorldViewSM::ProcessWVEvents - setting pause to 1
23:30:41.98   GAME -- SimulationController::Pause 0
23:30:46.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:30:46.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
23:30:59.34   WorldViewSM::ProcessWVEvents - setting pause to 0
23:30:59.34   GAME -- SimulationController::Pause 1
23:31:01.78   WorldViewSM::ProcessWVEvents - setting pause to 1
23:31:01.78   GAME -- SimulationController::Pause 0
23:31:05.06   WorldViewSM::ProcessWVEvents - setting pause to 0
23:31:05.06   GAME -- SimulationController::Pause 1
23:31:06.35   WorldViewSM::ProcessWVEvents - setting pause to 1
23:31:06.35   GAME -- SimulationController::Pause 0
23:31:08.53   Warning: binding repeat_2(Production Item: upgrade\allies_soviets\items\soviets_roks_flamethrower_dual) -- widget 'upgrade_button_01' already occupied by 'repeat_0:Production Item: upgrade\allies_soviets\items\soviets_roks_flamethrower'
23:31:12.46   WorldViewSM::ProcessWVEvents - setting pause to 0
23:31:12.46   GAME -- SimulationController::Pause 1
23:31:13.51   WorldViewSM::ProcessWVEvents - setting pause to 1
23:31:13.51   GAME -- SimulationController::Pause 0
23:31:14.48   WorldViewSM::ProcessWVEvents - setting pause to 0
23:31:14.48   GAME -- SimulationController::Pause 1
23:31:32.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
23:31:46.32   WorldViewSM::ProcessWVEvents - setting pause to 1
23:31:46.32   GAME -- SimulationController::Pause 0
23:31:47.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:31: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=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
23:31:48.62   WorldViewSM::ProcessWVEvents - setting pause to 0
23:31:48.62   GAME -- SimulationController::Pause 1
23:32:05.03   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:05.03   GAME -- SimulationController::Pause 0
23:32:07.73   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:07.73   GAME -- SimulationController::Pause 1
23:32:10.53   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:10.53   GAME -- SimulationController::Pause 0
23:32:11.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:11.42   GAME -- SimulationController::Pause 1
23:32:13.79   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:13.79   GAME -- SimulationController::Pause 0
23:32:16.12   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:16.12   GAME -- SimulationController::Pause 1
23:32:17.39   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:17.39   GAME -- SimulationController::Pause 0
23:32:19.76   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:19.76   GAME -- SimulationController::Pause 1
23:32:22.06   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:22.06   GAME -- SimulationController::Pause 0
23:32:23.12   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:23.12   GAME -- SimulationController::Pause 1
23:32:26.06   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:26.06   GAME -- SimulationController::Pause 0
23:32:30.03   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:30.03   GAME -- SimulationController::Pause 1
23:32:31.89   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:31.89   GAME -- SimulationController::Pause 0
23:32:32.29   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:32.29   GAME -- SimulationController::Pause 1
23:32:33.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
23:32:37.37   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:37.37   GAME -- SimulationController::Pause 0
23:32:38.07   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:38.07   GAME -- SimulationController::Pause 1
23:32:39.51   FXShader::SetVariable( "tex0", T ) uses unknown variable.
23:32:43.21   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:43.21   GAME -- SimulationController::Pause 0
23:32:44.76   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:44.76   GAME -- SimulationController::Pause 1
23:32:48.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:32: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
23:32:53.71   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:53.71   GAME -- SimulationController::Pause 0
23:32:54.79   WorldViewSM::ProcessWVEvents - setting pause to 0
23:32:54.79   GAME -- SimulationController::Pause 1
23:32:59.89   WorldViewSM::ProcessWVEvents - setting pause to 1
23:32:59.89   GAME -- SimulationController::Pause 0
23:33:03.32   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:03.32   GAME -- SimulationController::Pause 1
23:33:07.45   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:07.45   GAME -- SimulationController::Pause 0
23:33:08.15   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:08.15   GAME -- SimulationController::Pause 1
23:33:14.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:14.50   GAME -- SimulationController::Pause 0
23:33:15.09   Activating screen: Command_Branch
23:33:17.93   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:17.93   GAME -- SimulationController::Pause 1
23:33:18.28   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:18.28   GAME -- SimulationController::Pause 0
23:33:20.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:20.42   GAME -- SimulationController::Pause 1
23:33:21.64   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:21.64   GAME -- SimulationController::Pause 0
23:33:24.06   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:24.06   GAME -- SimulationController::Pause 1
23:33:27.62   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:27.62   GAME -- SimulationController::Pause 0
23:33:31.03   WorldViewSM::ProcessWVEvents - setting pause to 0
23:33:31.03   GAME -- SimulationController::Pause 1
23:33:31.87   WorldViewSM::ProcessWVEvents - setting pause to 1
23:33:31.87   GAME -- SimulationController::Pause 0
23:33:34.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
23:33:49.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:33: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
23:34: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
23:34:50.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:34: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=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
23:35:14.43   WorldViewSM::ProcessWVEvents - setting pause to 0
23:35:14.43   GAME -- SimulationController::Pause 1
23:35:33.39   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:34.37   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:35.64   Unabled to do upgrade, CANPRODUCE_NoResources
23:35: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
23:35:40.48   WorldViewSM::ProcessWVEvents - setting pause to 1
23:35:40.48   GAME -- SimulationController::Pause 0
23:35:44.90   WorldViewSM::ProcessWVEvents - setting pause to 0
23:35:44.90   GAME -- SimulationController::Pause 1
23:35:46.39   WorldViewSM::ProcessWVEvents - setting pause to 1
23:35:46.39   GAME -- SimulationController::Pause 0
23:35:51.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:35: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
23:35:52.45   WorldViewSM::ProcessWVEvents - setting pause to 0
23:35:52.45   GAME -- SimulationController::Pause 1
23:35:54.54   WorldViewSM::ProcessWVEvents - setting pause to 1
23:35:54.54   GAME -- SimulationController::Pause 0
23:36:00.04   WorldViewSM::ProcessWVEvents - setting pause to 0
23:36:00.04   GAME -- SimulationController::Pause 1
23:36:02.65   WorldViewSM::ProcessWVEvents - setting pause to 1
23:36:02.65   GAME -- SimulationController::Pause 0
23:36:03.53   WorldViewSM::ProcessWVEvents - setting pause to 0
23:36:03.53   GAME -- SimulationController::Pause 1
23:36:07.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:36:07.50   GAME -- SimulationController::Pause 0
23:36:33.87   SPDx9 -- 1497MB available Texture Memory
23:36: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
23:36:52.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:36:52.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
23:37:03.65   SPDx9 -- 1497MB available Texture Memory
23:37:06.12   WorldViewSM::ProcessWVEvents - setting pause to 0
23:37:06.12   GAME -- SimulationController::Pause 1
23:37:24.71   WorldViewSM::ProcessWVEvents - setting pause to 1
23:37:24.71   GAME -- SimulationController::Pause 0
23:37: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
23:37:53.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:37:53.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
23:38: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
23:38:54.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:38: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=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
23:38:59.26   SPDx9 -- 1497MB available Texture Memory
23:39:01.78   WorldViewSM::ProcessWVEvents - setting pause to 0
23:39:01.78   GAME -- SimulationController::Pause 1
23:39:11.84   WorldViewSM::ProcessWVEvents - setting pause to 1
23:39:11.84   GAME -- SimulationController::Pause 0
23:39:39.92   SPDx9 -- 1497MB available Texture Memory
23:39: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
23:39:42.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:39:42.42   GAME -- SimulationController::Pause 1
23:39:55.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:39:55.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
23:40:15.93   WorldViewSM::ProcessWVEvents - setting pause to 1
23:40:15.93   GAME -- SimulationController::Pause 0
23:40:28.46   WorldViewSM::ProcessWVEvents - setting pause to 0
23:40:28.46   GAME -- SimulationController::Pause 1
23:40:29.90   WorldViewSM::ProcessWVEvents - setting pause to 1
23:40:29.90   GAME -- SimulationController::Pause 0
23:40:33.45   WorldViewSM::ProcessWVEvents - setting pause to 0
23:40:33.45   GAME -- SimulationController::Pause 1
23:40:35.95   WorldViewSM::ProcessWVEvents - setting pause to 1
23:40:35.95   GAME -- SimulationController::Pause 0
23:40:39.39   WorldViewSM::ProcessWVEvents - setting pause to 0
23:40:39.39   GAME -- SimulationController::Pause 1
23:40: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
23:40:56.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:40: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
23:41:00.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:00.50   GAME -- SimulationController::Pause 0
23:41:02.01   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:02.01   GAME -- SimulationController::Pause 1
23:41:05.53   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:05.53   GAME -- SimulationController::Pause 0
23:41:06.96   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:06.96   GAME -- SimulationController::Pause 1
23:41:12.01   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:12.01   GAME -- SimulationController::Pause 0
23:41:15.96   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:15.96   GAME -- SimulationController::Pause 1
23:41:17.57   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:17.57   GAME -- SimulationController::Pause 0
23:41:19.78   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:19.78   GAME -- SimulationController::Pause 1
23:41:22.62   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:22.62   GAME -- SimulationController::Pause 0
23:41:24.73   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:24.73   GAME -- SimulationController::Pause 1
23:41:28.21   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:28.21   GAME -- SimulationController::Pause 0
23:41:36.17   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:36.17   GAME -- SimulationController::Pause 1
23:41:37.43   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:37.43   GAME -- SimulationController::Pause 0
23:41:38.20   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:38.20   GAME -- SimulationController::Pause 1
23:41:40.26   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:40.26   GAME -- SimulationController::Pause 0
23:41: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
23:41:43.85   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:43.85   GAME -- SimulationController::Pause 1
23:41:45.26   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:45.26   GAME -- SimulationController::Pause 0
23:41:50.75   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:50.75   GAME -- SimulationController::Pause 1
23:41:53.17   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:53.17   GAME -- SimulationController::Pause 0
23:41:54.42   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:54.42   GAME -- SimulationController::Pause 1
23:41:56.90   WorldViewSM::ProcessWVEvents - setting pause to 1
23:41:56.90   GAME -- SimulationController::Pause 0
23:41:57.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:41:57.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
23:41:59.57   WorldViewSM::ProcessWVEvents - setting pause to 0
23:41:59.57   GAME -- SimulationController::Pause 1
23:42:03.75   WorldViewSM::ProcessWVEvents - setting pause to 1
23:42:03.75   GAME -- SimulationController::Pause 0
23:42:04.95   WorldViewSM::ProcessWVEvents - setting pause to 0
23:42:04.95   GAME -- SimulationController::Pause 1
23:42:31.53   WorldViewSM::ProcessWVEvents - setting pause to 1
23:42:31.53   GAME -- SimulationController::Pause 0
23:42:38.07   WorldViewSM::ProcessWVEvents - setting pause to 0
23:42:38.07   GAME -- SimulationController::Pause 1
23:42:40.50   WorldViewSM::ProcessWVEvents - setting pause to 1
23:42:40.50   GAME -- SimulationController::Pause 0
23:42: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
23:42:51.73   WorldViewSM::ProcessWVEvents - setting pause to 0
23:42:51.73   GAME -- SimulationController::Pause 1
23:42:58.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:42:58.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
23:43:17.75   WorldViewSM::ProcessWVEvents - setting pause to 1
23:43:17.75   GAME -- SimulationController::Pause 0
23:43: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
23:43:59.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:43: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=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
23:44: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
23:45:00.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:45: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=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
23:45:16.42   SPDx9 -- 1497MB available Texture Memory
23:45:19.48   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:19.48   GAME -- SimulationController::Pause 1
23:45:21.98   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:21.98   GAME -- SimulationController::Pause 0
23:45:25.73   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:25.73   GAME -- SimulationController::Pause 1
23:45:29.17   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:29.17   GAME -- SimulationController::Pause 0
23:45:33.62   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:33.62   GAME -- SimulationController::Pause 1
23:45:38.85   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:38.85   GAME -- SimulationController::Pause 0
23:45:40.79   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:40.79   GAME -- SimulationController::Pause 1
23:45:42.76   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:42.76   GAME -- SimulationController::Pause 0
23:45: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
23:45:51.90   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:51.90   GAME -- SimulationController::Pause 1
23:45:52.87   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:52.87   GAME -- SimulationController::Pause 0
23:45:54.35   WorldViewSM::ProcessWVEvents - setting pause to 0
23:45:54.35   GAME -- SimulationController::Pause 1
23:45:55.07   WorldViewSM::ProcessWVEvents - setting pause to 1
23:45:55.07   GAME -- SimulationController::Pause 0
23:46:01.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:46: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
23:46:01.65   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:01.65   GAME -- SimulationController::Pause 1
23:46:07.76   WorldViewSM::ProcessWVEvents - setting pause to 1
23:46:07.76   GAME -- SimulationController::Pause 0
23:46:08.98   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:08.98   GAME -- SimulationController::Pause 1
23:46:10.59   WorldViewSM::ProcessWVEvents - setting pause to 1
23:46:10.59   GAME -- SimulationController::Pause 0
23:46:11.07   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:11.07   GAME -- SimulationController::Pause 1
23:46:13.25   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:13.26   GAME -- SimulationController::Pause 0
23:46:13.75   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:13.75   GAME -- SimulationController::Pause 1
23:46:14.06   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:14.06   GAME -- SimulationController::Pause 0
23:46:16.85   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:16.85   GAME -- SimulationController::Pause 1
23:46:16.95   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:16.95   GAME -- SimulationController::Pause 0
23:46:17.93   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:17.93   GAME -- SimulationController::Pause 1
23:46:18.43   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:18.43   GAME -- SimulationController::Pause 0
23:46:19.21   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:19.21   GAME -- SimulationController::Pause 1
23:46:19.39   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:19.39   GAME -- SimulationController::Pause 0
23:46:23.37   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:23.37   GAME -- SimulationController::Pause 1
23:46:23.71   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:23.71   GAME -- SimulationController::Pause 0
23:46:24.26   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:24.26   GAME -- SimulationController::Pause 1
23:46:24.43   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:24.43   GAME -- SimulationController::Pause 0
23:46:24.95   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:24.95   GAME -- SimulationController::Pause 1
23:46:25.04   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:25.04   GAME -- SimulationController::Pause 0
23:46:30.12   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:30.12   GAME -- SimulationController::Pause 1
23:46:30.48   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:30.48   GAME -- SimulationController::Pause 0
23:46:31.15   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:31.15   GAME -- SimulationController::Pause 1
23:46:31.46   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:31.46   GAME -- SimulationController::Pause 0
23:46:31.98   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:31.98   GAME -- SimulationController::Pause 1
23:46:32.06   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:32.06   GAME -- SimulationController::Pause 0
23:46:32.60   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:32.60   GAME -- SimulationController::Pause 1
23:46:33.07   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:33.07   GAME -- SimulationController::Pause 0
23:46:33.67   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:33.67   GAME -- SimulationController::Pause 1
23:46:33.84   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:33.84   GAME -- SimulationController::Pause 0
23:46:34.32   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:34.32   GAME -- SimulationController::Pause 1
23:46:34.51   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:34.51   GAME -- SimulationController::Pause 0
23:46:35.04   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:35.04   GAME -- SimulationController::Pause 1
23:46:35.25   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:35.25   GAME -- SimulationController::Pause 0
23:46:35.71   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:35.71   GAME -- SimulationController::Pause 1
23:46:36.09   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:36.09   GAME -- SimulationController::Pause 0
23:46:37.70   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:37.70   GAME -- SimulationController::Pause 1
23:46:38.00   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:38.00   GAME -- SimulationController::Pause 0
23:46:38.53   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:38.53   GAME -- SimulationController::Pause 1
23:46:38.70   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:38.70   GAME -- SimulationController::Pause 0
23:46:39.28   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:39.28   GAME -- SimulationController::Pause 1
23:46:39.48   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:39.48   GAME -- SimulationController::Pause 0
23:46:39.98   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:39.98   GAME -- SimulationController::Pause 1
23:46:40.14   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:40.14   GAME -- SimulationController::Pause 0
23:46:41.34   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:41.34   GAME -- SimulationController::Pause 1
23:46:41.54   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:41.54   GAME -- SimulationController::Pause 0
23:46:42.10   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:42.10   GAME -- SimulationController::Pause 1
23:46:42.54   LuaException::ThrowMessage - Invalid parameter 1 (type expected=Squad*, received=nil) in function Squad_GetPosition
23:46:42.54   GAME -- SimulationController::Pause 0
23:46:43.09   WorldViewSM::ProcessWVEvents - setting pause to 0
23:46:43.09   GAME -- SimulationController::Pause 1
23:46:45.15   WorldViewSM::ProcessWVEvents - setting pause to 1
23:46:45.15   GAME -- SimulationController::Pause 0
23:46: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
23:47:02.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:47:02.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
23:47: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
23:48:03.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:48:03.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
23:48: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
23:49:04.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:49:04.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=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
23:49: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
23:50:05.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:50:05.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
23:50: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
23:51:06.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:51:06.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
23:51: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
23:52:07.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:52:07.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
23:52:53.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
23:53:08.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:53:08.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=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
23:53:54.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
23:54:09.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:54:09.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
23:54:55.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
23:55:10.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:55:10.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
23:55:56.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
23:56:11.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:56:11.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=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
23:56:57.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
23:57:12.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:57:12.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
23:57:58.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
23:58:13.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:58:13.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
23:58:59.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
23:59:14.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
23:59:14.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
00:00:00.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
00:00:15.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:00:15.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
00:01:01.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
00:01:16.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:01:16.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
00:02:02.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
00:02:17.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:02:17.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
00:03:03.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
00:03:18.01   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:03:18.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
00:04:04.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
00:04:19.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:04:19.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
00:05:05.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
00:05:20.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:05:20.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
00:06:06.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
00:06:21.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:06:21.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
00:07:07.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
00:07:22.00   RLINK -- local host PeerID 1 LOCL ack= 31 (497ms~49) unack=  0, retry=  0, highwaterOOS=0 (ip=WINaddr:192.168.1.2:6112;), pending=0, dead=0, RS#=30/30
00:07:22.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
