-- Log file for all dbTracef messages --

23:19:36.20   NetworkManager::Create - creating network manager
23:19:36.20   Read 269 bytes from network datastore login_cache.bin
23:19:36.20   Read 52 bytes from network datastore global_cache.bin
23:19:36.20   Read 28 bytes from network datastore ping_cache.bin
23:19:36.20   QuazalInitializer - static initializing Quazal library
23:19:36.20   PingCache - populating cache with 0 pings
23:19:36.53   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
23:19:36.58   WinTransport - CreateSocket exclusive broadcast socket was available.
23:19:36.58   WinTransport - CreateSocket listening for broadcasts on default port
23:19:36.76   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
23:19:36.76   WinTransport - Host IP Address #0: 5.3.208.164
23:19:36.76   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
23:19:36.76   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
23:19:36.76   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:19:36.76   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
23:19:36.76   SessionManager - Peer Header Size = 16 bytes
23:19:36.76   SessionManager - Game Data overhead = 7 bytes
23:19:36.76   SessionManager - Proxy overhead = 7 bytes
23:19:36.76   MessageInternal::CreateChannel: Created channel 47535450
23:19:36.76   Session::Initialize - info, initializing session object, using threads.
23:19:36.76   SessionManager::RegisterSession - Registering new session 07e12e40
23:19:36.76   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:19:36.76   AutomatchInternal: Instantiating
23:19:36.76   Net::ThreadFunction - Entering network thread function...
23:19:36.76   PartyInternal: Instantiating
23:19:36.76   MessageInternal::CreateChannel: Created channel 50525459
23:19:36.76   MessageInternal::CreateChannel: Created channel 51434b4d
23:19:36.78   Transport - Largest received is now 19
23:19:36.78   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
23:19:36.79   Transport - Largest sent is now 19
23:19:37.13   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
23:19:37.13   MessageInternal::CreateChannel: Created channel 534d5347
23:19:37.13   MessageInternal::CreateChannel: Created channel 474d4343
23:19:37.13   MessageInternal::CreateChannel: Created channel 474f424a
23:19:37.13   MessageInternal::CreateChannel: Created channel 4d4f444d
23:19:37.13   MessageInternal::CreateChannel: Created channel 53594e43
23:19:37.13   MessageInternal::DestroyChannel: Destroyed channel 534d5347
23:19:37.13   MessageInternal::DestroyChannel: Destroyed channel 474d4343
23:19:37.13   MessageInternal::DestroyChannel: Destroyed channel 474f424a
23:19:37.13   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
23:19:37.13   MessageInternal::DestroyChannel: Destroyed channel 53594e43
23:19:37.20   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
23:19:38.87   DLLDriverLinker -- Adding driver 'spDx10.dll'.
23:19:39.03   DLLDriverLinker -- Adding driver 'spDx9.dll'.
23:19:39.03   DLLDriverLinker -- 2 DLL drivers found.
23:19:39.27   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
23:19:41.42   DLLDriverLinker -- 2 DLL drivers found.
23:19:41.64   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
23:19:41.64   GAME -- Resolution set to 1024x768 (fullscreen).
23:19:41.68   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
23:19:41.68   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
23:19:41.68   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
23:19:41.68   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
23:19:42.29   SPDx9 -- 1774MB available Texture Memory
23:19:42.32   ShaderDatabase: using shader profile [ps30]
23:19:43.07   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
23:19:44.41   GameObjLoader 0c8a0278 - resetting counters
23:19:44.41   GameObjLoader 0c8a0278 - Created loader
23:19:44.41   GameObjLoader 0c8a03d8 - resetting counters
23:19:44.41   GameObjLoader 0c8a03d8 - Created loader
23:19:46.33   GAME -- Beginning FE
23:19:46.33   Sent message game CompanyOfHeroes started 3676 602 allowtraffic
23:19:46.33   RemoteDLManager - Connection Restored.
23:19:46.33   UIFrontEnd - Loading Front End
23:19:46.33   THREAD: Hyper-Threading Technology Processors are not detected.
23:19:46.81   SOUND -- Initializing ...
23:19:46.97   INNIMapDCA Key not found: sp_speechducker::time
23:19:47.67   SOUND -- Initialization completed!
23:19:47.67   UIFrontEnd - Initializing Forms
23:19:49.25   CampaignFilter::BindFilterSpecificWidgets()
23:19:49.37   Activating screen: AppLoadingForm
23:19:49.37   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:19:49.37   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
23:19:53.02   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
23:19:53.02   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
23:19:53.02   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
23:19:53.03   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
23:19:53.05   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
23:19:53.05   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
23:19:53.69   GAME -- Using player profile NGOCQUANG-PC
23:19:56.93   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
23:19:57.92   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
23:19:59.22   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
23:19:59.35   SPDx9 -- 1752MB available Texture Memory.  Unable to create 516x223 texture.
23:20:03.54   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
23:20:03.54   RendezvousManager: CreateSession - starting profile=Guest login
23:20:03.69   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
23:20:03.69   RendezvousManager - unable to connect to the server as guest
23:20:03.74   OnConnect: connect failure
23:20:03.74   RendezvousManager::Shutdown - deleting instance
23:20:03.74   RendezvousManager - terminating all server calls in progress
23:20:03.74   CallManager - terminating all server calls in progress (1 in progress)
23:20:03.74   RendezvousManager - destroying chat handler
23:20:03.74   ~RendezvousManager - m_state = 7, no need for server disconnect
23:20:03.76   OnConnect: this wasnt a reconnect, no need for autologin
23:20:03.86   CRC & Version Info : 0000025a:db0aab6c:ec3c9e0d blitzkrieg:602:ww2mod.dll 1
23:20:03.86   Activating screen: FEMovie
23:20:03.86   Activating screen: OnlineWidget
23:20:03.86   Activating screen: RelicOnlineLogin
23:20:03.86   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:20:04.02   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:20:04.02   You have a valid version of the game.
23:20:04.04   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
23:20:04.04   installed_products = ( DLC1 DLC2 DLC3 )
23:20:04.04   OnLogin: no previous login, auto selecting profile not required
23:20:04.04   Activating screen: MessageBoxPopup
23:20:04.04   Activating screen: MessageBoxPopup
23:20:04.04   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
23:20:20.26   SPDx9 -- 1770MB available Texture Memory
23:20:29.34   Beginning media verification...
23:20:29.34   Validator type : validators\udro\udro.dll
23:20:29.42   Activating screen: MessageBoxPopup
23:20:30.41   Activating screen: FE_mm_01
23:20:30.41   GAME -- Setting campaign state to 'dlc1'
23:20:30.41   GAME -- Closing state 'dlc1'
23:20:30.42   GAME -- Setting campaign state to 'dlc2'
23:20:30.42   GAME -- Closing state 'dlc2'
23:20:30.42   GAME -- Setting campaign state to 'dlc3'
23:20:30.42   GAME -- Closing state 'dlc3'
23:20:34.69   Activating screen: MessageBoxPopup
23:20:34.70   Created Matchinfo
23:20:34.70   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
23:20:34.70   starting LAN hosting
23:20:34.73   OnJoinAdvertisementSuccess - joined online match, server leave notification required
23:20:34.73   starting local hosting
23:20:34.73   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:20:34.73   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:20:34.73   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
23:20:34.73   Session::Host sid = 107E032061DCF09D, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
23:20:34.73   ValidateCustomData: called with 210 bytes of custom data
23:20:34.73   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
23:20:34.73   AdvertisementInternal::Process - EVENT_NEWPEER
23:20:34.73   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
23:20:34.75   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
23:20:34.75   hosting - Session is connected
23:20:34.75   Net::Session::SetVisible - session is set to VISIBLE.
23:20:34.75   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
23:20:34.75   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
23:20:34.76   Transport - Largest received is now 462
23:20:34.76   hosting completed successfully
23:20:34.76   HostAsync - completed with HostResult = 0
23:20:34.76   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
23:20:34.76   Activating screen: OnlineGameSetup
23:20:34.76   MessageInternal::CreateChannel: Created channel 534d5347
23:20:34.76   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:34.76   MatchInternal::SetMatchType - new type 14 - updating server
23:20:34.78   Transport - Largest received is now 518
23:20:34.83   SetVisible called while !IsConnected
23:20:34.83   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:34.83   Activating screen: RelicOnlineChat
23:20:34.83   Activating screen: RelicOnlineNewsScreen
23:20:34.83   Activating screen: RelicOnlineStatsScreen
23:20:34.83   Activating screen: Achievements
23:20:34.83   GAME -- Setting campaign state to 'dlc1'
23:20:34.83   GAME -- Closing state 'dlc1'
23:20:34.84   GAME -- Setting campaign state to 'dlc2'
23:20:34.84   GAME -- Closing state 'dlc2'
23:20:34.84   GAME -- Setting campaign state to 'dlc3'
23:20:34.84   GAME -- Closing state 'dlc3'
23:20:34.84   Transport - Largest received is now 739
23:20:34.84   Activating screen: GameHistory
23:20:34.84   GAME -- Setting campaign state to 'dlc1'
23:20:34.84   GAME -- Closing state 'dlc1'
23:20:34.85   GAME -- Setting campaign state to 'dlc2'
23:20:34.85   GAME -- Closing state 'dlc2'
23:20:34.85   GAME -- Setting campaign state to 'dlc3'
23:20:34.85   GAME -- Closing state 'dlc3'
23:20:34.85   Activating screen: OnlineGameSetup
23:20:34.85   Activating screen: RelicOnlineTabs
23:20:34.85   AutomatchInternal::OnHostComplete - Completed Host with success=1
23:20:34.85   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
23:20:34.85   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
23:20:34.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:34.85   Net::Session::SetVisible - session is set to VISIBLE.
23:20:34.86   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:34.86   Transport - Largest received is now 1113
23:20:35.07   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:35.09   GAME -- Setting campaign state to 'dlc1'
23:20:35.09   GAME -- Closing state 'dlc1'
23:20:35.09   GAME -- Setting campaign state to 'dlc2'
23:20:35.09   GAME -- Closing state 'dlc2'
23:20:35.09   GAME -- Setting campaign state to 'dlc3'
23:20:35.09   GAME -- Closing state 'dlc3'
23:20:35.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:36.59   Activating screen: DynamicPopupMenu
23:20:37.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.5, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:20:38.21   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:38.21   MatchInternal::SetMatchType - new type 0 - updating server
23:20:38.21   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:38.21   Net::Session::SetVisible - session is set to VISIBLE.
23:20:38.21   Net::Session::SetVisible - session is set to VISIBLE.
23:20:38.21   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:38.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:38.26   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:38.26   Net::Session::SetVisible - session is set to VISIBLE.
23:20:38.26   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:38.28   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:38.31   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:39.55   Activating screen: DynamicPopupMenu
23:20:40.45   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:40.45   Net::Session::SetVisible - session is set to VISIBLE.
23:20:40.45   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:40.47   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:40.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:41.09   Activating screen: DynamicPopupMenu
23:20:41.88   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:41.88   Net::Session::SetVisible - session is set to VISIBLE.
23:20:41.88   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:41.89   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:41.92   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:42.60   Activating screen: DynamicPopupMenu
23:20:43.55   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:43.55   Net::Session::SetVisible - session is set to VISIBLE.
23:20:43.55   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:43.56   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:43.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:44.47   Activating screen: DynamicPopupMenu
23:20:45.21   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:45.21   Net::Session::SetVisible - session is set to VISIBLE.
23:20:45.22   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:45.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:45.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:45.73   Activating screen: DynamicPopupMenu
23:20:46.33   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:46.33   Net::Session::SetVisible - session is set to VISIBLE.
23:20:46.33   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:46.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:46.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:46.73   Activating screen: DynamicPopupMenu
23:20:47.22   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:47.22   Net::Session::SetVisible - session is set to VISIBLE.
23:20:47.22   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:47.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:47.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:47.83   Activating screen: DynamicPopupMenu
23:20:48.59   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:20:48.59   Net::Session::SetVisible - session is set to VISIBLE.
23:20:48.59   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:48.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:48.65   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:49.04   Activating screen: DynamicPopupMenu
23:20:49.60   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:49.60   MatchInternal::SetMatchType - new type 14 - updating server
23:20:49.60   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:49.60   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:49.60   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:49.60   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:49.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:49.65   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:49.65   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:49.65   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:49.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:49.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:51.16   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:51.16   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:51.16   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:51.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:51.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:53.11   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:53.11   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:53.11   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:53.12   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:53.17   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:55.13   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:55.13   Net::Session::SetVisible - session is set to INVISIBLE.
23:20:55.13   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.360925, bars=3, max avg=0.066, sd=0.009, 3 samples =  0.08 0.07 0.05
23:20:55.16   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:55.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:56.18   GameSetupForm - No win/loss reporting and only a single player, disconnecting
23:20:56.18   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:20:56.18   SetVisible called while !IsConnected
23:20:56.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:56.19   GameSetupForm - Starting game
23:20:56.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:20:56.19   PopulateGameInfo - random seed:[1308846056], guid:[{4353e65d-b089-40af-845d-4a2c8b5e24c3}], sync level:[2]
23:20:56.19   Error loading [DATA:levelingCurve.lua]
23:20:56.20   Error loading [DATA:levelingCurve.lua]
23:20:56.20   Error loading [DATA:levelingCurve.lua]
23:20:56.20   Error loading [DATA:levelingCurve.lua]
23:20:56.20   Error loading [DATA:levelingCurve.lua]
23:20:56.21   Error loading [DATA:levelingCurve.lua]
23:20:56.21   Error loading [DATA:levelingCurve.lua]
23:20:56.21   Error loading [DATA:levelingCurve.lua]
23:20:56.21   MOD - Setting player (0) race to: allies
23:20:56.21   MOD - Setting player (0) race to: 1
23:20:56.21   MOD - Setting player (1) race to: allies
23:20:56.21   MOD - Setting player (1) race to: 1
23:20:56.21   MOD - Setting player (2) race to: allies
23:20:56.21   MOD - Setting player (2) race to: 1
23:20:56.21   MOD - Setting player (3) race to: allies
23:20:56.21   MOD - Setting player (3) race to: 1
23:20:56.21   MOD - Setting player (4) race to: axis
23:20:56.21   MOD - Setting player (4) race to: 2
23:20:56.21   MOD - Setting player (5) race to: axis
23:20:56.21   MOD - Setting player (5) race to: 2
23:20:56.21   MOD - Setting player (6) race to: axis
23:20:56.21   MOD - Setting player (6) race to: 2
23:20:56.21   MOD - Setting player (7) race to: axis
23:20:56.21   MOD - Setting player (7) race to: 2
23:20:56.21   Activating screen: MessageBoxPopup
23:20:56.21   Session is marking the local peer PeerID 1 for death
23:20:56.21   Session::GetEvent DestroyPeer success Peer 1 removed
23:20:56.21   Session::DestroyPeer - deallocating peer 1
23:20:56.21   Session - Requested Disconnect for connectionID 2
23:20:56.21   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:20:56.21   Session - Requested Disconnect for connectionID 3
23:20:56.21   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:20:56.21   AdvertisementInternal::Process - EVENT_DESTROYPEER
23:20:56.21   Destroyed Matchinfo
23:20:56.23   APP -- Game Start
23:20:56.23   Sent message game CompanyOfHeroes allowtraffic
23:20:56.23   GAME -- Setting campaign state to 'dlc1'
23:20:56.23   GAME -- Closing state 'dlc1'
23:20:56.24   GAME -- Setting campaign state to 'dlc2'
23:20:56.24   GAME -- Closing state 'dlc2'
23:20:56.24   GAME -- Setting campaign state to 'dlc3'
23:20:56.24   GAME -- Closing state 'dlc3'
23:20:56.24   MessageInternal::DestroyChannel: Destroyed channel 534d5347
23:20:56.25   GAME -- Ending FE
23:20:56.25   UIFrontEnd - Unloading Front End
23:20:56.27   SOUND -- Shutting down ...
23:20:56.32   SOUND -- Shutdown completed!
23:20:56.34
23:20:56.34   GAME -- *** Beginning mission 8p_chambois (8) (1 Humans, 7 Computers) ***
23:20:56.34
23:20:56.57   GAME -- Recording game
23:20:56.64   Activating screen: GameLoadScreen
23:20:56.65   ReportGameStartStats - no connection to server unable to report
23:20:56.65   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
23:20:56.65   PeerRemoveAll - flushing local session peer data
23:20:56.65   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
23:20:56.65   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
23:20:57.04   THREAD: Hyper-Threading Technology Processors are not detected.
23:20:57.11   SOUND -- Initializing ...
23:20:58.00   SOUND -- Initialization completed!
23:20:58.05   PHYSICS: detected processor(s) capable of handling 4 threads.
23:20:58.10   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\8p_chambois (8)'
23:20:58.10   MOD -- Using Mod 'Blitzkrieg'
23:20:58.11   Unable to load/parse precache file [DATA:scenarios\mp\8p_chambois (8)_precache.lua]
23:20:58.24   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'.  Expensive operation
23:20:58.24   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'.  Expensive operation
23:20:59.45   GameObjLoader - upgrading load_count from 0 to 1125
23:21:04.42   GameObjLoader - upgrading load_count from 1125 to 1847
23:21:04.64   PHYSICS -- Created node factory 'HVOK'
23:21:04.64   PHYSICS -- Created node factory 'DMMY'
23:21:30.53   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'.  Expensive operation
23:21:37.55   SPDx9 -- 1770MB available Texture Memory
23:21:38.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.8, max unsent 0, version err 0, merge 0
23:22:05.92   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'.  Expensive operation
23:22:15.94   GameObjLoader - upgrading load_count from 60 to 4342
23:22:28.19   GameObjLoader 0c8a0278 - resetting counters
23:22:28.19   GameObjLoader 0c8a0278 - LOAD_DONE
23:22:28.19   GAME - SessionSetup
23:22:28.89   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
23:22:28.90   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
23:22:28.90   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
23:22:34.05   GAME - CreateGEWorld in 5859 ms
23:22:34.11   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
23:22:34.55   GAME - SessionSetup finished in 6356 ms
23:22:34.55   GAME - WaterReflectionManagerSetup
23:22:34.55   GAME - WaterReflectionManagerSetup finished in 0 ms
23:22:35.17   MessageInternal::CreateChannel: Created channel 474d4343
23:22:35.23   Regenerating ImpassMap data...
23:22:35.23       Impass Data was already valid, but regenerating...
23:22:35.48   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
23:22:35.48   Regenerating CanBuildMap data...
23:22:35.48   Generating CanShoot Map.
23:22:35.48   Pathfinder::Regenerate()...
23:22:35.55   Generating PathSectorMap...
23:22:36.02   Pathfinder::Regenerate() Done.
23:22:36.29   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/ZANNIHILATE.SCAR] succeeded.
23:22:37.60   MessageInternal::CreateChannel: Created channel 4d4f444d
23:22:38.56   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:22:38.57   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:22:38.57   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:22:38.57   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:22:38.57   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:22:38.90   SPEECHMANAGER -- Loaded in 0.289654 seconds
23:22:39.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:22:41.28   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_upper_load.smf'.  Expensive operation
23:22:43.24   GameObjLoader - upgrading load_count from 0 to 2159
23:22:52.05   GameObjLoader 0c8a03d8 - resetting counters
23:22:52.05   GameObjLoader 0c8a03d8 - LOAD_DONE
23:22:54.73   PreloadResources took 2088ms.
23:22:54.87   GAME -- Loading completed (118 seconds)
23:22:54.87   SIM -- Setting SyncErrorChecking level to None
23:22:58.36   Activating screen: GameScreen
23:22:58.36   Activating screen: Decorators
23:22:58.36   Activating screen: Taskbar
23:22:58.36   Activating screen: SubtitleScreen
23:22:58.36   Activating screen: TextOverlayScreen
23:22:58.53   PerformanceRecorder::StartRecording for game size 8
23:22:58.53   GAME -- Starting mission...
23:23:00.71   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Hard set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Hard set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Hard set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:23:00.71   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:23:05.35   Warning: non auto-match upgrade not found in AE, tuning
23:23:06.65   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:23:15.24   Activating screen: pause_menu
23:23:15.24   GAME -- SimulationController::Pause 0
23:23:18.71   SPDx9 -- 1757MB available Texture Memory
23:23:20.63   GAME -- SimulationController::Pause 1
23:23:32.08   Activating screen: Command_Tree
23:23:33.93   Activating screen: Command_Branch
23:23:40.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:23:41.69   Activating screen: Command_Branch
23:23:54.07   Activating screen: Command_Branch
23:24:06.77   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
23:24:06.77   Warning: binding repeat_0(Production Item: upgrade\allies\research\abilities_ki) -- ui index '0' out of bounds; range is [1, 12]
23:24:41.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:25:20.47   Activating screen: pause_menu
23:25:20.47   GAME -- SimulationController::Pause 0
23:25:24.09   SPDx9 -- 1757MB available Texture Memory
23:25:26.51   GAME -- SimulationController::Pause 1
23:25:42.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:25:53.70   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:25:54.20   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:25:54.70   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:25:55.23   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:26:43.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:27:38.22   Warning: binding repeat_5(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:27:40.51   Activating screen: pause_menu
23:27:40.51   GAME -- SimulationController::Pause 0
23:27:43.95   SPDx9 -- 1757MB available Texture Memory
23:27:44.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:27:45.47   GAME -- SimulationController::Pause 1
23:27:51.98   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:28:45.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:29:19.22   Activating screen: Command_Branch
23:29:46.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:29:58.99   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:30:15.67   Activating screen: pause_menu
23:30:15.67   GAME -- SimulationController::Pause 0
23:30:18.64   SPDx9 -- 1757MB available Texture Memory
23:30:20.68   GAME -- SimulationController::Pause 1
23:30:31.12   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:30:47.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:31:24.06   Was already stealing a skeleton when told to steal another [mortar_target].
23:31:29.24   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:31:48.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:32:02.14   Activating screen: Command_Branch
23:32:08.52   Activating screen: Command_Branch
23:32:29.96   Unable to bind updater for fx [ui\reveal].  It could be looping in a fire-n-forget action.
23:32:49.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:33:05.72   Activating screen: pause_menu
23:33:05.73   GAME -- SimulationController::Pause 0
23:33:09.19   SPDx9 -- 1757MB available Texture Memory
23:33:11.71   GAME -- SimulationController::Pause 1
23:33:14.04   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:33:14.04   Muting spew of bind updater.  Fix art and re-test.
23:33:50.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:34:01.85   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:03.21   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:04.22   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:05.48   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:06.60   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:07.71   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:08.84   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:09.96   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:11.22   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:12.34   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:13.46   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:14.47   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:15.60   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:16.72   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:17.71   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:18.71   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:19.71   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:20.73   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:21.72   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:22.71   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:23.83   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:24.86   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:25.84   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:26.85   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:27.71   Was already stealing a skeleton when told to steal another [mortar_target].
23:34:27.87   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:29.11   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:29.92   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:30.24   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:30.85   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:31.37   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:31.98   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:33.11   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:34.23   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:35.49   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:36.54   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:37.56   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:38.69   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:39.67   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:40.95   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:41.99   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:43.21   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:44.32   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:45.33   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:46.59   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:47.69   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:48.83   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:49.95   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:51.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:34:51.08   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:52.20   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:53.34   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:54.33   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:55.57   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:56.58   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:57.58   Unabled to do upgrade, CANPRODUCE_NoResources
23:34:58.83   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:00.08   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:01.31   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:02.33   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:03.52   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:04.53   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:05.54   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:06.77   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:07.89   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:09.02   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:10.15   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:11.29   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:12.28   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:13.69   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:14.68   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:15.94   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:16.92   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:17.93   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:18.94   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:20.20   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:21.19   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:22.17   Unabled to do upgrade, CANPRODUCE_NoResources
23:35:31.76   FXShader::SetVariable( "tex0", T ) uses unknown variable.
23:35:40.42   Activating screen: Command_Branch
23:35:52.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:36:02.72   Was already stealing a skeleton when told to steal another [flakvierling_sync].
23:36:05.58   Activating screen: Command_Branch
23:36:10.86   Activating screen: pause_menu
23:36:10.86   GAME -- SimulationController::Pause 0
23:36:14.44   SPDx9 -- 1757MB available Texture Memory
23:36:16.69   GAME -- SimulationController::Pause 1
23:36:53.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:37:21.97   Warning: binding repeat_0(Production Item: upgrade\axis\items\axis_squad_item_tank_top_mg42) -- ui index '0' out of bounds; range is [1, 3]
23:37:33.36   Was already stealing a skeleton when told to steal another [mortar_target].
23:37:54.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:38:49.08   Activating screen: Command_Branch
23:38:55.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:39:29.82   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:39:30.91   Activating screen: pause_menu
23:39:30.91   GAME -- SimulationController::Pause 0
23:39:34.16   SPDx9 -- 1757MB available Texture Memory
23:39:37.81   GAME -- SimulationController::Pause 1
23:39:56.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:40:57.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:41:58.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:42:01.59   Activating screen: Command_Branch
23:42:59.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:43:05.91   Activating screen: pause_menu
23:43:05.91   GAME -- SimulationController::Pause 0
23:43:11.02   SPDx9 -- 1757MB available Texture Memory
23:43:13.22   GAME -- SimulationController::Pause 1
23:44:00.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:44:16.85   SimulationController::GenerateSyncCmd - couldn't send all commands, 4 binned.
23:44:25.25   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
23:44:34.50   SimulationController::GenerateSyncCmd - couldn't send all commands, 2 binned.
23:44:45.26   MOD -- Player CPU - Hard (kill endgame) (frame 10007) (KillPlayer)
23:44:45.26   MOD -- Player CPU - Hard (kill endgame) (frame 10007) (KillPlayer)
23:44:45.26   MOD -- Player CPU - Expert (kill endgame) (frame 10007) (KillPlayer)
23:44:45.26   MOD -- Player CPU - Hard (kill endgame) (frame 10007) (KillPlayer)
23:44:45.26   MOD -- Game Over at frame 10007
23:44:45.28   GameApp::ReportStats
23:44:45.28   ReportStats - untracked game, no need to report match 4294967295:4294967295
23:44:45.28   ReportSimStats - nothing to report, no connection to the server
23:44:45.28   ReportStats - ReportSimStats failed
23:44:45.28   GameObj::DoGameOverPopup
23:44:45.29   Activating screen: GameOverDialog
23:44:45.29   ArbitrationMessageNeeded adding player 1002 [57639399023432] as victorious ally
23:44:45.29   ArbitrationMessageNeeded 1 allies vs 0 enemies result 0
23:44:45.29   GameOverDialog - normal game ending (no sync errors)
23:44:49.56   Activating screen: ViewStats
23:44:52.79   Activating screen: postgame_stats_skirm
23:44:54.35   Activating screen: AppRestartingForm
23:44:54.35   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:44:54.35   Widget attempting to remove a non-existance listener. Widget:bkg_COH
23:44:54.35   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
23:44:54.35   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
23:44:54.35   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
23:44:54.35   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
23:44:54.47   APP -- Game Stop
23:44:54.47   GameApp::TransitionGameStop
23:44:54.47   GameApp::TransitionQuitCommon
23:44:54.47   PerformanceRecorder: Updating profile history
23:44:54.47   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:44:54.47   PerformanceRecorder::EndRecording - game size=8, max average=0.071338, worst frame=0.075404
23:44:54.47    Recording: No [8 players]
23:44:54.47    Total render, sim time: 10.47, 12.66 sec
23:44:54.47    Total render, sim frames: 364, 90
23:44:54.47    Max/Avg: 0.07, 0.04 sec (fps=14.02, 23.56) (65 samples)
23:44:54.47    Bars: 4
23:44:54.47   Profile Max Performance[8 players] =  0.07 0.08 0.07 0.05 0.00
23:44:54.47   Profile Avg Performance[8 players] =  0.04 0.04 0.04 0.04 0.00
23:44:54.47   GameObj::ShutdownGameObj
23:44:54.47   GAME -- Ending mission (Game over)
23:44:54.51   GameObjLoader 0c8a03d8 - Unload
23:44:54.51   GameObjLoader 0c8a03d8 - resetting counters
23:44:54.63   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
23:44:54.83   GameObjLoader 0c8a0278 - Unload
23:44:54.83   GameObjLoader 0c8a0278 - resetting counters
23:44:54.94   SOUND -- Shutting down ...
23:44:55.08   SOUND -- Shutdown completed!
23:44:55.11   MessageInternal::DestroyChannel: Destroyed channel 474d4343
23:44:55.11   GAME -- Beginning FE
23:44:55.11   Sent message game CompanyOfHeroes allowtraffic
23:44:55.11   UIFrontEnd - Loading Front End
23:44:55.11   THREAD: Hyper-Threading Technology Processors are not detected.
23:44:55.24   SOUND -- Initializing ...
23:44:55.29   SOUND -- Initialization completed!
23:44:55.29   UIFrontEnd - Initializing Forms
23:44:56.88   CampaignFilter::BindFilterSpecificWidgets()
23:44:56.93   Turning off auto-selection of profiles, we already have a profile selected.
23:44:57.02   MOD -- Mounting BlitzkriegDLC1, 1.0
23:44:57.06   FILESYSTEM -- filepath failure, path does not exist 'DLC1\Data\'
23:44:57.06   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC1\Data\'
23:44:57.06   FILESYSTEM -- filepath failure, path does not exist 'DLC1\DataArtHigh\'
23:44:57.06   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC1\DataArtHigh\'
23:44:57.11   FILESYSTEM -- filepath failure, path does not exist 'DLC1\DataSoundEnglish\'
23:44:57.11   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC1\DataSoundEnglish\'
23:44:57.13   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC1\Movies\'
23:44:57.13   MOD -- Mounting BlitzkriegDLC2, 1.0
23:44:57.20   FILESYSTEM -- filepath failure, path does not exist 'DLC2\Data\'
23:44:57.20   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC2\Data\'
23:44:57.20   FILESYSTEM -- filepath failure, path does not exist 'DLC2\DataArtHigh\'
23:44:57.20   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC2\DataArtHigh\'
23:44:57.25   FILESYSTEM -- filepath failure, path does not exist 'DLC2\DataSoundEnglish\'
23:44:57.25   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC2\DataSoundEnglish\'
23:44:57.25   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC2\Movies\'
23:44:57.25   MOD -- Mounting BlitzkriegDLC3, 1.0
23:44:57.31   FILESYSTEM -- filepath failure, path does not exist 'DLC3\Data\'
23:44:57.31   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC3\Data\'
23:44:57.32   FILESYSTEM -- filepath failure, path does not exist 'DLC3\DataArtHigh\'
23:44:57.32   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC3\DataArtHigh\'
23:44:57.35   FILESYSTEM -- filepath failure, path does not exist 'DLC3\DataSoundEnglish\'
23:44:57.35   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC3\DataSoundEnglish\'
23:44:57.35   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC3\Movies\'
23:44:57.35   MOD -- Mounting BlitzkriegOps, 1.0
23:44:57.40   FILESYSTEM -- filepath failure, path does not exist 'CoH\Ops\Data\'
23:44:57.40   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\CoH\Ops\Data\'
23:44:57.40   MOD -- Mounting Blitzkrieg, v1.60 Open Beta
23:44:57.44   FILESYSTEM -- filepath failure, path does not exist 'RelicOnline\Data\'
23:44:57.44   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\RelicOnline\Data\'
23:44:57.58   FILESYSTEM -- filepath failure, path does not exist 'CoH\Engine\Data\'
23:44:57.58   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\CoH\Engine\Data\'
23:44:57.59   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Blitzkrieg\Data\'
23:44:57.96   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Blitzkrieg\Data\'
23:44:58.08   FILESYSTEM -- filepath failure, path does not exist 'CoH\DataArtHigh\'
23:44:58.08   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\CoH\DataArtHigh\'
23:44:58.27   FILESYSTEM -- filepath failure, path does not exist 'Coh\DataSoundHigh\'
23:44:58.27   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Coh\DataSoundHigh\'
23:44:58.29   FILESYSTEM -- filepath failure, path does not exist 'Engine\Locale\English\Data\'
23:44:58.29   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Engine\Locale\English\Data\'
23:44:58.93   FILESYSTEM -- filepath failure, path does not exist 'CoH\DataSoundEnglish\'
23:44:58.93   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\CoH\DataSoundEnglish\'
23:44:58.98   FILESYSTEM -- filepath failure, path does not exist 'CoH\Locale\English\Data\'
23:44:58.98   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\CoH\Locale\English\Data\'
23:44:59.02   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Blitzkrieg\DataAttrib\'
23:44:59.02   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC3\Movies\'
23:44:59.02   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC2\Movies\'
23:44:59.02   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\DLC1\Movies\'
23:44:59.02   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\Engine\Movies\'
23:44:59.03   FILESYSTEM -- filepath failure, path does not exist 'C:\Users\Ngoc.Quang\Documents\My Games\Company of Heroes\WW2\Movies\'
23:44:59.03   Activating screen: AppRestartingForm
23:44:59.03   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:44:59.03   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
23:44:59.58   SPDx9 -- 1763MB available Texture Memory.  Unable to create 516x223 texture.
23:44:59.69   SPDx9 -- 1763MB available Texture Memory.  Unable to create 516x223 texture.
23:45:00.82   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:45:00.84   CRC & Version Info : 0000025a:db0aab6c:ec3c9e0d blitzkrieg:602:ww2mod.dll 1
23:45:00.84   Activating screen: FEMovie
23:45:00.84   Activating screen: OnlineWidget
23:45:00.84   Activating screen: FE_mm_01
23:45:00.89   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:45:00.89   GAME -- Setting campaign state to 'dlc1'
23:45:00.89   GAME -- Closing state 'dlc1'
23:45:00.92   GAME -- Setting campaign state to 'dlc2'
23:45:00.92   GAME -- Closing state 'dlc2'
23:45:00.92   GAME -- Setting campaign state to 'dlc3'
23:45:00.92   GAME -- Closing state 'dlc3'
23:45:01.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.2/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:45:36.76   Activating screen: MessageBoxPopup
23:45:36.76   Created Matchinfo
23:45:36.76   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
23:45:36.76   starting LAN hosting
23:45:36.79   OnJoinAdvertisementSuccess - joined online match, server leave notification required
23:45:36.79   starting local hosting
23:45:36.79   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
23:45:36.79   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:45:36.79   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
23:45:36.79   Session::Host sid = 82DC1FA36EF2A1B0, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
23:45:36.79   ValidateCustomData: called with 210 bytes of custom data
23:45:36.79   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
23:45:36.79   AdvertisementInternal::Process - EVENT_NEWPEER
23:45:36.79   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
23:45:36.81   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
23:45:36.81   hosting - Session is connected
23:45:36.81   Net::Session::SetVisible - session is set to VISIBLE.
23:45:36.81   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
23:45:36.81   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
23:45:36.82   hosting completed successfully
23:45:36.82   HostAsync - completed with HostResult = 0
23:45:36.82   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
23:45:36.82   Activating screen: OnlineGameSetup
23:45:36.82   MessageInternal::CreateChannel: Created channel 534d5347
23:45:36.83   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:36.83   MatchInternal::SetMatchType - new type 14 - updating server
23:45:36.84   SetVisible called while !IsConnected
23:45:36.84   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:36.84   Activating screen: RelicOnlineChat
23:45:36.84   Activating screen: RelicOnlineNewsScreen
23:45:36.85   Activating screen: RelicOnlineStatsScreen
23:45:36.85   Activating screen: Achievements
23:45:36.85   GAME -- Setting campaign state to 'dlc1'
23:45:36.85   GAME -- Closing state 'dlc1'
23:45:36.85   GAME -- Setting campaign state to 'dlc2'
23:45:36.85   GAME -- Closing state 'dlc2'
23:45:36.85   GAME -- Setting campaign state to 'dlc3'
23:45:36.85   GAME -- Closing state 'dlc3'
23:45:36.86   Activating screen: GameHistory
23:45:36.86   GAME -- Setting campaign state to 'dlc1'
23:45:36.86   GAME -- Closing state 'dlc1'
23:45:36.86   GAME -- Setting campaign state to 'dlc2'
23:45:36.86   GAME -- Closing state 'dlc2'
23:45:36.86   GAME -- Setting campaign state to 'dlc3'
23:45:36.86   GAME -- Closing state 'dlc3'
23:45:36.86   Activating screen: OnlineGameSetup
23:45:36.86   Activating screen: RelicOnlineTabs
23:45:36.86   AutomatchInternal::OnHostComplete - Completed Host with success=1
23:45:36.86   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
23:45:36.86   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
23:45:36.87   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:36.87   Net::Session::SetVisible - session is set to VISIBLE.
23:45:36.87   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:36.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:36.96   GAME -- Setting campaign state to 'dlc1'
23:45:36.96   GAME -- Closing state 'dlc1'
23:45:36.96   GAME -- Setting campaign state to 'dlc2'
23:45:36.96   GAME -- Closing state 'dlc2'
23:45:36.96   GAME -- Setting campaign state to 'dlc3'
23:45:36.96   GAME -- Closing state 'dlc3'
23:45:37.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:46.50   Activating screen: DynamicPopupMenu
23:45:49.41   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:49.41   MatchInternal::SetMatchType - new type 0 - updating server
23:45:49.41   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:49.41   Net::Session::SetVisible - session is set to VISIBLE.
23:45:49.41   Net::Session::SetVisible - session is set to VISIBLE.
23:45:49.42   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:49.42   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:49.45   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:49.45   Net::Session::SetVisible - session is set to VISIBLE.
23:45:49.45   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:49.47   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:49.50   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:50.17   Activating screen: DynamicPopupMenu
23:45:50.94   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:50.94   Net::Session::SetVisible - session is set to VISIBLE.
23:45:50.94   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:50.96   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:51.00   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:51.47   Activating screen: DynamicPopupMenu
23:45:52.19   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:52.19   Net::Session::SetVisible - session is set to VISIBLE.
23:45:52.19   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:52.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:52.24   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:52.84   Activating screen: DynamicPopupMenu
23:45:53.46   GameSetupForm - UpdateMatchType: Setting match type to 0: BASIC_MATCH
23:45:53.46   Net::Session::SetVisible - session is set to VISIBLE.
23:45:53.47   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:53.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:53.53   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:53.99   Activating screen: DynamicPopupMenu
23:45:54.97   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:54.97   MatchInternal::SetMatchType - new type 14 - updating server
23:45:54.97   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:54.97   Net::Session::SetVisible - session is set to INVISIBLE.
23:45:54.97   Net::Session::SetVisible - session is set to INVISIBLE.
23:45:54.97   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:54.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:55.01   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:55.01   Net::Session::SetVisible - session is set to INVISIBLE.
23:45:55.01   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:55.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:55.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:57.11   Activating screen: RaceSelectionPopup
23:45:59.77   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:45:59.77   Net::Session::SetVisible - session is set to INVISIBLE.
23:45:59.77   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:45:59.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:45:59.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:00.82   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:46:00.82   Net::Session::SetVisible - session is set to INVISIBLE.
23:46:00.83   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:46:00.83   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:00.88   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:02.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.7, max unsent 0, version err 0, merge 0
23:46:02.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:46:02.71   Net::Session::SetVisible - session is set to INVISIBLE.
23:46:02.71   GetMaxFrameTimeFromProfile: players=8 expected FPS=13.261894, bars=3, max avg=0.067, sd=0.008, 4 samples =  0.07 0.08 0.07 0.05
23:46:02.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:02.77   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:03.36   GameSetupForm - No win/loss reporting and only a single player, disconnecting
23:46:03.36   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
23:46:03.36   SetVisible called while !IsConnected
23:46:03.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:03.37   GameSetupForm - Starting game
23:46:03.37   GameInfo::ResetInfo - SyncLevel set to 0 on reset
23:46:03.37   PopulateGameInfo - random seed:[1308847563], guid:[{40ce0cf4-b39d-4cb0-809d-a90bb80285dc}], sync level:[2]
23:46:03.37   Error loading [DATA:levelingCurve.lua]
23:46:03.37   Error loading [DATA:levelingCurve.lua]
23:46:03.38   Error loading [DATA:levelingCurve.lua]
23:46:03.38   Error loading [DATA:levelingCurve.lua]
23:46:03.38   Error loading [DATA:levelingCurve.lua]
23:46:03.38   Error loading [DATA:levelingCurve.lua]
23:46:03.39   Error loading [DATA:levelingCurve.lua]
23:46:03.39   Error loading [DATA:levelingCurve.lua]
23:46:03.39   MOD - Setting player (0) race to: allies
23:46:03.39   MOD - Setting player (0) race to: 1
23:46:03.39   MOD - Setting player (1) race to: allies
23:46:03.39   MOD - Setting player (1) race to: 1
23:46:03.39   MOD - Setting player (2) race to: allies
23:46:03.39   MOD - Setting player (2) race to: 1
23:46:03.39   MOD - Setting player (3) race to: allies
23:46:03.39   MOD - Setting player (3) race to: 1
23:46:03.39   MOD - Setting player (4) race to: axis
23:46:03.39   MOD - Setting player (4) race to: 2
23:46:03.39   MOD - Setting player (5) race to: axis
23:46:03.39   MOD - Setting player (5) race to: 2
23:46:03.39   MOD - Setting player (6) race to: axis
23:46:03.39   MOD - Setting player (6) race to: 2
23:46:03.39   MOD - Setting player (7) race to: axis
23:46:03.39   MOD - Setting player (7) race to: 2
23:46:03.39   Activating screen: MessageBoxPopup
23:46:03.39   Session is marking the local peer PeerID 1 for death
23:46:03.39   Session::GetEvent DestroyPeer success Peer 1 removed
23:46:03.39   Session::DestroyPeer - deallocating peer 1
23:46:03.39   Session - Requested Disconnect for connectionID 4
23:46:03.39   Deallocated route ID=5 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:46:03.39   Session - Requested Disconnect for connectionID 5
23:46:03.39   Closed route 5<>5 for PeerID 1 at WINaddr:5.3.208.164:6112;
23:46:03.39   AdvertisementInternal::Process - EVENT_DESTROYPEER
23:46:03.39   Destroyed Matchinfo
23:46:03.41   APP -- Game Start
23:46:03.41   Sent message game CompanyOfHeroes allowtraffic
23:46:03.41   GAME -- Setting campaign state to 'dlc1'
23:46:03.41   GAME -- Closing state 'dlc1'
23:46:03.41   GAME -- Setting campaign state to 'dlc2'
23:46:03.41   GAME -- Closing state 'dlc2'
23:46:03.41   GAME -- Setting campaign state to 'dlc3'
23:46:03.41   GAME -- Closing state 'dlc3'
23:46:03.41   MessageInternal::DestroyChannel: Destroyed channel 534d5347
23:46:03.42   GAME -- Ending FE
23:46:03.42   UIFrontEnd - Unloading Front End
23:46:03.44   SOUND -- Shutting down ...
23:46:03.49   SOUND -- Shutdown completed!
23:46:03.52
23:46:03.52   GAME -- *** Beginning mission 8p_chambois (8) (1 Humans, 7 Computers) ***
23:46:03.52
23:46:03.69   GAME -- Recording game
23:46:03.76   Activating screen: GameLoadScreen
23:46:03.76   ReportGameStartStats - no connection to server unable to report
23:46:03.76   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
23:46:03.76   PeerRemoveAll - flushing local session peer data
23:46:03.76   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
23:46:03.76   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
23:46:04.03   THREAD: Hyper-Threading Technology Processors are not detected.
23:46:04.12   SOUND -- Initializing ...
23:46:05.00   SOUND -- Initialization completed!
23:46:05.02   PHYSICS: detected processor(s) capable of handling 4 threads.
23:46:05.03   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\8p_chambois (8)'
23:46:05.03   MOD -- Using Mod 'Blitzkrieg'
23:46:05.05   Unable to load/parse precache file [DATA:scenarios\mp\8p_chambois (8)_precache.lua]
23:46:05.21   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
23:46:05.21   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
23:46:06.39   GameObjLoader - upgrading load_count from 0 to 1096
23:46:09.14   GameObjLoader - upgrading load_count from 1096 to 1846
23:46:39.25   GameObjLoader - upgrading load_count from 30 to 4342
23:46:42.14   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
23:46:43.71   GameObjLoader 0c8a0278 - resetting counters
23:46:43.71   GameObjLoader 0c8a0278 - LOAD_DONE
23:46:43.71   GAME - SessionSetup
23:46:43.80   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
23:46:43.80   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
23:46:43.80   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
23:46:45.83   GAME - CreateGEWorld in 2117 ms
23:46:45.86   GAME - SessionSetup finished in 2149 ms
23:46:45.86   GAME - WaterReflectionManagerSetup
23:46:45.86   GAME - WaterReflectionManagerSetup finished in 0 ms
23:46:46.48   MessageInternal::CreateChannel: Created channel 474d4343
23:46:46.49   Regenerating ImpassMap data...
23:46:46.49       Impass Data was already valid, but regenerating...
23:46:46.74   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
23:46:46.74   Regenerating CanBuildMap data...
23:46:46.74   Generating CanShoot Map.
23:46:46.74   Pathfinder::Regenerate()...
23:46:46.81   Generating PathSectorMap...
23:46:47.27   Pathfinder::Regenerate() Done.
23:46:47.37   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/ZANNIHILATE.SCAR] succeeded.
23:46:48.14   MessageInternal::CreateChannel: Created channel 4d4f444d
23:46:48.85   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:46:48.86   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:46:48.86   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:46:48.86   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:46:48.86   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:46:49.16   SPEECHMANAGER -- Loaded in 0.267957 seconds
23:46:50.98   GameObjLoader - upgrading load_count from 0 to 1813
23:46:51.90   GameObjLoader 0c8a03d8 - resetting counters
23:46:51.90   GameObjLoader 0c8a03d8 - LOAD_DONE
23:46:54.51   PreloadResources took 2022ms.
23:46:54.54   GAME -- Loading completed (51 seconds)
23:46:54.54   SIM -- Setting SyncErrorChecking level to None
23:47:03.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:47:10.32   SPDx9 -- 1758MB available Texture Memory
23:47:12.26   Activating screen: GameScreen
23:47:12.26   Activating screen: Decorators
23:47:12.26   Activating screen: Taskbar
23:47:12.26   Activating screen: SubtitleScreen
23:47:12.26   Activating screen: TextOverlayScreen
23:47:12.30   PerformanceRecorder::StartRecording for game size 8
23:47:12.30   GAME -- Starting mission...
23:47:14.16   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Easy set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:47:14.16   MOD -- Player CPU - Normal set to AI Type: AI Player (frame 1) (CmdAI)
23:47:18.80   Warning: non auto-match upgrade not found in AE, tuning
23:47:21.13   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:47:25.79   Activating screen: Command_Tree
23:47:26.88   Activating screen: Command_Branch
23:47:31.27   Activating screen: Command_Branch
23:47:37.32   Activating screen: Command_Branch
23:48:04.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:48:41.35   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
23:48:41.35   Warning: binding repeat_0(Production Item: upgrade\allies\research\abilities_ki) -- ui index '0' out of bounds; range is [1, 12]
23:49:05.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:49:21.85   Warning: binding repeat_5(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:50:02.92   Activating screen: Command_Branch
23:50:06.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:51:01.10   Activating screen: pause_menu
23:51:01.11   GAME -- SimulationController::Pause 0
23:51:04.22   SPDx9 -- 1757MB available Texture Memory
23:51:06.13   GAME -- SimulationController::Pause 1
23:51:07.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:51:30.41   Activating screen: Command_Branch
23:51:55.94   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:52:08.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:53:09.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:54:10.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:54:51.28   Activating screen: Command_Branch
23:55:11.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 3.3/0.1, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:55:21.12   Activating screen: pause_menu
23:55:21.12   GAME -- SimulationController::Pause 0
23:55:28.32   SPDx9 -- 1757MB available Texture Memory
23:55:31.12   GAME -- SimulationController::Pause 1
23:56:12.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:57:13.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:57:46.49   Activating screen: Command_Branch
23:58:14.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:58:28.90   Activating screen: Command_Branch
23:58:40.51   FXShader::SetVariable( "tex0", T ) uses unknown variable.
23:59:15.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:59:49.46   Unabled to do upgrade, CANPRODUCE_NoResources
23:59:51.83   Warning: binding repeat_4(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:59:56.25   Activating screen: pause_menu
23:59:56.25   GAME -- SimulationController::Pause 0
23:59:59.43   SPDx9 -- 1757MB available Texture Memory
00:00:06.96   GAME -- SimulationController::Pause 1
00:00:16.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
00:00:17.57   Activating screen: Command_Branch
00:01:17.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
00:02:18.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 3.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
00:02:23.59   Activating screen: Command_Branch
00:02:38.30   Activating screen: pause_menu
00:02:38.31   GAME -- SimulationController::Pause 0
00:02:39.36   Activating screen: prompt_generic
00:02:40.09   MOD -- Player NGOCQUANG-PC (network abort) (frame 7169) (KillPlayer)
00:02:40.10   GameApp::ReportStats
00:02:40.10   ReportStats - untracked game, no need to report match 4294967295:4294967295
00:02:40.10   ReportSimStats - nothing to report, no connection to the server
00:02:40.10   ReportStats - ReportSimStats failed
00:02:40.10   GameApp::Quit( exitValue = 0 )
00:02:40.12   GAME -- SimulationController::Pause 1
00:02:40.12   Activating screen: AppRestartingForm
00:02:40.12   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
00:02:40.12   Widget attempting to remove a non-existance listener. Widget:bkg_COH
00:02:40.12   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
00:02:40.12   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
00:02:40.12   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
00:02:40.12   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
00:02:40.41   GameApp::ShutFrontEnd
00:02:40.41   GameObj::ShutdownGameObj
00:02:40.41   GAME -- Ending mission (Game over)
00:02:40.45   GameObjLoader 0c8a03d8 - Unload
00:02:40.45   GameObjLoader 0c8a03d8 - resetting counters
00:02:40.55   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
00:02:40.55   MOD -- Game Over at frame 7169
00:02:40.73   GameObjLoader 0c8a0278 - Unload
00:02:40.73   GameObjLoader 0c8a0278 - resetting counters
00:02:40.84   SOUND -- Shutting down ...
00:02:40.97   SOUND -- Shutdown completed!
00:02:40.98   MessageInternal::DestroyChannel: Destroyed channel 474d4343
00:02:41.01   ~FEAppListener - Flushing queued online notifications
00:02:41.74   DLLDriverLinker -- 2 DLL drivers found.
00:02:41.74   ActionDatabase : [2347] global actions, [142] dummy actions.
00:02:41.75   NetworkManager::Destroy - destroying network manager
00:02:41.75   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
00:02:41.75   MessageInternal::DestroyChannel: Destroyed channel 50525459
00:02:41.75   PartyInternal: Fade to black
00:02:41.75   AutomatchInternal: Fade to black
00:02:41.75   PeerRemoveAll - flushing local session peer data
00:02:41.75   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
00:02:41.75   MessageInternal::DestroyChannel: Destroyed channel 47535450
00:02:41.75   Session - Requested Disconnect for connectionID 1
00:02:41.75   SessionManager::UnregisterSession - Unregistering session 07e12e40
00:02:41.75   SessionManager::~SessionManager - uninitializing
00:02:41.75   Net::ThreadFunction - Returning from the network thread function...
00:02:41.75   Transport::~Transport - shutting down transport
00:02:41.75   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
00:02:41.75   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
00:02:41.75   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
00:02:41.78   Wrote 269 bytes to network datastore login_cache.bin
00:02:41.78   Wrote 52 bytes to network datastore global_cache.bin
00:02:41.78   Wrote 28 bytes to network datastore ping_cache.bin
00:02:41.78   Datastore -- uninitialize complete
00:02:41.78   QuazalInitializer - static uninit of Quazal library
00:02:41.78   QuazalInitializer - unhooking memory 0 currently allocated, 205 allocations, total of 20072 bytes
