-- Log file for all dbTracef messages --

22:58:27.55   NetworkManager::Create - creating network manager
22:58:27.55   Read 269 bytes from network datastore login_cache.bin
22:58:27.55   Read 52 bytes from network datastore global_cache.bin
22:58:27.55   Read 28 bytes from network datastore ping_cache.bin
22:58:27.55   QuazalInitializer - static initializing Quazal library
22:58:27.55   PingCache - populating cache with 0 pings
22:58:27.55   Sent message game CompanyOfHeroes started 3300 602 allowtraffic
22:58:27.55   RemoteDLManager - Connection Restored.
22:58:27.55   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
22:58:27.61   WinTransport - CreateSocket exclusive broadcast socket was available.
22:58:27.61   WinTransport - CreateSocket listening for broadcasts on default port
22:58:27.61   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
22:58:27.61   WinTransport - Host IP Address #0: 5.3.208.164
22:58:27.61   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
22:58:27.61   WinTransport - Interface #1: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
22:58:27.61   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:58:27.61   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
22:58:27.61   SessionManager - Peer Header Size = 16 bytes
22:58:27.61   SessionManager - Game Data overhead = 7 bytes
22:58:27.61   SessionManager - Proxy overhead = 7 bytes
22:58:27.61   MessageInternal::CreateChannel: Created channel 47535450
22:58:27.61   Session::Initialize - info, initializing session object, using threads.
22:58:27.61   SessionManager::RegisterSession - Registering new session 0fa786b8
22:58:27.61   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:58:27.61   AutomatchInternal: Instantiating
22:58:27.61   PartyInternal: Instantiating
22:58:27.61   MessageInternal::CreateChannel: Created channel 50525459
22:58:27.61   MessageInternal::CreateChannel: Created channel 51434b4d
22:58:27.61   Net::ThreadFunction - Entering network thread function...
22:58:27.61   MessageInternal::CreateChannel: Created channel 534d5347
22:58:27.61   MessageInternal::CreateChannel: Created channel 474d4343
22:58:27.61   MessageInternal::CreateChannel: Created channel 474f424a
22:58:27.61   MessageInternal::CreateChannel: Created channel 4d4f444d
22:58:27.61   MessageInternal::CreateChannel: Created channel 53594e43
22:58:27.61   MessageInternal::DestroyChannel: Destroyed channel 534d5347
22:58:27.61   MessageInternal::DestroyChannel: Destroyed channel 474d4343
22:58:27.61   MessageInternal::DestroyChannel: Destroyed channel 474f424a
22:58:27.61   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
22:58:27.61   MessageInternal::DestroyChannel: Destroyed channel 53594e43
22:58:27.61   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
22:58:27.63   Transport - Largest received is now 19
22:58:27.63   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
22:58:27.64   Transport - Largest sent is now 19
22:58:31.03   DLLDriverLinker -- Adding driver 'spDx10.dll'.
22:58:31.04   DLLDriverLinker -- Adding driver 'spDx9.dll'.
22:58:31.04   DLLDriverLinker -- 2 DLL drivers found.
22:58:31.09   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
22:58:32.73   DLLDriverLinker -- 2 DLL drivers found.
22:58:32.88   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
22:58:32.88   GAME -- Resolution set to 1024x768 (fullscreen).
22:58:32.90   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
22:58:32.90   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
22:58:32.90   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
22:58:32.90   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
22:58:33.44   SPDx9 -- 1774MB available Texture Memory
22:58:33.44   ShaderDatabase: using shader profile [ps30]
22:58:34.02   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
22:58:34.27   GameObjLoader 1034ffe0 - resetting counters
22:58:34.27   GameObjLoader 1034ffe0 - Created loader
22:58:34.27   GameObjLoader 0d8c65b8 - resetting counters
22:58:34.27   GameObjLoader 0d8c65b8 - Created loader
22:58:49.61   GAME -- Beginning FE
22:58:49.61   Sent message game CompanyOfHeroes allowtraffic
22:58:49.61   UIFrontEnd - Loading Front End
22:58:49.61   THREAD: Hyper-Threading Technology Processors are not detected.
22:58:49.71   SOUND -- Initializing ...
22:58:50.47   SOUND -- Initialization completed!
22:58:50.47   UIFrontEnd - Initializing Forms
22:58:52.48   CampaignFilter::BindFilterSpecificWidgets()
22:58:52.55   installed_products = ( )
22:58:52.58   Activating screen: AppResolutionPrompt
22:58:52.58   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:58:52.58   Activating screen: prompt_generic
22:58:52.58   Activating screen: prompt_generic
22:58:52.58   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
22:58:52.58   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
22:58:52.58   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
22:58:52.58   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
22:59:01.57   Activating screen: AppLoadingForm
22:59:01.57   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:59:02.37   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
22:59:02.38   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
22:59:02.38   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
22:59:02.38   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
22:59:02.38   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
22:59:02.39   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
22:59:02.76   GAME -- Using player profile NGOCQUANG-PC
22:59:06.13   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
22:59:07.09   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
22:59:08.16   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
22:59:08.16   RendezvousManager: CreateSession - starting profile=Guest login
22:59:08.21   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
22:59:08.21   RendezvousManager - unable to connect to the server as guest
22:59:08.23   OnConnect: connect failure
22:59:08.23   RendezvousManager::Shutdown - deleting instance
22:59:08.23   RendezvousManager - terminating all server calls in progress
22:59:08.23   CallManager - terminating all server calls in progress (1 in progress)
22:59:08.23   RendezvousManager - destroying chat handler
22:59:08.23   ~RendezvousManager - m_state = 7, no need for server disconnect
22:59:08.25   OnConnect: this wasnt a reconnect, no need for autologin
22:59:08.26   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:59:08.26   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
22:59:08.26   Activating screen: FEMovie
22:59:08.26   Activating screen: OnlineWidget
22:59:08.26   Activating screen: RelicOnlineLogin
22:59:08.32   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
22:59:08.32   You have a valid version of the game.
22:59:08.32   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
22:59:08.33   installed_products = ( DLC1 DLC2 DLC3 )
22:59:08.33   OnLogin: no previous login, auto selecting profile not required
22:59:08.33   Activating screen: MessageBoxPopup
22:59:08.33   Activating screen: MessageBoxPopup
22:59:08.33   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
22:59:09.40   Beginning media verification...
22:59:09.40   Validator type : validators\udro\udro.dll
22:59:09.40   Activating screen: MessageBoxPopup
22:59:09.42   Activating screen: FE_mm_01
22:59:09.42   GAME -- Setting campaign state to 'dlc1'
22:59:09.42   GAME -- Closing state 'dlc1'
22:59:09.42   GAME -- Setting campaign state to 'dlc2'
22:59:09.42   GAME -- Closing state 'dlc2'
22:59:09.42   GAME -- Setting campaign state to 'dlc3'
22:59:09.42   GAME -- Closing state 'dlc3'
22:59:10.53   Activating screen: MessageBoxPopup
22:59:10.53   Created Matchinfo
22:59:10.53   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
22:59:10.53   starting LAN hosting
22:59:10.56   OnJoinAdvertisementSuccess - joined online match, server leave notification required
22:59:10.56   starting local hosting
22:59:10.56   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
22:59:10.56   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:59:10.56   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
22:59:10.56   Session::Host sid = 705CF249BE429625, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
22:59:10.56   ValidateCustomData: called with 217 bytes of custom data
22:59:10.56   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
22:59:10.56   AdvertisementInternal::Process - EVENT_NEWPEER
22:59:10.56   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
22:59:10.58   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
22:59:10.58   hosting - Session is connected
22:59:10.58   Net::Session::SetVisible - session is set to VISIBLE.
22:59:10.59   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
22:59:10.59   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
22:59:10.60   Transport - Largest received is now 457
22:59:10.60   hosting completed successfully
22:59:10.60   HostAsync - completed with HostResult = 0
22:59:10.60   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
22:59:10.60   Activating screen: OnlineGameSetup
22:59:10.60   MessageInternal::CreateChannel: Created channel 534d5347
22:59:10.60   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:10.60   MatchInternal::SetMatchType - new type 14 - updating server
22:59:10.61   SetVisible called while !IsConnected
22:59:10.61   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
22:59:10.62   Transport - Largest received is now 513
22:59:10.62   Activating screen: RelicOnlineChat
22:59:10.62   Activating screen: RelicOnlineNewsScreen
22:59:10.62   Activating screen: RelicOnlineStatsScreen
22:59:10.62   Activating screen: Achievements
22:59:10.62   GAME -- Setting campaign state to 'dlc1'
22:59:10.62   GAME -- Closing state 'dlc1'
22:59:10.62   GAME -- Setting campaign state to 'dlc1'
22:59:10.63   GAME -- Closing state 'dlc1'
22:59:10.63   GAME -- Setting campaign state to 'dlc2'
22:59:10.63   GAME -- Closing state 'dlc2'
22:59:10.63   GAME -- Setting campaign state to 'dlc3'
22:59:10.63   GAME -- Closing state 'dlc3'
22:59:10.63   GAME -- Setting campaign state to 'dlc1'
22:59:10.63   GAME -- Closing state 'dlc1'
22:59:10.64   Transport - Largest received is now 1171
22:59:10.64   Activating screen: GameHistory
22:59:10.64   GAME -- Setting campaign state to 'dlc1'
22:59:10.64   GAME -- Closing state 'dlc1'
22:59:10.64   GAME -- Setting campaign state to 'dlc2'
22:59:10.64   GAME -- Closing state 'dlc2'
22:59:10.64   GAME -- Setting campaign state to 'dlc3'
22:59:10.64   GAME -- Closing state 'dlc3'
22:59:10.65   Activating screen: OnlineGameSetup
22:59:10.65   Activating screen: RelicOnlineTabs
22:59:10.65   AutomatchInternal::OnHostComplete - Completed Host with success=1
22:59:10.65   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
22:59:10.65   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
22:59:10.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:10.66   Net::Session::SetVisible - session is set to VISIBLE.
22:59:10.66   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
22:59:10.70   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:10.73   GAME -- Setting campaign state to 'dlc1'
22:59:10.73   GAME -- Closing state 'dlc1'
22:59:10.73   GAME -- Setting campaign state to 'dlc2'
22:59:10.73   GAME -- Closing state 'dlc2'
22:59:10.73   GAME -- Setting campaign state to 'dlc3'
22:59:10.73   GAME -- Closing state 'dlc3'
22:59:10.79   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:12.45   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:12.45   Net::Session::SetVisible - session is set to VISIBLE.
22:59:12.45   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:12.46   Transport - Largest received is now 1187
22:59:12.47   TGAIO -- TGA file 'Data:scenarios\mp\8p_berlin_1945_b041_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
22:59:12.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:12.55   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:14.08   Transport - Largest received is now 1189
22:59:14.09   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:14.09   Net::Session::SetVisible - session is set to VISIBLE.
22:59:14.09   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:14.11   TGAIO -- TGA file 'Data:scenarios\mp\eichsfeld confluence_map_base.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
22:59:14.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:14.20   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:15.10   Activating screen: RaceSelectionPopup
22:59:15.71   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:15.71   Net::Session::SetVisible - session is set to VISIBLE.
22:59:15.71   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:15.72   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:15.75   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:16.23   Activating screen: DynamicPopupMenu
22:59:16.85   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:16.85   Net::Session::SetVisible - session is set to VISIBLE.
22:59:16.85   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:16.86   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:16.90   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:17.40   Activating screen: DynamicPopupMenu
22:59:17.98   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:17.98   Net::Session::SetVisible - session is set to VISIBLE.
22:59:17.98   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:18.00   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:18.04   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:18.47   Activating screen: DynamicPopupMenu
22:59:19.02   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:19.02   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:19.02   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:19.03   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:19.08   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:19.44   Activating screen: DynamicPopupMenu
22:59:20.24   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:20.24   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:20.25   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:20.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:20.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:20.83   Activating screen: DynamicPopupMenu
22:59:21.45   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:21.45   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:21.45   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:21.47   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:21.51   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:21.87   Activating screen: DynamicPopupMenu
22:59:22.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:22.46   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:22.47   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:22.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:22.52   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:22.96   Activating screen: DynamicPopupMenu
22:59:23.56   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:23.56   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:23.56   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:23.57   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:23.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:24.73   Activating screen: RaceSelectionPopup
22:59:25.40   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:25.40   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:25.40   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:25.41   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:25.45   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:25.89   Activating screen: RaceSelectionPopup
22:59:26.46   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:26.46   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:26.47   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:26.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:26.52   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:26.96   Activating screen: RaceSelectionPopup
22:59:27.52   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:27.52   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:27.53   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:27.54   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:27.58   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:28.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.8, max unsent 0, version err 0, merge 0
22:59:28.08   Activating screen: Achievements
22:59:28.08   Activating screen: RelicOnlineTabs
22:59:31.60   SPDx9 -- 1766MB available Texture Memory
22:59:44.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:44.20   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:44.20   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:44.22   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:44.26   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:45.22   Activating screen: OnlineGameSetup
22:59:45.22   Activating screen: RelicOnlineTabs
22:59:48.04   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:48.04   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:48.04   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:48.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:48.10   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:49.29   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:49.29   Net::Session::SetVisible - session is set to INVISIBLE.
22:59:49.29   GetMaxFrameTimeFromProfile: players=8 expected FPS=18.583906, bars=5, max avg=0.054, sd=0.000, 1 samples =  0.05
22:59:49.30   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:49.34   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:50.06   GameSetupForm - No win/loss reporting and only a single player, disconnecting
22:59:50.06   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
22:59:50.06   SetVisible called while !IsConnected
22:59:50.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:50.06   GameSetupForm - Starting game
22:59:50.06   GameInfo::ResetInfo - SyncLevel set to 0 on reset
22:59:50.07   PopulateGameInfo - random seed:[1308671990], guid:[{8d949afc-7132-40c9-801b-6565603dd33b}], sync level:[2]
22:59:50.07   Error loading [DATA:levelingCurve.lua]
22:59:50.07   Error loading [DATA:levelingCurve.lua]
22:59:50.07   Error loading [DATA:levelingCurve.lua]
22:59:50.07   Error loading [DATA:levelingCurve.lua]
22:59:50.08   Error loading [DATA:levelingCurve.lua]
22:59:50.08   Error loading [DATA:levelingCurve.lua]
22:59:50.08   Error loading [DATA:levelingCurve.lua]
22:59:50.08   Error loading [DATA:levelingCurve.lua]
22:59:50.08   MOD - Setting player (0) race to: allies_soviets
22:59:50.08   MOD - Setting player (0) race to: 2
22:59:50.08   MOD - Setting player (1) race to: allies_soviets
22:59:50.08   MOD - Setting player (1) race to: 2
22:59:50.08   MOD - Setting player (2) race to: allies_soviets
22:59:50.08   MOD - Setting player (2) race to: 2
22:59:50.08   MOD - Setting player (3) race to: allies_soviets
22:59:50.08   MOD - Setting player (3) race to: 2
22:59:50.08   MOD - Setting player (4) race to: axis
22:59:50.08   MOD - Setting player (4) race to: 3
22:59:50.08   MOD - Setting player (5) race to: axis
22:59:50.08   MOD - Setting player (5) race to: 3
22:59:50.08   MOD - Setting player (6) race to: axis
22:59:50.08   MOD - Setting player (6) race to: 3
22:59:50.08   MOD - Setting player (7) race to: axis
22:59:50.08   MOD - Setting player (7) race to: 3
22:59:50.08   Activating screen: MessageBoxPopup
22:59:50.08   Session is marking the local peer PeerID 1 for death
22:59:50.08   Session::GetEvent DestroyPeer success Peer 1 removed
22:59:50.08   Session::DestroyPeer - deallocating peer 1
22:59:50.08   Session - Requested Disconnect for connectionID 2
22:59:50.08   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:59:50.08   Session - Requested Disconnect for connectionID 3
22:59:50.08   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
22:59:50.08   AdvertisementInternal::Process - EVENT_DESTROYPEER
22:59:50.08   Destroyed Matchinfo
22:59:50.10   APP -- Game Start
22:59:50.10   Sent message game CompanyOfHeroes allowtraffic
22:59:50.10   GAME -- Setting campaign state to 'dlc1'
22:59:50.10   GAME -- Closing state 'dlc1'
22:59:50.10   GAME -- Setting campaign state to 'dlc2'
22:59:50.10   GAME -- Closing state 'dlc2'
22:59:50.10   GAME -- Setting campaign state to 'dlc3'
22:59:50.10   GAME -- Closing state 'dlc3'
22:59:50.11   MessageInternal::DestroyChannel: Destroyed channel 534d5347
22:59:50.12   GAME -- Ending FE
22:59:50.12   UIFrontEnd - Unloading Front End
22:59:50.13   SOUND -- Shutting down ...
22:59:50.22   SOUND -- Shutdown completed!
22:59:50.23
22:59:50.23   GAME -- *** Beginning mission EICHSFELD CONFLUENCE (1 Humans, 7 Computers) ***
22:59:50.23
22:59:50.23   GAME -- Recording game
22:59:50.31   Activating screen: GameLoadScreen
22:59:50.31   ReportGameStartStats - no connection to server unable to report
22:59:50.31   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
22:59:50.31   PeerRemoveAll - flushing local session peer data
22:59:50.31   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
22:59:50.31   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
22:59:50.73   THREAD: Hyper-Threading Technology Processors are not detected.
22:59:50.81   SOUND -- Initializing ...
22:59:51.56   SOUND -- Initialization completed!
22:59:51.58   PHYSICS: detected processor(s) capable of handling 4 threads.
22:59:51.58   MOD -- Locating MOD for scenario 'DATA:Scenarios\MP\EICHSFELD CONFLUENCE'
22:59:51.58   MOD -- Using Mod 'Eastern_Front'
22:59:51.61   Unable to load/parse precache file [DATA:Scenarios\MP\EICHSFELD CONFLUENCE_precache.lua]
22:59:51.74   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
22:59:51.74   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\m04_shermans_arrive_low_load.smf'.  Expensive operation
22:59:55.23   GameObjLoader - upgrading load_count from 0 to 1083
22:59:57.97   GameObjLoader - upgrading load_count from 1083 to 1781
22:59:57.98   PHYSICS -- Created node factory 'HVOK'
22:59:57.98   PHYSICS -- Created node factory 'DMMY'
23:00:06.93   GameObjLoader - upgrading load_count from 1343 to 4021
23:00:11.64   GameObjLoader 1034ffe0 - resetting counters
23:00:11.64   GameObjLoader 1034ffe0 - LOAD_DONE
23:00:11.64   GAME - SessionSetup
23:00:11.64   GAME -- Can't initialize scenario pack more than once.
23:00:11.94   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
23:00:11.94   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
23:00:11.94   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
23:00:12.14   Warning: RenderCompositeStrips AddStripSegment : time == FLT_MAX
23:00:13.10   GAME - CreateGEWorld in 1460 ms
23:00:13.11   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
23:00:13.22   GAME - SessionSetup finished in 1580 ms
23:00:13.23   GAME - WaterReflectionManagerSetup
23:00:13.23   GAME - WaterReflectionManagerSetup finished in 0 ms
23:00:13.85   MessageInternal::CreateChannel: Created channel 474d4343
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x0630aa40
[Cope FactionFix] - patched @0x6d2e5491
[Cope FactionFix] - hooked @0x6d2e5492
[Cope FactionFix] - patched @0x6d2e4a07
[Cope FactionFix] - hooked @0x6d2e4a07
[Cope FactionFix] - Hook installed
23:00:14.02   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
23:00:15.00   MessageInternal::CreateChannel: Created channel 4d4f444d
23:00:15.80   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:00:15.80   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:00:15.80   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:00:15.80   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:00:15.80   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
23:00:16.36   SPEECHMANAGER -- Loaded in 0.512979 seconds
23:00:18.15   GameObjLoader - upgrading load_count from 0 to 331
23:00:19.06   GameObjLoader 0d8c65b8 - resetting counters
23:00:19.06   GameObjLoader 0d8c65b8 - LOAD_DONE
23:00:21.12   PreloadResources took 2000ms.
23:00:21.15   GAME -- Loading completed (31 seconds)
23:00:21.15   SIM -- Setting SyncErrorChecking level to None
23:00:28.04   Activating screen: GameScreen
23:00:28.04   Activating screen: Decorators
23:00:28.04   Activating screen: Taskbar
23:00:28.04   Activating screen: SubtitleScreen
23:00:28.04   Activating screen: TextOverlayScreen
23:00:28.13   PerformanceRecorder::StartRecording for game size 8
23:00:28.13   GAME -- Starting mission...
23:00:29.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:29.48   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
23:00:34.25   Warning: non auto-match upgrade not found in AE, tuning
23:00:37.94   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
23:00:59.63   Warning: binding repeat_3(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:01:18.52   Activating screen: pause_menu
23:01:18.52   GAME -- SimulationController::Pause 0
23:01:22.30   SPDx9 -- 1751MB available Texture Memory
23:01:24.04   GAME -- SimulationController::Pause 1
23:01:30.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:01:44.60   Activating screen: Command_Tree
23:01:45.35   Activating screen: Command_Branch
23:01:54.39   Warning: binding repeat_0(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
23:01:54.46   Warning: binding repeat_5(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:02:14.68   Warning: binding repeat_1(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:02:31.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:03:23.43   Activating screen: pause_menu
23:03:23.43   GAME -- SimulationController::Pause 0
23:03:26.68   SPDx9 -- 1751MB available Texture Memory
23:03:28.99   GAME -- SimulationController::Pause 1
23:03:32.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:04:33.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:04:44.58   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:04:44.58   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:04:44.58   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.
23:05:05.28   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:05:05.28   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:05:05.28   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.
23:05:34.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:05:43.59   Activating screen: pause_menu
23:05:43.59   GAME -- SimulationController::Pause 0
23:05:46.75   SPDx9 -- 1751MB available Texture Memory
23:05:48.47   GAME -- SimulationController::Pause 1
23:06:35.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:07:34.95   Activating screen: Command_Branch
23:07:36.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:07:40.12   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:07:40.12   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:07:40.12   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.
23:07:55.96   Unable to bind updater for fx [fx_special\production_exhaust].  It could be looping in a fire-n-forget action.
23:07:55.96   Muting spew of bind updater.  Fix art and re-test.
23:08:18.60   Activating screen: pause_menu
23:08:18.60   GAME -- SimulationController::Pause 0
23:08:25.65   SPDx9 -- 1751MB available Texture Memory
23:08:30.76   GAME -- SimulationController::Pause 1
23:08:37.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:09:26.02   Warning: binding repeat_4(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
23:09:38.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:10:30.43   Activating screen: Command_Branch
23:10:39.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:11:08.85   Activating screen: pause_menu
23:11:08.85   GAME -- SimulationController::Pause 0
23:11:12.78   SPDx9 -- 1751MB available Texture Memory
23:11:15.34   GAME -- SimulationController::Pause 1
23:11:40.01   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:12:41.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:12:51.52   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
23:13:42.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:14:13.80   Activating screen: pause_menu
23:14:13.80   GAME -- SimulationController::Pause 0
23:14:17.78   SPDx9 -- 1751MB available Texture Memory
23:14:19.33   GAME -- SimulationController::Pause 1
23:14:43.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
23:15:13.89   FXShader::SetVariable( "tex0", T ) uses unknown variable.
23:15:42.42   SimulationController::GenerateSyncCmd - couldn't send all commands, 1 binned.
23:15:44.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 2.3/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
23:16:16.76   Activating screen: pause_menu
23:16:16.81   GAME -- SimulationController::Pause 0
23:16:18.11   Activating screen: SaveGamePopup
23:16:21.23   Saving Terrain....
23:16:22.11       HeightManager::Save took 0.876275 seconds
23:16:22.16       TChunkManagerIO::Save took 0.0496128 seconds
23:16:22.16   GRASSMANAGER -- Save() called with grass disabled. Data lost.
23:16:22.16       GrassManager::Save took 4.22393e-005 seconds
23:16:22.31       TerrainTextureLoad::Save took 0.145646 seconds
23:16:22.31       DecalManager::Save took 0.0014323 seconds
23:16:22.31       TerrainMaterial::Save took 0.000498765 seconds
23:16:22.31       DeformationMask::Save took 0.000427086 seconds
23:16:22.31       ShellManager::Save took 1.62131e-005 seconds
23:16:22.31       LitterManager::Save took 1.45064e-005 seconds
23:16:22.31       WeatherManager::Save took 4.43726e-005 seconds
23:16:26.98   Pathfinder::Save...
23:16:30.06   Pathfinder::Save Done
23:16:39.09   Activating screen: prompt_generic
23:16:39.99   MOD -- Player NGOCQUANG-PC (network abort) (frame 7245) (KillPlayer)
23:16:39.99   GameApp::ReportStats
23:16:39.99   ReportStats - untracked game, no need to report match 4294967295:4294967295
23:16:39.99   ReportSimStats - nothing to report, no connection to the server
23:16:39.99   ReportStats - ReportSimStats failed
23:16:39.99   GameApp::Quit( exitValue = 0 )
23:16:40.02   GAME -- SimulationController::Pause 1
23:16:40.02   Activating screen: AppRestartingForm
23:16:40.02   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
23:16:40.02   Widget attempting to remove a non-existance listener. Widget:bkg_COH
23:16:40.02   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
23:16:40.02   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
23:16:40.02   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
23:16:40.02   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
23:16:40.03   GameApp::ShutFrontEnd
23:16:40.03   GameObj::ShutdownGameObj
23:16:40.03   GAME -- Ending mission (Game over)
23:16:40.12   GameObjLoader 0d8c65b8 - Unload
23:16:40.12   GameObjLoader 0d8c65b8 - resetting counters
23:16:40.20   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
23:16:40.20   MOD -- Game Over at frame 7245
23:16:40.48   GameObjLoader 1034ffe0 - Unload
23:16:40.48   GameObjLoader 1034ffe0 - resetting counters
23:16:40.61   SOUND -- Shutting down ...
23:16:40.76   SOUND -- Shutdown completed!
23:16:40.76   MessageInternal::DestroyChannel: Destroyed channel 474d4343
23:16:40.76   ~FEAppListener - Flushing queued online notifications
23:16:41.28   DLLDriverLinker -- 2 DLL drivers found.
23:16:41.29   ActionDatabase : [2344] global actions, [84] dummy actions.
23:16:41.29   NetworkManager::Destroy - destroying network manager
23:16:41.29   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
23:16:41.29   MessageInternal::DestroyChannel: Destroyed channel 50525459
23:16:41.29   PartyInternal: Fade to black
23:16:41.29   AutomatchInternal: Fade to black
23:16:41.29   PeerRemoveAll - flushing local session peer data
23:16:41.29   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
23:16:41.29   MessageInternal::DestroyChannel: Destroyed channel 47535450
23:16:41.29   Session - Requested Disconnect for connectionID 1
23:16:41.29   SessionManager::UnregisterSession - Unregistering session 0fa786b8
23:16:41.29   SessionManager::~SessionManager - uninitializing
23:16:41.31   Net::ThreadFunction - Returning from the network thread function...
23:16:41.32   Transport::~Transport - shutting down transport
23:16:41.32   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
23:16:41.32   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
23:16:41.32   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
23:16:41.32   Wrote 269 bytes to network datastore login_cache.bin
23:16:41.32   Wrote 52 bytes to network datastore global_cache.bin
23:16:41.32   Wrote 28 bytes to network datastore ping_cache.bin
23:16:41.32   Datastore -- uninitialize complete
23:16:41.32   QuazalInitializer - static uninit of Quazal library
23:16:41.32   QuazalInitializer - unhooking memory 0 currently allocated, 816 allocations, total of 79848 bytes
