-- Log file for all dbTracef messages --

21:54:04.31   NetworkManager::Create - creating network manager
21:54:04.31   Read 269 bytes from network datastore login_cache.bin
21:54:04.31   Read 52 bytes from network datastore global_cache.bin
21:54:04.31   Read 28 bytes from network datastore ping_cache.bin
21:54:04.31   QuazalInitializer - static initializing Quazal library
21:54:04.31   PingCache - populating cache with 0 pings
21:54:04.31   Sent message game CompanyOfHeroes started 1584 602 allowtraffic
21:54:04.31   RemoteDLManager - Connection Restored.
21:54:04.31   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
21:54:04.54   WinTransport - CreateSocket exclusive broadcast socket was available.
21:54:04.54   WinTransport - CreateSocket listening for broadcasts on default port
21:54:04.54   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
21:54:04.54   WinTransport - Host IP Address #0: 5.3.208.164
21:54:04.54   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
21:54:04.54   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
21:54:04.54   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
21:54:04.54   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
21:54:04.54   SessionManager - Peer Header Size = 16 bytes
21:54:04.54   SessionManager - Game Data overhead = 7 bytes
21:54:04.54   SessionManager - Proxy overhead = 7 bytes
21:54:04.54   MessageInternal::CreateChannel: Created channel 47535450
21:54:04.54   Session::Initialize - info, initializing session object, using threads.
21:54:04.54   SessionManager::RegisterSession - Registering new session 01d75fa0
21:54:04.54   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
21:54:04.54   AutomatchInternal: Instantiating
21:54:04.54   PartyInternal: Instantiating
21:54:04.54   MessageInternal::CreateChannel: Created channel 50525459
21:54:04.54   MessageInternal::CreateChannel: Created channel 51434b4d
21:54:04.54   Net::ThreadFunction - Entering network thread function...
21:54:04.54   MessageInternal::CreateChannel: Created channel 534d5347
21:54:04.54   MessageInternal::CreateChannel: Created channel 474d4343
21:54:04.54   MessageInternal::CreateChannel: Created channel 474f424a
21:54:04.54   MessageInternal::CreateChannel: Created channel 4d4f444d
21:54:04.54   MessageInternal::CreateChannel: Created channel 53594e43
21:54:04.54   MessageInternal::DestroyChannel: Destroyed channel 534d5347
21:54:04.54   MessageInternal::DestroyChannel: Destroyed channel 474d4343
21:54:04.54   MessageInternal::DestroyChannel: Destroyed channel 474f424a
21:54:04.54   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
21:54:04.54   MessageInternal::DestroyChannel: Destroyed channel 53594e43
21:54:04.54   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
21:54:04.55   Transport - Largest received is now 19
21:54:04.55   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
21:54:04.56   Transport - Largest sent is now 19
21:54:05.95   DLLDriverLinker -- Adding driver 'spDx10.dll'.
21:54:05.99   DLLDriverLinker -- Adding driver 'spDx9.dll'.
21:54:05.99   DLLDriverLinker -- 2 DLL drivers found.
21:54:06.21   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
21:54:08.20   DLLDriverLinker -- 2 DLL drivers found.
21:54:08.36   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
21:54:08.36   GAME -- Resolution set to 1024x768 (fullscreen).
21:54:08.39   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
21:54:08.39   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
21:54:08.39   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
21:54:08.39   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
21:54:08.93   SPDx9 -- 1774MB available Texture Memory
21:54:08.95   ShaderDatabase: using shader profile [ps15]
21:54:09.66   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
21:54:09.97   GameObjLoader 8b3c2f60 - resetting counters
21:54:09.97   GameObjLoader 8b3c2f60 - Created loader
21:54:09.97   GameObjLoader 8b3c30c0 - resetting counters
21:54:09.97   GameObjLoader 8b3c30c0 - Created loader
21:54:11.78   GAME -- Beginning FE
21:54:11.78   Sent message game CompanyOfHeroes allowtraffic
21:54:11.78   UIFrontEnd - Loading Front End
21:54:11.78   THREAD: Hyper-Threading Technology Processors are not detected.
21:54:11.86   SOUND -- Initializing ...
21:54:12.73   SOUND -- Initialization completed!
21:54:12.73   UIFrontEnd - Initializing Forms
21:54:14.34   CampaignFilter::BindFilterSpecificWidgets()
21:54:14.40   installed_products = ( )
21:54:14.46   Activating screen: AppResolutionPrompt
21:54:14.46   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:54:14.46   Activating screen: prompt_generic
21:54:14.46   Activating screen: prompt_generic
21:54:14.46   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
21:54:14.46   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
21:54:14.46   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
21:54:14.46   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
21:54:25.05   Activating screen: AppLoadingForm
21:54:25.05   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:54:26.11   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
21:54:26.11   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
21:54:26.11   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
21:54:26.13   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
21:54:26.15   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
21:54:26.15   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
21:54:26.46   GAME -- Using player profile NGOCQUANG-PC
21:54:26.92   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
21:54:27.23   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
21:54:27.62   SPDx9 -- 1753MB available Texture Memory.  Unable to create 516x223 texture.
21:54:27.63   SPDx9 -- 1753MB available Texture Memory.  Unable to create 516x223 texture.
21:54:28.20   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
21:54:28.20   RendezvousManager: CreateSession - starting profile=Guest login
21:54:28.25   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
21:54:28.25   RendezvousManager - unable to connect to the server as guest
21:54:28.27   OnConnect: connect failure
21:54:28.27   RendezvousManager::Shutdown - deleting instance
21:54:28.27   RendezvousManager - terminating all server calls in progress
21:54:28.27   CallManager - terminating all server calls in progress (1 in progress)
21:54:28.27   RendezvousManager - destroying chat handler
21:54:28.27   ~RendezvousManager - m_state = 7, no need for server disconnect
21:54:28.29   OnConnect: this wasnt a reconnect, no need for autologin
21:54:28.30   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:54:28.30   CRC & Version Info : 0000025a:db0aab6c:ec3c9e0d blitzkrieg:602:ww2mod.dll 1
21:54:28.30   Activating screen: FEMovie
21:54:28.30   Activating screen: OnlineWidget
21:54:28.30   Activating screen: RelicOnlineLogin
21:54:28.33   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
21:54:28.33   You have a valid version of the game.
21:54:28.34   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
21:54:28.34   installed_products = ( DLC1 DLC2 DLC3 )
21:54:28.34   OnLogin: no previous login, auto selecting profile not required
21:54:28.34   Activating screen: MessageBoxPopup
21:54:28.34   Activating screen: MessageBoxPopup
21:54:28.34   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
21:54:43.33   Beginning media verification...
21:54:43.33   Validator type : validators\udro\udro.dll
21:54:43.33   Activating screen: MessageBoxPopup
21:54:45.68   Activating screen: FE_mm_01
21:54:45.68   GAME -- Setting campaign state to 'dlc1'
21:54:45.68   GAME -- Closing state 'dlc1'
21:54:45.68   GAME -- Setting campaign state to 'dlc2'
21:54:45.68   GAME -- Closing state 'dlc2'
21:54:45.68   GAME -- Setting campaign state to 'dlc3'
21:54:45.68   GAME -- Closing state 'dlc3'
21:54:48.60   FEHelpers::DoScenarioSelection - Could not find current profile, using first scenario
21:54:48.60   Activating screen: MessageBoxPopup
21:54:48.60   Created Matchinfo
21:54:48.60   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
21:54:48.60   starting LAN hosting
21:54:48.63   OnJoinAdvertisementSuccess - joined online match, server leave notification required
21:54:48.63   starting local hosting
21:54:48.63   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
21:54:48.63   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
21:54:48.63   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
21:54:48.63   Session::Host sid = 4E7BF8D577EFFF9B, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
21:54:48.63   ValidateCustomData: called with 210 bytes of custom data
21:54:48.63   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
21:54:48.63   AdvertisementInternal::Process - EVENT_NEWPEER
21:54:48.63   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
21:54:48.64   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
21:54:48.64   hosting - Session is connected
21:54:48.64   Net::Session::SetVisible - session is set to VISIBLE.
21:54:48.66   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
21:54:48.66   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
21:54:48.66   hosting completed successfully
21:54:48.66   HostAsync - completed with HostResult = 0
21:54:48.66   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
21:54:48.66   Activating screen: OnlineGameSetup
21:54:48.66   MessageInternal::CreateChannel: Created channel 534d5347
21:54:48.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:54:48.66   MatchInternal::SetMatchType - new type 14 - updating server
21:54:48.67   Transport - Largest received is now 432
21:54:48.67   SetVisible called while !IsConnected
21:54:48.68   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:54:48.68   Activating screen: RelicOnlineChat
21:54:48.68   Activating screen: RelicOnlineNewsScreen
21:54:48.68   Activating screen: RelicOnlineStatsScreen
21:54:48.68   Activating screen: Achievements
21:54:48.69   GAME -- Setting campaign state to 'dlc1'
21:54:48.69   GAME -- Closing state 'dlc1'
21:54:48.69   GAME -- Setting campaign state to 'dlc2'
21:54:48.69   GAME -- Closing state 'dlc2'
21:54:48.69   GAME -- Setting campaign state to 'dlc3'
21:54:48.69   GAME -- Closing state 'dlc3'
21:54:48.69   Transport - Largest received is now 574
21:54:48.70   Activating screen: GameHistory
21:54:48.70   GAME -- Setting campaign state to 'dlc1'
21:54:48.70   GAME -- Closing state 'dlc1'
21:54:48.70   GAME -- Setting campaign state to 'dlc2'
21:54:48.70   GAME -- Closing state 'dlc2'
21:54:48.70   GAME -- Setting campaign state to 'dlc3'
21:54:48.70   GAME -- Closing state 'dlc3'
21:54:48.70   Activating screen: OnlineGameSetup
21:54:48.70   Activating screen: RelicOnlineTabs
21:54:48.70   AutomatchInternal::OnHostComplete - Completed Host with success=1
21:54:48.70   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
21:54:48.70   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
21:54:48.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:54:48.71   Net::Session::SetVisible - session is set to INVISIBLE.
21:54:48.71   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:54:48.71   Transport - Largest received is now 1131
21:54:48.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:48.80   GAME -- Setting campaign state to 'dlc1'
21:54:48.80   GAME -- Closing state 'dlc1'
21:54:48.80   GAME -- Setting campaign state to 'dlc2'
21:54:48.80   GAME -- Closing state 'dlc2'
21:54:48.80   GAME -- Setting campaign state to 'dlc3'
21:54:48.80   GAME -- Closing state 'dlc3'
21:54:48.85   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:53.13   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:54:53.13   Net::Session::SetVisible - session is set to VISIBLE.
21:54:53.13   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:54:53.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:53.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:55.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:54:55.20   Net::Session::SetVisible - session is set to VISIBLE.
21:54:55.20   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:54:55.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:55.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:57.89   Transport - Largest received is now 1133
21:54:57.90   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:54:57.90   Net::Session::SetVisible - session is set to VISIBLE.
21:54:57.90   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:54:57.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:54:57.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:00.32   Activating screen: RaceSelectionPopup
21:55:01.07   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:01.07   Net::Session::SetVisible - session is set to VISIBLE.
21:55:01.07   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:01.08   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:01.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:01.68   Activating screen: DynamicPopupMenu
21:55:03.21   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:03.21   Net::Session::SetVisible - session is set to VISIBLE.
21:55:03.21   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:03.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:03.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:03.80   Activating screen: DynamicPopupMenu
21:55:04.54   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:04.54   Net::Session::SetVisible - session is set to VISIBLE.
21:55:04.54   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:04.54   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:04.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:05.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/1.8, #p/sec[s/r] = 0.3/0.7, max unsent 0, version err 0, merge 0
21:55:05.06   Activating screen: DynamicPopupMenu
21:55:05.61   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:05.61   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:05.62   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:05.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:05.67   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:06.19   Activating screen: RaceSelectionPopup
21:55:06.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:06.85   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:06.85   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:06.86   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:06.91   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:07.46   Activating screen: DynamicPopupMenu
21:55:08.09   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:08.09   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:08.09   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:08.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:08.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:08.66   Activating screen: DynamicPopupMenu
21:55:09.53   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:09.53   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:09.53   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:09.54   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:09.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:10.01   Activating screen: DynamicPopupMenu
21:55:10.69   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:10.69   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:10.70   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:10.71   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:10.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:11.54   Activating screen: DynamicPopupMenu
21:55:12.22   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:12.22   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:12.22   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:12.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:12.27   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:13.07   Activating screen: RaceSelectionPopup
21:55:13.62   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:13.62   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:13.62   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:13.63   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:13.68   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:14.23   Activating screen: RaceSelectionPopup
21:55:14.92   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:14.92   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:14.92   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:14.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:14.98   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:16.32   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:16.32   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:16.32   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:16.32   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:16.36   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:17.79   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:17.79   Net::Session::SetVisible - session is set to INVISIBLE.
21:55:17.79   GetMaxFrameTimeFromProfile: players=8 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
21:55:17.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:17.84   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:19.73   GameSetupForm - No win/loss reporting and only a single player, disconnecting
21:55:19.73   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
21:55:19.73   SetVisible called while !IsConnected
21:55:19.73   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:19.74   GameSetupForm - Starting game
21:55:19.74   GameInfo::ResetInfo - SyncLevel set to 0 on reset
21:55:19.74   PopulateGameInfo - random seed:[1308495319], guid:[{8edf0e76-13ba-4f27-963c-45e71bdf0f62}], sync level:[2]
21:55:19.74   Error loading [DATA:levelingCurve.lua]
21:55:19.75   Error loading [DATA:levelingCurve.lua]
21:55:19.75   Error loading [DATA:levelingCurve.lua]
21:55:19.75   Error loading [DATA:levelingCurve.lua]
21:55:19.75   Error loading [DATA:levelingCurve.lua]
21:55:19.76   Error loading [DATA:levelingCurve.lua]
21:55:19.76   Error loading [DATA:levelingCurve.lua]
21:55:19.76   Error loading [DATA:levelingCurve.lua]
21:55:19.76   MOD - Setting player (0) race to: allies_commonwealth
21:55:19.76   MOD - Setting player (0) race to: 0
21:55:19.76   MOD - Setting player (1) race to: allies
21:55:19.76   MOD - Setting player (1) race to: 1
21:55:19.76   MOD - Setting player (2) race to: allies
21:55:19.76   MOD - Setting player (2) race to: 1
21:55:19.76   MOD - Setting player (3) race to: allies_commonwealth
21:55:19.76   MOD - Setting player (3) race to: 0
21:55:19.76   MOD - Setting player (4) race to: axis_panzer_elite
21:55:19.76   MOD - Setting player (4) race to: 3
21:55:19.76   MOD - Setting player (5) race to: axis
21:55:19.76   MOD - Setting player (5) race to: 2
21:55:19.76   MOD - Setting player (6) race to: axis_panzer_elite
21:55:19.76   MOD - Setting player (6) race to: 3
21:55:19.76   MOD - Setting player (7) race to: axis
21:55:19.76   MOD - Setting player (7) race to: 2
21:55:19.76   Activating screen: MessageBoxPopup
21:55:19.76   Session is marking the local peer PeerID 1 for death
21:55:19.76   Session::GetEvent DestroyPeer success Peer 1 removed
21:55:19.76   Session::DestroyPeer - deallocating peer 1
21:55:19.76   Session - Requested Disconnect for connectionID 2
21:55:19.76   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
21:55:19.76   Session - Requested Disconnect for connectionID 3
21:55:19.76   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
21:55:19.76   AdvertisementInternal::Process - EVENT_DESTROYPEER
21:55:19.76   Destroyed Matchinfo
21:55:19.77   APP -- Game Start
21:55:19.77   Sent message game CompanyOfHeroes allowtraffic
21:55:19.77   GAME -- Setting campaign state to 'dlc1'
21:55:19.77   GAME -- Closing state 'dlc1'
21:55:19.77   GAME -- Setting campaign state to 'dlc2'
21:55:19.77   GAME -- Closing state 'dlc2'
21:55:19.78   GAME -- Setting campaign state to 'dlc3'
21:55:19.78   GAME -- Closing state 'dlc3'
21:55:19.78   MessageInternal::DestroyChannel: Destroyed channel 534d5347
21:55:19.79   GAME -- Ending FE
21:55:19.79   UIFrontEnd - Unloading Front End
21:55:19.81   SOUND -- Shutting down ...
21:55:19.86   SOUND -- Shutdown completed!
21:55:19.90
21:55:19.90   GAME -- *** Beginning mission 8p_operation goodwood (8) (1 Humans, 7 Computers) ***
21:55:19.90
21:55:20.19   GAME -- Recording game
21:55:20.25   Activating screen: GameLoadScreen
21:55:20.25   ReportGameStartStats - no connection to server unable to report
21:55:20.26   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
21:55:20.26   PeerRemoveAll - flushing local session peer data
21:55:20.26   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
21:55:20.26   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
21:55:20.56   THREAD: Hyper-Threading Technology Processors are not detected.
21:55:20.64   SOUND -- Initializing ...
21:55:21.51   SOUND -- Initialization completed!
21:55:21.53   PHYSICS: detected processor(s) capable of handling 4 threads.
21:55:21.53   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\8p_operation goodwood (8)'
21:55:21.53   MOD -- Using Mod 'Blitzkrieg'
21:55:21.56   Unable to load/parse precache file [DATA:scenarios\mp\8p_operation goodwood (8)_precache.lua]
21:55:21.70   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
21:55:21.70   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
21:55:22.91   GameObjLoader - upgrading load_count from 0 to 1210
21:55:26.64   GameObjLoader - upgrading load_count from 1210 to 2086
21:55:54.00   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
21:56:06.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:56:29.39   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_m01_cue_02_lower_load.smf'.  Expensive operation
21:56:30.32   GameObjLoader - upgrading load_count from 43 to 4943
21:56:35.77   GameObjLoader 8b3c2f60 - resetting counters
21:56:35.77   GameObjLoader 8b3c2f60 - LOAD_DONE
21:56:35.77   GAME - SessionSetup
21:56:35.95   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
21:56:35.95   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
21:56:35.95   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
21:56:38.76   GAME - CreateGEWorld in 2987 ms
21:56:38.79   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
21:56:39.20   GAME - SessionSetup finished in 3429 ms
21:56:39.20   GAME - WaterReflectionManagerSetup
21:56:39.20   GAME - WaterReflectionManagerSetup finished in 0 ms
21:56:39.20   MessageInternal::CreateChannel: Created channel 474d4343
21:56:39.22   Regenerating ImpassMap data...
21:56:39.22       Impass Data was already valid, but regenerating...
21:56:39.57   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
21:56:39.57   Regenerating CanBuildMap data...
21:56:39.57   Generating CanShoot Map.
21:56:39.57   Pathfinder::Regenerate()...
21:56:39.69   Generating PathSectorMap...
21:56:40.34   Pathfinder::Regenerate() Done.
21:56:40.85   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/ZANNIHILATE.SCAR] succeeded.
21:56:43.30   MessageInternal::CreateChannel: Created channel 4d4f444d
21:56:44.11   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:56:44.11   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:56:44.11   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:56:44.11   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:56:44.11   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
21:56:44.46   SPEECHMANAGER -- Loaded in 0.290064 seconds
21:56:47.45   GameObjLoader - upgrading load_count from 0 to 2131
21:56:56.61   GameObjLoader 8b3c30c0 - resetting counters
21:56:56.61   GameObjLoader 8b3c30c0 - LOAD_DONE
21:56:59.28   PreloadResources took 2047ms.
21:56:59.39   GAME -- Loading completed (99 seconds)
21:56:59.39   SIM -- Setting SyncErrorChecking level to None
21:57:07.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:57:08.37   Activating screen: GameScreen
21:57:08.37   Activating screen: Decorators
21:57:08.37   Activating screen: Taskbar
21:57:08.37   Activating screen: SubtitleScreen
21:57:08.37   Activating screen: TextOverlayScreen
21:57:08.65   PerformanceRecorder::StartRecording for game size 8
21:57:08.65   GAME -- Starting mission...
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:09.73   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
21:57:11.31   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
21:57:14.44   Warning: non auto-match upgrade not found in AE, tuning
21:57:30.97   Activating screen: pause_menu
21:57:30.97   GAME -- SimulationController::Pause 0
21:57:33.61   SPDx9 -- 1763MB available Texture Memory
21:57:39.09   GAME -- SimulationController::Pause 1
21:57:50.28   Activating screen: pause_menu
21:57:50.28   GAME -- SimulationController::Pause 0
21:58:00.55   SPDx9 -- 1763MB available Texture Memory
21:58:03.65   GAME -- SimulationController::Pause 1
21:58:08.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
21:58:14.32   Activating screen: Command_Tree
21:58:16.54   Activating screen: Command_Branch
21:58:52.74   Warning: binding repeat_4(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
21:59:09.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:00:10.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
22:01:07.83   Warning: binding repeat_2(Ability: abilities\commonwealth_truck_setup_instant) -- ui index '-1' out of bounds; range is [1, 12]
22:01:11.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:01:17.17   Warning: binding repeat_5(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
22:01:22.41   Activating screen: pause_menu
22:01:22.42   GAME -- SimulationController::Pause 0
22:01:25.03   SPDx9 -- 1763MB available Texture Memory
22:01:28.43   GAME -- SimulationController::Pause 1
22:02:09.88   Activating screen: Command_Branch
22:02:12.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
22:02:57.53   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
22:03:13.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:03:37.19   Warning: binding repeat_3(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
22:03:47.99   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
22:03:58.51   Activating screen: Command_Branch
22:04:03.23   Activating screen: NewObjective
22:04:14.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:05:15.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:05:27.79   Activating screen: pause_menu
22:05:27.80   GAME -- SimulationController::Pause 0
22:05:29.83   SPDx9 -- 1763MB available Texture Memory
22:05:36.72   GAME -- SimulationController::Pause 1
22:06:16.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:06:23.18   Was already stealing a skeleton when told to steal another [mortar_target].
22:07:16.14   FXShader::SetVariable( "tex0", T ) uses unknown variable.
22:07:17.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
22:07:52.84   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:07:52.84   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:07:52.84   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.
22:08:09.38   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:08:09.38   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:08:09.38   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.
22:08:18.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:08:24.48   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:08:24.48   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:08:24.48   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.
22:08:40.34   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
22:08:40.34   Muting spew of bind updater.  Fix art and re-test.
22:09:09.84   Activating screen: Command_Branch
22:09:11.90   Activating screen: NewObjective
22:09:19.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:09:47.83   Activating screen: pause_menu
22:09:47.83   GAME -- SimulationController::Pause 0
22:09:49.72   SPDx9 -- 1763MB available Texture Memory
22:09:54.25   GAME -- SimulationController::Pause 1
22:10:17.48   Activating screen: Command_Branch
22:10:20.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:11:21.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:12:22.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:12:51.49   Activating screen: Command_Branch
22:12:54.69   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
22:13:23.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:13:52.50   Activating screen: Command_Branch
22:13:56.88   SimulationController::GenerateSyncCmd - couldn't send all commands, 3 binned.
22:13:57.78   Activating screen: NewObjective
22:14:12.87   Activating screen: Command_Branch
22:14:23.10   Activating screen: pause_menu
22:14:23.10   GAME -- SimulationController::Pause 0
22:14:24.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:14:25.14   SPDx9 -- 1763MB available Texture Memory
22:14:27.12   GAME -- SimulationController::Pause 1
22:15:07.41   Activating screen: Command_Branch
22:15:14.68   Activating screen: Command_Branch
22:15:25.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.8/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
22:15:26.97   Activating screen: pause_menu
22:15:27.09   GAME -- SimulationController::Pause 0
22:15:28.24   Activating screen: prompt_generic
22:15:29.04   MOD -- Player NGOCQUANG-PC (network abort) (frame 8289) (KillPlayer)
22:15:29.05   GameApp::ReportStats
22:15:29.05   ReportStats - untracked game, no need to report match 4294967295:4294967295
22:15:29.05   ReportSimStats - nothing to report, no connection to the server
22:15:29.05   ReportStats - ReportSimStats failed
22:15:29.05   GameApp::Quit( exitValue = 0 )
22:15:29.07   GAME -- SimulationController::Pause 1
22:15:29.07   Activating screen: AppRestartingForm
22:15:29.07   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:15:29.07   Widget attempting to remove a non-existance listener. Widget:bkg_COH
22:15:29.07   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
22:15:29.07   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
22:15:29.07   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
22:15:29.07   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
22:15:29.19   GameApp::ShutFrontEnd
22:15:29.19   GameObj::ShutdownGameObj
22:15:29.19   GAME -- Ending mission (Game over)
22:15:29.21   GameObjLoader 8b3c30c0 - Unload
22:15:29.21   GameObjLoader 8b3c30c0 - resetting counters
22:15:29.47   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
22:15:29.47   MOD -- Game Over at frame 8289
22:15:30.28   GameObjLoader 8b3c2f60 - Unload
22:15:30.28   GameObjLoader 8b3c2f60 - resetting counters
22:15:30.53   SOUND -- Shutting down ...
22:15:30.90   SOUND -- Shutdown completed!
22:15:30.92   MessageInternal::DestroyChannel: Destroyed channel 474d4343
22:15:30.95   ~FEAppListener - Flushing queued online notifications
22:15:33.96   DLLDriverLinker -- 2 DLL drivers found.
22:15:34.10   ActionDatabase : [2347] global actions, [108] dummy actions.
22:15:34.10   NetworkManager::Destroy - destroying network manager
22:15:34.10   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
22:15:34.10   MessageInternal::DestroyChannel: Destroyed channel 50525459
22:15:34.10   PartyInternal: Fade to black
22:15:34.10   AutomatchInternal: Fade to black
22:15:34.10   PeerRemoveAll - flushing local session peer data
22:15:34.10   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
22:15:34.10   MessageInternal::DestroyChannel: Destroyed channel 47535450
22:15:34.10   Session - Requested Disconnect for connectionID 1
22:15:34.10   SessionManager::UnregisterSession - Unregistering session 01d75fa0
22:15:34.10   SessionManager::~SessionManager - uninitializing
22:15:34.10   Net::ThreadFunction - Returning from the network thread function...
22:15:34.15   Transport::~Transport - shutting down transport
22:15:34.15   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
22:15:34.15   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
22:15:34.15   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
22:15:34.15   Wrote 269 bytes to network datastore login_cache.bin
22:15:34.15   Wrote 52 bytes to network datastore global_cache.bin
22:15:34.22   Wrote 28 bytes to network datastore ping_cache.bin
22:15:34.22   Datastore -- uninitialize complete
22:15:34.22   QuazalInitializer - static uninit of Quazal library
22:15:34.24   QuazalInitializer - unhooking memory 0 currently allocated, 610 allocations, total of 59844 bytes
