-- Log file for all dbTracef messages --

09:54:11.51   NetworkManager::Create - creating network manager
09:54:11.51   Read 269 bytes from network datastore login_cache.bin
09:54:11.51   Read 52 bytes from network datastore global_cache.bin
09:54:11.51   Read 28 bytes from network datastore ping_cache.bin
09:54:11.51   QuazalInitializer - static initializing Quazal library
09:54:11.51   PingCache - populating cache with 0 pings
09:54:11.51   Sent message game CompanyOfHeroes started 1692 602 allowtraffic
09:54:11.51   RemoteDLManager - Connection Restored.
09:54:11.51   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
09:54:11.56   WinTransport - CreateSocket exclusive broadcast socket was available.
09:54:11.56   WinTransport - CreateSocket listening for broadcasts on default port
09:54:11.56   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
09:54:11.56   WinTransport - Host IP Address #0: 5.3.208.164
09:54:11.56   WinTransport - WARNING, MultipleNetwork adapters may cause problems
09:54:11.56   WinTransport - Interface #0: ip:192.168.1.100, broadcast:192.168.1.100, flags=IFF_BROADCAST IFF_MULTICAST
09:54:11.56   WinTransport - Interface #1: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
09:54:11.56   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
09:54:11.56   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:54:11.56   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
09:54:11.56   SessionManager - Peer Header Size = 16 bytes
09:54:11.56   SessionManager - Game Data overhead = 7 bytes
09:54:11.56   SessionManager - Proxy overhead = 7 bytes
09:54:11.56   MessageInternal::CreateChannel: Created channel 47535450
09:54:11.56   Session::Initialize - info, initializing session object, using threads.
09:54:11.56   SessionManager::RegisterSession - Registering new session 078b5ff8
09:54:11.56   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:54:11.56   AutomatchInternal: Instantiating
09:54:11.56   PartyInternal: Instantiating
09:54:11.56   MessageInternal::CreateChannel: Created channel 50525459
09:54:11.56   MessageInternal::CreateChannel: Created channel 51434b4d
09:54:11.56   Net::ThreadFunction - Entering network thread function...
09:54:11.56   MessageInternal::CreateChannel: Created channel 534d5347
09:54:11.56   MessageInternal::CreateChannel: Created channel 474d4343
09:54:11.56   MessageInternal::CreateChannel: Created channel 474f424a
09:54:11.56   MessageInternal::CreateChannel: Created channel 4d4f444d
09:54:11.56   MessageInternal::CreateChannel: Created channel 53594e43
09:54:11.56   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:54:11.56   MessageInternal::DestroyChannel: Destroyed channel 474d4343
09:54:11.56   MessageInternal::DestroyChannel: Destroyed channel 474f424a
09:54:11.56   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
09:54:11.56   MessageInternal::DestroyChannel: Destroyed channel 53594e43
09:54:11.56   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
09:54:11.57   Transport - Largest received is now 19
09:54:11.57   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
09:54:11.58   Transport - Largest sent is now 19
09:54:14.93   DLLDriverLinker -- Adding driver 'spDx10.dll'.
09:54:14.94   DLLDriverLinker -- Adding driver 'spDx9.dll'.
09:54:14.94   DLLDriverLinker -- 2 DLL drivers found.
09:54:14.99   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
09:54:16.65   DLLDriverLinker -- 2 DLL drivers found.
09:54:16.80   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
09:54:16.80   GAME -- Resolution set to 1024x768 (fullscreen).
09:54:16.82   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
09:54:16.82   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
09:54:16.82   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
09:54:16.82   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
09:54:17.35   SPDx9 -- 1774MB available Texture Memory
09:54:17.36   ShaderDatabase: using shader profile [ps30]
09:54:17.93   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
09:54:18.17   GameObjLoader 09e2ac28 - resetting counters
09:54:18.17   GameObjLoader 09e2ac28 - Created loader
09:54:18.17   GameObjLoader 09e2ad88 - resetting counters
09:54:18.17   GameObjLoader 09e2ad88 - Created loader
09:54:33.51   GAME -- Beginning FE
09:54:33.51   Sent message game CompanyOfHeroes allowtraffic
09:54:33.51   UIFrontEnd - Loading Front End
09:54:33.51   THREAD: Hyper-Threading Technology Processors are not detected.
09:54:33.58   SOUND -- Initializing ...
09:54:34.31   SOUND -- Initialization completed!
09:54:34.32   UIFrontEnd - Initializing Forms
09:54:36.28   CampaignFilter::BindFilterSpecificWidgets()
09:54:36.34   installed_products = ( )
09:54:36.37   Activating screen: AppLoadingForm
09:54:36.37   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:54:36.37   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
09:54:36.37   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:54:36.37   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:54:37.17   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
09:54:37.17   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
09:54:37.17   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
09:54:37.18   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
09:54:37.18   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
09:54:37.18   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
09:54:37.56   GAME -- Using player profile NGOCQUANG-PC
09:54:40.90   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
09:54:41.85   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
09:54:42.91   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
09:54:42.91   RendezvousManager: CreateSession - starting profile=Guest login
09:54:42.96   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
09:54:42.96   RendezvousManager - unable to connect to the server as guest
09:54:42.98   OnConnect: connect failure
09:54:42.98   RendezvousManager::Shutdown - deleting instance
09:54:42.98   RendezvousManager - terminating all server calls in progress
09:54:42.98   CallManager - terminating all server calls in progress (1 in progress)
09:54:42.98   RendezvousManager - destroying chat handler
09:54:42.98   ~RendezvousManager - m_state = 7, no need for server disconnect
09:54:43.00   OnConnect: this wasnt a reconnect, no need for autologin
09:54:43.01   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:54:43.02   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
09:54:43.02   Activating screen: FEMovie
09:54:43.02   Activating screen: OnlineWidget
09:54:43.02   Activating screen: RelicOnlineLogin
09:54:43.07   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:54:43.07   You have a valid version of the game.
09:54:43.07   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
09:54:43.07   installed_products = ( DLC1 DLC2 DLC3 )
09:54:43.07   OnLogin: no previous login, auto selecting profile not required
09:54:43.07   Activating screen: MessageBoxPopup
09:54:43.07   Activating screen: MessageBoxPopup
09:54:43.07   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
09:54:44.79   Beginning media verification...
09:54:44.79   Validator type : validators\udro\udro.dll
09:54:44.79   Activating screen: MessageBoxPopup
09:54:44.82   Activating screen: FE_mm_01
09:54:44.82   GAME -- Setting campaign state to 'dlc1'
09:54:44.82   GAME -- Closing state 'dlc1'
09:54:44.83   GAME -- Setting campaign state to 'dlc2'
09:54:44.83   GAME -- Closing state 'dlc2'
09:54:44.83   GAME -- Setting campaign state to 'dlc3'
09:54:44.83   GAME -- Closing state 'dlc3'
09:54:49.11   Activating screen: MessageBoxPopup
09:54:49.11   Created Matchinfo
09:54:49.11   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:54:49.11   starting LAN hosting
09:54:49.14   OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:54:49.14   starting local hosting
09:54:49.14   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:54:49.14   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:54:49.14   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
09:54:49.14   Session::Host sid = 8422580A3A0756E5, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
09:54:49.14   ValidateCustomData: called with 217 bytes of custom data
09:54:49.14   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
09:54:49.14   AdvertisementInternal::Process - EVENT_NEWPEER
09:54:49.14   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:54:49.15   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:54:49.15   hosting - Session is connected
09:54:49.15   Net::Session::SetVisible - session is set to VISIBLE.
09:54:49.16   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
09:54:49.16   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=1/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
09:54:49.17   Transport - Largest received is now 479
09:54:49.17   hosting completed successfully
09:54:49.17   HostAsync - completed with HostResult = 0
09:54:49.17   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
09:54:49.17   Activating screen: OnlineGameSetup
09:54:49.17   MessageInternal::CreateChannel: Created channel 534d5347
09:54:49.17   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:54:49.17   MatchInternal::SetMatchType - new type 14 - updating server
09:54:49.19   Transport - Largest received is now 535
09:54:49.21   SetVisible called while !IsConnected
09:54:49.21   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:54:49.21   Activating screen: RelicOnlineChat
09:54:49.21   Activating screen: RelicOnlineNewsScreen
09:54:49.21   Activating screen: RelicOnlineStatsScreen
09:54:49.21   Activating screen: Achievements
09:54:49.22   GAME -- Setting campaign state to 'dlc1'
09:54:49.22   GAME -- Closing state 'dlc1'
09:54:49.22   GAME -- Setting campaign state to 'dlc1'
09:54:49.22   GAME -- Closing state 'dlc1'
09:54:49.22   GAME -- Setting campaign state to 'dlc2'
09:54:49.22   GAME -- Closing state 'dlc2'
09:54:49.22   GAME -- Setting campaign state to 'dlc3'
09:54:49.22   GAME -- Closing state 'dlc3'
09:54:49.23   GAME -- Setting campaign state to 'dlc1'
09:54:49.23   GAME -- Closing state 'dlc1'
09:54:49.23   Transport - Largest received is now 1189
09:54:49.23   Activating screen: GameHistory
09:54:49.23   GAME -- Setting campaign state to 'dlc1'
09:54:49.23   GAME -- Closing state 'dlc1'
09:54:49.24   GAME -- Setting campaign state to 'dlc2'
09:54:49.24   GAME -- Closing state 'dlc2'
09:54:49.24   GAME -- Setting campaign state to 'dlc3'
09:54:49.24   GAME -- Closing state 'dlc3'
09:54:49.24   Activating screen: OnlineGameSetup
09:54:49.24   Activating screen: RelicOnlineTabs
09:54:49.24   AutomatchInternal::OnHostComplete - Completed Host with success=1
09:54:49.24   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:54:49.24   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
09:54:49.25   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:54:49.25   Net::Session::SetVisible - session is set to VISIBLE.
09:54:49.25   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:54:49.30   TGAIO -- TGA file 'Data:scenarios\mp\eichsfeld confluence_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:54:49.34   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:49.36   GAME -- Setting campaign state to 'dlc1'
09:54:49.36   GAME -- Closing state 'dlc1'
09:54:49.36   GAME -- Setting campaign state to 'dlc2'
09:54:49.36   GAME -- Closing state 'dlc2'
09:54:49.36   GAME -- Setting campaign state to 'dlc3'
09:54:49.36   GAME -- Closing state 'dlc3'
09:54:49.41   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:51.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:56.69   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:54:56.69   Net::Session::SetVisible - session is set to VISIBLE.
09:54:56.69   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:54:56.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:56.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:59.15   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:54:59.15   Net::Session::SetVisible - session is set to VISIBLE.
09:54:59.15   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:54:59.18   TGAIO -- TGA file 'Data:scenarios\mp\8p_berlin_1945_b041_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:54:59.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:54:59.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:00.15   Activating screen: RaceSelectionPopup
09:55:00.84   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:00.84   Net::Session::SetVisible - session is set to VISIBLE.
09:55:00.84   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:00.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:00.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:01.67   Activating screen: DynamicPopupMenu
09:55:02.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:02.66   Net::Session::SetVisible - session is set to VISIBLE.
09:55:02.66   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:02.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:02.71   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:04.20   Activating screen: DynamicPopupMenu
09:55:04.91   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:04.91   Net::Session::SetVisible - session is set to VISIBLE.
09:55:04.91   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:04.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:04.95   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:05.57   Activating screen: DynamicPopupMenu
09:55:06.23   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:06.23   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:06.23   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:06.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:06.29   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:06.97   Activating screen: DynamicPopupMenu
09:55:08.32   Activating screen: RaceSelectionPopup
09:55:09.05   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:09.05   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:09.05   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:09.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:09.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:09.66   Activating screen: RaceSelectionPopup
09:55:10.36   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:10.36   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:10.36   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:10.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:10.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:11.08   Activating screen: RaceSelectionPopup
09:55:11.73   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:11.73   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:11.73   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:11.74   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:11.78   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:12.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.7, max unsent 0, version err 0, merge 0
09:55:12.58   Activating screen: DynamicPopupMenu
09:55:13.33   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:13.33   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:13.33   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:13.34   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:13.39   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:14.25   Activating screen: DynamicPopupMenu
09:55:15.35   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:15.35   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:15.35   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:15.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:15.40   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:16.16   Activating screen: DynamicPopupMenu
09:55:16.93   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:16.93   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:16.93   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:16.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:16.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:17.47   Activating screen: DynamicPopupMenu
09:55:18.30   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:18.30   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:18.30   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:18.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:18.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:18.88   Activating screen: DynamicPopupMenu
09:55:19.91   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:19.91   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:19.91   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:19.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:19.97   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:27.18   SPDx9 -- 1770MB available Texture Memory
09:55:29.01   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:29.01   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:29.01   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:29.02   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:29.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:32.63   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:32.63   Net::Session::SetVisible - session is set to INVISIBLE.
09:55:32.63   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
09:55:32.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:32.69   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:37.01   GameSetupForm - No win/loss reporting and only a single player, disconnecting
09:55:37.01   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:55:37.01   SetVisible called while !IsConnected
09:55:37.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:37.01   GameSetupForm - Starting game
09:55:37.01   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:55:37.02   PopulateGameInfo - random seed:[1308711337], guid:[{e5f53656-03c0-4796-94a1-88d8093e2161}], sync level:[2]
09:55:37.02   Error loading [DATA:levelingCurve.lua]
09:55:37.02   Error loading [DATA:levelingCurve.lua]
09:55:37.02   Error loading [DATA:levelingCurve.lua]
09:55:37.03   Error loading [DATA:levelingCurve.lua]
09:55:37.03   Error loading [DATA:levelingCurve.lua]
09:55:37.03   Error loading [DATA:levelingCurve.lua]
09:55:37.03   Error loading [DATA:levelingCurve.lua]
09:55:37.03   Error loading [DATA:levelingCurve.lua]
09:55:37.03   MOD - Setting player (0) race to: allies_soviets
09:55:37.03   MOD - Setting player (0) race to: 2
09:55:37.03   MOD - Setting player (1) race to: allies_soviets
09:55:37.03   MOD - Setting player (1) race to: 2
09:55:37.03   MOD - Setting player (2) race to: allies_soviets
09:55:37.03   MOD - Setting player (2) race to: 2
09:55:37.03   MOD - Setting player (3) race to: allies_soviets
09:55:37.03   MOD - Setting player (3) race to: 2
09:55:37.03   MOD - Setting player (4) race to: axis
09:55:37.03   MOD - Setting player (4) race to: 3
09:55:37.03   MOD - Setting player (5) race to: axis
09:55:37.03   MOD - Setting player (5) race to: 3
09:55:37.03   MOD - Setting player (6) race to: axis
09:55:37.03   MOD - Setting player (6) race to: 3
09:55:37.03   MOD - Setting player (7) race to: axis
09:55:37.03   MOD - Setting player (7) race to: 3
09:55:37.03   Activating screen: MessageBoxPopup
09:55:37.04   Session is marking the local peer PeerID 1 for death
09:55:37.04   Session::GetEvent DestroyPeer success Peer 1 removed
09:55:37.04   Session::DestroyPeer - deallocating peer 1
09:55:37.04   Session - Requested Disconnect for connectionID 2
09:55:37.04   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:55:37.04   Session - Requested Disconnect for connectionID 3
09:55:37.04   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:55:37.04   AdvertisementInternal::Process - EVENT_DESTROYPEER
09:55:37.04   Destroyed Matchinfo
09:55:37.05   APP -- Game Start
09:55:37.05   Sent message game CompanyOfHeroes allowtraffic
09:55:37.05   GAME -- Setting campaign state to 'dlc1'
09:55:37.05   GAME -- Closing state 'dlc1'
09:55:37.06   GAME -- Setting campaign state to 'dlc2'
09:55:37.06   GAME -- Closing state 'dlc2'
09:55:37.06   GAME -- Setting campaign state to 'dlc3'
09:55:37.06   GAME -- Closing state 'dlc3'
09:55:37.07   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:55:37.07   GAME -- Ending FE
09:55:37.07   UIFrontEnd - Unloading Front End
09:55:37.09   SOUND -- Shutting down ...
09:55:37.14   SOUND -- Shutdown completed!
09:55:37.16
09:55:37.16   GAME -- *** Beginning mission 8P_BERLIN_1945_B041 (1 Humans, 7 Computers) ***
09:55:37.16
09:55:37.16   GAME -- Recording game
09:55:37.26   Activating screen: GameLoadScreen
09:55:37.26   ReportGameStartStats - no connection to server unable to report
09:55:37.26   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:55:37.26   PeerRemoveAll - flushing local session peer data
09:55:37.26   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:55:37.26   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:55:37.29   TGAIO -- TGA file 'Data:scenarios\mp\8p_berlin_1945_b041.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:55:37.68   THREAD: Hyper-Threading Technology Processors are not detected.
09:55:37.76   SOUND -- Initializing ...
09:55:38.49   SOUND -- Initialization completed!
09:55:38.53   PHYSICS: detected processor(s) capable of handling 4 threads.
09:55:38.55   MOD -- Locating MOD for scenario 'DATA:Scenarios\MP\8P_BERLIN_1945_B041'
09:55:38.55   MOD -- Using Mod 'Eastern_Front'
09:55:38.56   Unable to load/parse precache file [DATA:Scenarios\MP\8P_BERLIN_1945_B041_precache.lua]
09:55:38.67   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:55:38.67   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:55:42.11   GameObjLoader - upgrading load_count from 0 to 1117
09:55:45.39   GameObjLoader - upgrading load_count from 1117 to 1826
09:55:45.52   PHYSICS -- Created node factory 'HVOK'
09:55:45.52   PHYSICS -- Created node factory 'DMMY'
09:56:10.98   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:56:12.89   GameObjLoader - upgrading load_count from 41 to 4486
09:56:13.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.4, max unsent 0, version err 0, merge 0
09:56:41.48   GameObjLoader 09e2ac28 - resetting counters
09:56:41.48   GameObjLoader 09e2ac28 - LOAD_DONE
09:56:41.58   GAME - SessionSetup
09:56:41.58   GAME -- Can't initialize scenario pack more than once.
09:56:42.30   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
09:56:42.30   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
09:56:42.30   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
09:56:46.35   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
09:56:50.21   GAME - CreateGEWorld in 8629 ms
09:56:50.24   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:56:50.48   GAME - SessionSetup finished in 8897 ms
09:56:50.53   GAME - WaterReflectionManagerSetup
09:56:50.53   GAME - WaterReflectionManagerSetup finished in 0 ms
09:56:51.18   MessageInternal::CreateChannel: Created channel 474d4343
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x065c89c0
[Cope FactionFix] - patched @0x6b8f5491
[Cope FactionFix] - hooked @0x6b8f5492
[Cope FactionFix] - patched @0x6b8f4a07
[Cope FactionFix] - hooked @0x6b8f4a07
[Cope FactionFix] - Hook installed
09:56:51.52   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
09:56:54.84   MessageInternal::CreateChannel: Created channel 4d4f444d
09:56:55.59   TGAIO -- TGA file 'DATA:Scenarios\MP\8P_BERLIN_1945_B041_mm.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:56:55.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:56:55.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:56:55.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:56:55.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:56:55.67   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:56:56.25   SPEECHMANAGER -- Loaded in 0.518101 seconds
09:56:57.04   TGAIO -- TGA file 'DATA:Scenarios\MP\8P_BERLIN_1945_B041_mm.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:56:59.28   GameObjLoader - upgrading load_count from 0 to 426
09:57:01.91   GameObjLoader 09e2ad88 - resetting counters
09:57:01.91   GameObjLoader 09e2ad88 - LOAD_DONE
09:57:03.92   SPDx9 -- 1753MB available Texture Memory
09:57:06.20   PreloadResources took 2261ms.
09:57:06.35   GAME -- Loading completed (89 seconds)
09:57:06.35   SIM -- Setting SyncErrorChecking level to None
09:57:08.24   Activating screen: GameScreen
09:57:08.24   Activating screen: Decorators
09:57:08.24   Activating screen: Taskbar
09:57:08.24   Activating screen: SubtitleScreen
09:57:08.24   Activating screen: TextOverlayScreen
09:57:08.40   PerformanceRecorder::StartRecording for game size 8
09:57:08.40   GAME -- Starting mission...
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Hard set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:13.51   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:57:14.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:57:19.34   Warning: non auto-match upgrade not found in AE, tuning
09:57:19.74   Activating screen: Command_Tree
09:57:22.65   Activating screen: Command_Branch
09:57:36.90   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:58:15.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:58:16.82   Activating screen: pause_menu
09:58:16.82   GAME -- SimulationController::Pause 0
09:58:21.12   SPDx9 -- 1755MB available Texture Memory
09:58:29.95   GAME -- SimulationController::Pause 1
09:58:34.90   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
09:58:41.81   Warning: binding repeat_1(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
09:59:16.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:59:23.34   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:59:57.79   Activating screen: Command_Branch
10:00:06.79   Activating screen: pause_menu
10:00:06.79   GAME -- SimulationController::Pause 0
10:00:13.99   Got dlman msg [dlmanager shutdown user]
10:00:17.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:00:26.80   SPDx9 -- 1755MB available Texture Memory
10:00:28.53   GAME -- SimulationController::Pause 1
10:01:18.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:02:11.82   Activating screen: pause_menu
10:02:11.82   GAME -- SimulationController::Pause 0
10:02:15.22   SPDx9 -- 1755MB available Texture Memory
10:02:17.05   GAME -- SimulationController::Pause 1
10:02:19.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:02:24.30   Activating screen: Command_Branch
10:03:17.93   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:17.93   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:17.93   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
10:03:20.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:03:34.10   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:34.10   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:34.10   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
10:03:48.17   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:48.17   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:48.17   Unable to bind updater for fx [fx_damage\tech_tree\white_lingering_smoke_combo_00].  It could be looping in a fire-n-forget action.
10:03:49.33   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
10:03:49.33   Muting spew of bind updater.  Fix art and re-test.
10:04:21.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:04:31.83   Activating screen: pause_menu
10:04:31.83   GAME -- SimulationController::Pause 0
10:04:34.97   SPDx9 -- 1755MB available Texture Memory
10:04:36.87   GAME -- SimulationController::Pause 1
10:05:22.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:06:08.36   Unabled to do upgrade, CANPRODUCE_NoResources
10:06:09.68   Unabled to do upgrade, CANPRODUCE_NoResources
10:06:10.85   Unabled to do upgrade, CANPRODUCE_NoResources
10:06:23.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:07:06.99   Activating screen: pause_menu
10:07:06.99   GAME -- SimulationController::Pause 0
10:07:10.15   SPDx9 -- 1755MB available Texture Memory
10:07:11.95   GAME -- SimulationController::Pause 1
10:07:24.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:08:11.18   Activating screen: Command_Branch
10:08:25.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:09:26.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:09:30.51   SimulationController::GenerateSyncCmd - couldn't send all commands, 2 binned.
10:09:57.14   Activating screen: pause_menu
10:09:57.14   GAME -- SimulationController::Pause 0
10:10:00.40   SPDx9 -- 1755MB available Texture Memory
10:10:03.59   GAME -- SimulationController::Pause 1
10:10:03.89   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:10:10.11   Activating screen: Command_Branch
10:10:13.12   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
10:10:19.86   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:10:27.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:10:33.85   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:10:43.87   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:11:28.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:12:29.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:13:02.19   Activating screen: pause_menu
10:13:02.19   GAME -- SimulationController::Pause 0
10:13:05.64   SPDx9 -- 1755MB available Texture Memory
10:13:08.14   GAME -- SimulationController::Pause 1
10:13:30.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:13:45.12   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:14:07.92   Unabled to do upgrade, CANPRODUCE_NoResources
10:14:09.26   Unabled to do upgrade, CANPRODUCE_NoResources
10:14:11.03   Unabled to do upgrade, CANPRODUCE_NoResources
10:14:16.26   Activating screen: Command_Branch
10:14:31.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:15:24.74   SimulationController::GenerateSyncCmd - couldn't send all commands, 2 binned.
10:15:32.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:16:22.17   Activating screen: pause_menu
10:16:22.17   GAME -- SimulationController::Pause 0
10:16:25.12   SPDx9 -- 1755MB available Texture Memory
10:16:27.14   GAME -- SimulationController::Pause 1
10:16:33.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:17:34.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:18:35.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:18:59.58   Activating screen: Command_Branch
10:19:02.36   Activating screen: NewObjective
10:19:36.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:19:57.31   Activating screen: pause_menu
10:19:57.31   GAME -- SimulationController::Pause 0
10:20:00.64   SPDx9 -- 1755MB available Texture Memory
10:20:02.16   GAME -- SimulationController::Pause 1
10:20:19.40   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
10:20:37.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:20:43.64   FXShader::SetVariable( "tex0", T ) uses unknown variable.
10:21:06.90   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:08.01   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:09.15   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:10.17   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:11.52   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:12.96   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:13.90   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:15.31   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:16.70   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:18.19   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:19.35   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:20.57   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:21.91   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:23.06   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:24.22   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:25.24   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:26.20   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:27.34   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:28.72   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:30.47   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:31.82   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:32.97   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:34.32   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:35.36   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:36.51   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:37.82   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:38.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:21:38.83   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:40.36   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:21:41.45   An ability failed to cast because target validation failed: abilities\soviets_air_all_targets
10:22:39.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:23:07.91   Activating screen: Command_Branch
10:23:40.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:23:45.58   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:23:47.37   Activating screen: pause_menu
10:23:47.38   GAME -- SimulationController::Pause 0
10:23:51.14   SPDx9 -- 1755MB available Texture Memory
10:23:52.96   GAME -- SimulationController::Pause 1
10:23:54.28   Unabled to do upgrade, CANPRODUCE_NoResources
10:23:55.48   Unabled to do upgrade, CANPRODUCE_NoResources
10:23:56.83   Unabled to do upgrade, CANPRODUCE_NoResources
10:23:57.88   Unabled to do upgrade, CANPRODUCE_NoResources
10:23:59.20   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:00.36   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:01.49   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:02.62   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:03.85   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:05.13   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:06.25   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:07.35   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:08.36   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:09.35   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:10.50   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:11.71   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:12.72   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:13.72   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:14.75   Unabled to do upgrade, CANPRODUCE_NoResources
10:24:35.33   Activating screen: Command_Branch
10:24:41.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:25:29.21   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:25:42.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:25:42.48   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
10:25:45.85   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:26:43.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:27:44.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:27:52.72   Activating screen: pause_menu
10:27:52.72   GAME -- SimulationController::Pause 0
10:27:56.28   SPDx9 -- 1755MB available Texture Memory
10:27:58.55   GAME -- SimulationController::Pause 1
10:28:15.30   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:28:45.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:29:46.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:30:01.99   Unabled to do upgrade, CANPRODUCE_NoResources
10:30:03.45   Unabled to do upgrade, CANPRODUCE_NoResources
10:30:04.70   Unabled to do upgrade, CANPRODUCE_NoResources
10:30:06.22   Unabled to do upgrade, CANPRODUCE_NoResources
10:30:06.47   SimulationController::GenerateSyncCmd - couldn't send all commands, 5 binned.
10:30:47.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:31:48.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:32:12.44   Activating screen: pause_menu
10:32:12.44   GAME -- SimulationController::Pause 0
10:32:15.83   SPDx9 -- 1755MB available Texture Memory
10:32:18.11   GAME -- SimulationController::Pause 1
10:32:43.53   Activating screen: Command_Branch
10:32:45.61   Activating screen: NewObjective
10:32:49.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:33:30.08   Unabled to do upgrade, CANPRODUCE_NoResources
10:33:31.23   Unabled to do upgrade, CANPRODUCE_NoResources
10:33:32.48   Unabled to do upgrade, CANPRODUCE_NoResources
10:33:33.46   Unabled to do upgrade, CANPRODUCE_NoResources
10:33:34.59   Unabled to do upgrade, CANPRODUCE_NoResources
10:33:50.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:34:35.83   An ability failed to cast because target validation failed: abilities\soviets_god_o_war_shoot
10:34:37.07   An ability failed to cast because target validation failed: abilities\soviets_god_o_war_shoot
10:34:38.33   An ability failed to cast because target validation failed: abilities\soviets_god_o_war_shoot
10:34:51.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
10:34:54.97   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:35:52.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.0/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
10:35:53.60   Activating screen: Command_Branch
10:35:53.75   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
10:36:13.49   Warning: binding repeat_3(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
