-- Log file for all dbTracef messages --

09:06:08.88   NetworkManager::Create - creating network manager
09:06:08.88   Read 269 bytes from network datastore login_cache.bin
09:06:08.88   Read 52 bytes from network datastore global_cache.bin
09:06:08.88   Read 28 bytes from network datastore ping_cache.bin
09:06:08.88   QuazalInitializer - static initializing Quazal library
09:06:08.88   PingCache - populating cache with 0 pings
09:06:08.88   Sent message game CompanyOfHeroes started 1600 602 allowtraffic
09:06:08.88   RemoteDLManager - Connection Restored.
09:06:08.88   Transport - Header Size = 4 bytes + 4 byte nonce + 2 byte consolidation header
09:06:08.93   WinTransport - CreateSocket exclusive broadcast socket was available.
09:06:08.93   WinTransport - CreateSocket listening for broadcasts on default port
09:06:08.93   WinTransport - Host Name: NgocQuang-PC, aliases: , type=AF_INET, len=4
09:06:08.93   WinTransport - Host IP Address #0: 5.3.208.164
09:06:08.93   WinTransport - WARNING, MultipleNetwork adapters may cause problems
09:06:08.93   WinTransport - Interface #0: ip:5.3.208.164, broadcast:5.3.208.164, flags=IFF_UP IFF_BROADCAST IFF_MULTICAST
09:06:08.93   WinTransport - Interface #1: ip:192.168.1.100, broadcast:192.168.1.100, flags=IFF_BROADCAST IFF_MULTICAST
09:06:08.93   WinTransport - Interface #2: ip:127.0.0.1, broadcast:127.0.0.1, flags=IFF_UP IFF_LOOPBACK IFF_MULTICAST
09:06:08.93   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:06:08.93   WinTransport - Quazal address string = udp:/address=5.3.208.164;port=6112
09:06:08.93   SessionManager - Peer Header Size = 16 bytes
09:06:08.93   SessionManager - Game Data overhead = 7 bytes
09:06:08.93   SessionManager - Proxy overhead = 7 bytes
09:06:08.93   MessageInternal::CreateChannel: Created channel 47535450
09:06:08.93   Session::Initialize - info, initializing session object, using threads.
09:06:08.93   SessionManager::RegisterSession - Registering new session 076a1e08
09:06:08.93   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:06:08.93   AutomatchInternal: Instantiating
09:06:08.93   PartyInternal: Instantiating
09:06:08.93   MessageInternal::CreateChannel: Created channel 50525459
09:06:08.93   MessageInternal::CreateChannel: Created channel 51434b4d
09:06:08.93   Net::ThreadFunction - Entering network thread function...
09:06:08.93   MessageInternal::CreateChannel: Created channel 534d5347
09:06:08.93   MessageInternal::CreateChannel: Created channel 474d4343
09:06:08.93   MessageInternal::CreateChannel: Created channel 474f424a
09:06:08.93   MessageInternal::CreateChannel: Created channel 4d4f444d
09:06:08.93   MessageInternal::CreateChannel: Created channel 53594e43
09:06:08.93   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:06:08.93   MessageInternal::DestroyChannel: Destroyed channel 474d4343
09:06:08.93   MessageInternal::DestroyChannel: Destroyed channel 474f424a
09:06:08.93   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
09:06:08.93   MessageInternal::DestroyChannel: Destroyed channel 53594e43
09:06:08.93   GAME -- Available memory: 3071MB Physical RAM, 3069MB Pagefile, 4095 Virtual Address Space
09:06:08.95   Transport - Largest received is now 19
09:06:08.95   Transport::OpenInternal request to WINaddr:127.0.0.1:6112;
09:06:08.96   Transport - Largest sent is now 19
09:06:12.39   DLLDriverLinker -- Adding driver 'spDx10.dll'.
09:06:12.39   DLLDriverLinker -- Adding driver 'spDx9.dll'.
09:06:12.39   DLLDriverLinker -- 2 DLL drivers found.
09:06:12.45   SPDx10 -- Adapter [ASUS EAH3450 Series]: 508MB dedicated video memory, 0MB dedicated system memory and 1279MB shared system memory.
09:06:14.10   DLLDriverLinker -- 2 DLL drivers found.
09:06:14.24   SPOOGE - Driver[DirectX9 rendering device] version[4,36]
09:06:14.24   GAME -- Resolution set to 1024x768 (fullscreen).
09:06:14.25   SPDx9 -- Driver Name = atiumdag.dll  Desc = ASUS EAH3450 Series
09:06:14.25   SPDx9 -- Driver Vendor = 0x1002  Device = 0x95C5  SubSys = 0x01E21043  Rev = 0x0000
09:06:14.25   SPDx9 -- Driver Version  Product = 0x0007  Version = 0x000E  SubVersion = 0x00  Build = 5.97
09:06:14.25   SPDx9 -- Driver GUID = {D7B71EE2-D685-11CF-A671-E821A1C2CA35}
09:06:14.78   SPDx9 -- 1774MB available Texture Memory
09:06:14.78   ShaderDatabase: using shader profile [ps30]
09:06:15.33   FILESYSTEM -- filepath failure, missing alias 'TOOLSDATA:autoloddecimator.lua'
09:06:15.57   GameObjLoader 077238c0 - resetting counters
09:06:15.57   GameObjLoader 077238c0 - Created loader
09:06:15.57   GameObjLoader 07723a20 - resetting counters
09:06:15.57   GameObjLoader 07723a20 - Created loader
09:06:31.03   GAME -- Beginning FE
09:06:31.03   Sent message game CompanyOfHeroes allowtraffic
09:06:31.03   UIFrontEnd - Loading Front End
09:06:31.03   THREAD: Hyper-Threading Technology Processors are not detected.
09:06:31.11   SOUND -- Initializing ...
09:06:31.83   SOUND -- Initialization completed!
09:06:31.83   UIFrontEnd - Initializing Forms
09:06:33.73   CampaignFilter::BindFilterSpecificWidgets()
09:06:33.80   installed_products = ( )
09:06:33.82   Activating screen: AppLoadingForm
09:06:33.82   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:06:33.82   Got dlman msg [dlmanager version 1.0 peertraffic 1 uploadlimit 2147483647 seedratio 3]
09:06:33.82   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:06:33.82   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:06:34.56   GAME -- Loaded campaign 'Invasion of Normandy' (DATA:SCENARIOS\SP\COH.CAMP) with 15 missions, [coh]
09:06:34.57   GAME -- Loaded campaign 'Liberation of Caen' (DATA:SCENARIOS\SP\CXP1.CAMP) with 9 missions, [cxp1]
09:06:34.57   GAME -- Loaded campaign 'Operation Market Garden' (DATA:SCENARIOS\SP\CXP2.CAMP) with 8 missions, [cxp2]
09:06:34.57   GAME -- Loaded campaign 'Falaise Pocket' (DATA:SCENARIOS\SP\DLC3.CAMP) with 3 missions, [dlc3]
09:06:34.57   GAME -- Loaded campaign 'Causeway' (DATA:SCENARIOS\SP\DLC2.CAMP) with 3 missions, [dlc2]
09:06:34.58   GAME -- Loaded campaign 'Tiger Ace' (DATA:SCENARIOS\SP\DLC1.CAMP) with 3 missions, [dlc1]
09:06:34.96   GAME -- Using player profile NGOCQUANG-PC
09:06:38.30   Dx9Program : Unable to find shader script for 'fxshader_multiply' in the ShaderDatabase.
09:06:39.26   Dx9Program : Unable to find shader script for 'fxshader_depthadditive' in the ShaderDatabase.
09:06:40.32   QuazalLoginService - *** Connecting to server: reliclive.quazal.net:30260
09:06:40.32   RendezvousManager: CreateSession - starting profile=Guest login
09:06:40.37   GetBackEndServices()->Login: call returned with (5:2) TransportErrorCode::ConnectionFailure.
09:06:40.37   RendezvousManager - unable to connect to the server as guest
09:06:40.39   OnConnect: connect failure
09:06:40.39   RendezvousManager::Shutdown - deleting instance
09:06:40.39   RendezvousManager - terminating all server calls in progress
09:06:40.39   CallManager - terminating all server calls in progress (1 in progress)
09:06:40.39   RendezvousManager - destroying chat handler
09:06:40.39   ~RendezvousManager - m_state = 7, no need for server disconnect
09:06:40.41   OnConnect: this wasnt a reconnect, no need for autologin
09:06:40.42   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:06:40.43   CRC & Version Info : 0000025a:ce5073b5:ec3c9e0d eastern_front:602:factionfix.dll 1
09:06:40.43   Activating screen: FEMovie
09:06:40.43   Activating screen: OnlineWidget
09:06:40.43   Activating screen: RelicOnlineLogin
09:06:40.48   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:06:40.48   You have a valid version of the game.
09:06:40.49   AccountStore -- Found matching account %%%DefaultAccountName%%%, ignoring for now
09:06:40.49   installed_products = ( DLC1 DLC2 DLC3 )
09:06:40.49   OnLogin: no previous login, auto selecting profile not required
09:06:40.49   Activating screen: MessageBoxPopup
09:06:40.49   Activating screen: MessageBoxPopup
09:06:40.49   ScreenManager - Flushing recursively, due to activated screens during the previous flush, flush number: 1
09:06:43.54   Beginning media verification...
09:06:43.54   Validator type : validators\udro\udro.dll
09:06:43.55   Activating screen: MessageBoxPopup
09:06:43.58   Activating screen: FE_mm_01
09:06:43.58   GAME -- Setting campaign state to 'dlc1'
09:06:43.58   GAME -- Closing state 'dlc1'
09:06:43.59   GAME -- Setting campaign state to 'dlc2'
09:06:43.59   GAME -- Closing state 'dlc2'
09:06:43.59   GAME -- Setting campaign state to 'dlc3'
09:06:43.59   GAME -- Closing state 'dlc3'
09:06:44.60   Activating screen: MessageBoxPopup
09:06:44.60   Created Matchinfo
09:06:44.60   Session::Reset with reason 999 and AdvertisementInternal::ResetSession()
09:06:44.60   starting LAN hosting
09:06:44.63   OnJoinAdvertisementSuccess - joined online match, server leave notification required
09:06:44.63   starting local hosting
09:06:44.63   Transport::OpenInternal request to WINaddr:255.255.255.255:6112;
09:06:44.63   Allocated route ID=0 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:06:44.63   Transport::OpenInternal request to WINaddr:5.3.208.164:6112;
09:06:44.63   Session::Host sid = DE8F4D05497B350B, hostURL = , local addresses = WINaddr:5.3.208.164:6112;
09:06:44.63   ValidateCustomData: called with 217 bytes of custom data
09:06:44.63   Host accepted Peer 1 into the match at address list=WINaddr:5.3.208.164:6112;, routes=WINaddr:5.3.208.164:6112;
09:06:44.63   AdvertisementInternal::Process - EVENT_NEWPEER
09:06:44.63   Session::GetState - info, session's state changed to [2:STATE_CONNECTING].
09:06:44.65   Session::GetState - info, session's state changed to [3:STATE_CONNECTED].
09:06:44.65   hosting - Session is connected
09:06:44.65   Net::Session::SetVisible - session is set to VISIBLE.
09:06:44.65   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
09:06:44.65   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=1/0, join_reply=0/0, add=0/0, remove=0/0, drop=0/0, data=0/0, voice=0/0, rchk=0/0, nudge=0/0, peerhdr=0/0, proxy=0/0, ping=0/0, frag=0/0, Errors=0/0
09:06:44.66   Transport - Largest received is now 475
09:06:44.66   hosting completed successfully
09:06:44.66   HostAsync - completed with HostResult = 0
09:06:44.66   UIFrontEnd::StartRelicOnlineTabs deactivating FE_mm_01
09:06:44.66   Activating screen: OnlineGameSetup
09:06:44.66   MessageInternal::CreateChannel: Created channel 534d5347
09:06:44.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:06:44.66   MatchInternal::SetMatchType - new type 14 - updating server
09:06:44.68   SetVisible called while !IsConnected
09:06:44.68   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:06:44.68   Transport - Largest received is now 531
09:06:44.68   Activating screen: RelicOnlineChat
09:06:44.68   Activating screen: RelicOnlineNewsScreen
09:06:44.68   Activating screen: RelicOnlineStatsScreen
09:06:44.68   Activating screen: Achievements
09:06:44.68   GAME -- Setting campaign state to 'dlc1'
09:06:44.69   GAME -- Closing state 'dlc1'
09:06:44.69   GAME -- Setting campaign state to 'dlc1'
09:06:44.69   GAME -- Closing state 'dlc1'
09:06:44.69   GAME -- Setting campaign state to 'dlc2'
09:06:44.69   GAME -- Closing state 'dlc2'
09:06:44.69   GAME -- Setting campaign state to 'dlc3'
09:06:44.69   GAME -- Closing state 'dlc3'
09:06:44.69   GAME -- Setting campaign state to 'dlc1'
09:06:44.69   GAME -- Closing state 'dlc1'
09:06:44.70   Transport - Largest received is now 1196
09:06:44.70   Activating screen: GameHistory
09:06:44.70   GAME -- Setting campaign state to 'dlc1'
09:06:44.77   GAME -- Closing state 'dlc1'
09:06:44.78   GAME -- Setting campaign state to 'dlc2'
09:06:44.78   GAME -- Closing state 'dlc2'
09:06:44.78   GAME -- Setting campaign state to 'dlc3'
09:06:44.78   GAME -- Closing state 'dlc3'
09:06:44.78   Activating screen: OnlineGameSetup
09:06:44.78   Activating screen: RelicOnlineTabs
09:06:44.78   AutomatchInternal::OnHostComplete - Completed Host with success=1
09:06:44.78   AutomatchInternal::OnHostComplete - automatcher is no longer active - ignoring
09:06:44.78   QuickMatchInternal::OnHostComplete - Quickmatch not in host state.
09:06:44.79   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:06:44.79   Net::Session::SetVisible - session is set to INVISIBLE.
09:06:44.79   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:06:44.87   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:06:44.88   GAME -- Setting campaign state to 'dlc1'
09:06:44.88   GAME -- Closing state 'dlc1'
09:06:44.88   GAME -- Setting campaign state to 'dlc2'
09:06:44.88   GAME -- Closing state 'dlc2'
09:06:44.89   GAME -- Setting campaign state to 'dlc3'
09:06:44.89   GAME -- Closing state 'dlc3'
09:06:44.94   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:06:46.10   Activating screen: Achievements
09:06:46.10   Activating screen: RelicOnlineTabs
09:06:55.49   SPDx9 -- 1773MB available Texture Memory
09:07:09.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.1/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:07:27.02   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:27.02   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:27.02   GetMaxFrameTimeFromProfile: players=2 expected FPS=100.000000, bars=5, max avg=0.000, sd=0.000, 0 samples =
09:07:27.05   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:27.09   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:28.77   Activating screen: OnlineGameSetup
09:07:28.77   Activating screen: RelicOnlineTabs
09:07:30.52   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:30.52   Net::Session::SetVisible - session is set to VISIBLE.
09:07:30.52   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:30.59   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:30.62   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:35.01   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:35.01   Net::Session::SetVisible - session is set to VISIBLE.
09:07:35.01   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:35.13   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:35.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:40.33   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:40.33   Net::Session::SetVisible - session is set to VISIBLE.
09:07:40.33   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:40.43   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:40.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:41.44   Activating screen: RaceSelectionPopup
09:07:42.10   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:42.10   Net::Session::SetVisible - session is set to VISIBLE.
09:07:42.10   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:42.11   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:42.14   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:42.79   Activating screen: DynamicPopupMenu
09:07:43.76   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:43.76   Net::Session::SetVisible - session is set to VISIBLE.
09:07:43.76   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:43.78   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:43.80   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:44.34   Activating screen: DynamicPopupMenu
09:07:45.01   local host PeerID 1 CONN ack=  0 (  0ms~0) unack=  0, retry=  0, highwaterOOS=0 @WINaddr:5.3.208.164:6112; (ping=0ms) 100.00%, pending=0, dead=0
09:07:45.01   MessageCounts: inval=0/0, seek=0/0, join=0/0, integ=0/0, seek_reply=13/14, 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=15/15, frag=0/0, Errors=0/0
09:07:45.14   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:45.14   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:45.14   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:45.15   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:45.18   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:45.68   Activating screen: RaceSelectionPopup
09:07:46.32   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:46.32   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:46.33   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:46.35   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:46.38   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:46.75   Activating screen: RaceSelectionPopup
09:07:47.61   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:47.61   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:47.61   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:47.61   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:47.64   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:48.31   Activating screen: DynamicPopupMenu
09:07:48.95   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:48.95   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:48.95   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:48.96   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:48.99   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:49.49   Activating screen: DynamicPopupMenu
09:07:50.19   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:50.19   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:50.19   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:50.19   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:50.23   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:50.68   Activating screen: DynamicPopupMenu
09:07:51.73   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:51.73   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:51.73   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:51.74   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:51.76   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:53.20   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:53.20   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:53.20   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:53.21   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:53.25   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:54.44   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:54.44   Net::Session::SetVisible - session is set to INVISIBLE.
09:07:54.44   GetMaxFrameTimeFromProfile: players=6 expected FPS=19.252983, bars=5, max avg=0.042, sd=0.010, 2 samples =  0.05 0.03
09:07:54.45   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:54.48   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:55.66   GameSetupForm - No win/loss reporting and only a single player, disconnecting
09:07:55.66   GameSetupForm - UpdateMatchType: Setting match type to 14: CLASSIC_COOP_SKIRMISH
09:07:55.66   SetVisible called while !IsConnected
09:07:55.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:55.66   GameSetupForm - Starting game
09:07:55.66   GameInfo::ResetInfo - SyncLevel set to 0 on reset
09:07:55.67   PopulateGameInfo - random seed:[1308535675], guid:[{379414a3-eea6-473c-9332-398303eec029}], sync level:[2]
09:07:55.67   Error loading [DATA:levelingCurve.lua]
09:07:55.67   Error loading [DATA:levelingCurve.lua]
09:07:55.67   Error loading [DATA:levelingCurve.lua]
09:07:55.68   Error loading [DATA:levelingCurve.lua]
09:07:55.68   Error loading [DATA:levelingCurve.lua]
09:07:55.68   Error loading [DATA:levelingCurve.lua]
09:07:55.68   MOD - Setting player (0) race to: allies_soviets
09:07:55.68   MOD - Setting player (0) race to: 2
09:07:55.68   MOD - Setting player (1) race to: allies_soviets
09:07:55.68   MOD - Setting player (1) race to: 2
09:07:55.68   MOD - Setting player (2) race to: allies_soviets
09:07:55.68   MOD - Setting player (2) race to: 2
09:07:55.68   MOD - Setting player (3) race to: axis
09:07:55.68   MOD - Setting player (3) race to: 3
09:07:55.68   MOD - Setting player (4) race to: axis
09:07:55.68   MOD - Setting player (4) race to: 3
09:07:55.68   MOD - Setting player (5) race to: axis
09:07:55.68   MOD - Setting player (5) race to: 3
09:07:55.68   Activating screen: MessageBoxPopup
09:07:55.68   Session is marking the local peer PeerID 1 for death
09:07:55.68   Session::GetEvent DestroyPeer success Peer 1 removed
09:07:55.68   Session::DestroyPeer - deallocating peer 1
09:07:55.68   Session - Requested Disconnect for connectionID 2
09:07:55.68   Deallocated route ID=3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:07:55.68   Session - Requested Disconnect for connectionID 3
09:07:55.68   Closed route 3<>3 for PeerID 1 at WINaddr:5.3.208.164:6112;
09:07:55.68   AdvertisementInternal::Process - EVENT_DESTROYPEER
09:07:55.68   Destroyed Matchinfo
09:07:55.71   APP -- Game Start
09:07:55.71   Sent message game CompanyOfHeroes allowtraffic
09:07:55.71   GAME -- Setting campaign state to 'dlc1'
09:07:55.71   GAME -- Closing state 'dlc1'
09:07:55.71   GAME -- Setting campaign state to 'dlc2'
09:07:55.71   GAME -- Closing state 'dlc2'
09:07:55.72   GAME -- Setting campaign state to 'dlc3'
09:07:55.72   GAME -- Closing state 'dlc3'
09:07:55.72   MessageInternal::DestroyChannel: Destroyed channel 534d5347
09:07:55.74   GAME -- Ending FE
09:07:55.74   UIFrontEnd - Unloading Front End
09:07:55.75   SOUND -- Shutting down ...
09:07:55.80   SOUND -- Shutdown completed!
09:07:55.83
09:07:55.83   GAME -- *** Beginning mission 6p_kiev (1 Humans, 5 Computers) ***
09:07:55.83
09:07:56.06   GAME -- Recording game
09:07:56.12   Activating screen: GameLoadScreen
09:07:56.13   ReportGameStartStats - no connection to server unable to report
09:07:56.13   Session::GetState - info, session's state changed to [1:STATE_DISCONNECTED].
09:07:56.13   PeerRemoveAll - flushing local session peer data
09:07:56.13   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:07:56.13   Got dlman msg [ack game CompanyOfHeroes allowtraffic]
09:07:56.59   THREAD: Hyper-Threading Technology Processors are not detected.
09:07:56.67   SOUND -- Initializing ...
09:07:57.39   SOUND -- Initialization completed!
09:07:57.41   PHYSICS: detected processor(s) capable of handling 4 threads.
09:07:57.41   MOD -- Locating MOD for scenario 'DATA:scenarios\mp\6p_kiev'
09:07:57.41   MOD -- Using Mod 'Eastern_Front'
09:07:57.44   Unable to load/parse precache file [DATA:scenarios\mp\6p_kiev_precache.lua]
09:07:57.56   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
09:07:57.56   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
09:08:01.08   GameObjLoader - upgrading load_count from 0 to 1100
09:08:03.99   GameObjLoader - upgrading load_count from 1100 to 1822
09:08:04.00   PHYSICS -- Created node factory 'HVOK'
09:08:04.00   PHYSICS -- Created node factory 'DMMY'
09:08:10.00   Transport - median kBPS [hi/cur] sent = 0.1/0.1, recvd = 1.9/0.0, #p/sec[s/r] = 0.3/0.6, max unsent 0, version err 0, merge 0
09:08:15.85   GameObjLoader - upgrading load_count from 1447 to 4395
09:08:20.92   GameObjLoader 077238c0 - resetting counters
09:08:20.92   GameObjLoader 077238c0 - LOAD_DONE
09:08:20.92   GAME - SessionSetup
09:08:21.22   CommandBPDatabase - Unable to register function [splat_attach] due to missing CommandBP.
09:08:21.22   TERRAINTEXTURE -- compositor added RenderTarget [0] of size 1024 x 1024
09:08:21.22   TERRAINTEXTURE -- compositor added RenderTarget [1] of size 1024 x 1024
09:08:23.83   GAME - CreateGEWorld in 2909 ms
09:08:23.84   TGAIO -- TGA file 'data:simulation/deformdata/Lock_deform.tga' is RLE compressed. For optimal speed, please re-save uncompressed.
09:08:24.05   GAME - SessionSetup finished in 3125 ms
09:08:24.06   GAME - WaterReflectionManagerSetup
09:08:24.06   GAME - WaterReflectionManagerSetup finished in 0 ms
09:08:24.62   MessageInternal::CreateChannel: Created channel 474d4343
09:08:24.63   Regenerating ImpassMap data...
09:08:24.63       Impass Data was already valid, but regenerating...
09:08:24.95   Generating CanBuild Map.  THIS SHOULD ONLY HAPPEN IN WORLDBUILDER!  IF YOU SEE THIS IN GAME, RE-SAVE THE MAP!
09:08:24.95   Regenerating CanBuildMap data...
09:08:24.95   Generating CanShoot Map.
09:08:24.95   Pathfinder::Regenerate()...
09:08:25.05   Generating PathSectorMap...
09:08:25.72   Pathfinder::Regenerate() Done.
[Cope FactionFix] - Trying to hook function
[Cope FactionFix] - Got LuaState @0x06a59230
[Cope FactionFix] - patched @0x699b5491
[Cope FactionFix] - hooked @0x699b5492
[Cope FactionFix] - patched @0x699b4a07
[Cope FactionFix] - hooked @0x699b4a07
[Cope FactionFix] - Hook installed
09:08:25.93   ModWorld::LoadWinCondition: - [DATA:Scar/WinConditions/zannihilate.scar] succeeded.
09:08:26.40   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:08:26.40   MOD -- Player  (unused player) (frame 0) (KillPlayer)
09:08:27.29   MessageInternal::CreateChannel: Created channel 4d4f444d
09:08:28.19   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:08:28.20   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:08:28.20   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:08:28.20   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:08:28.20   BindingsSystem -- Cannot create binding.  Unknown type 'repair_radius_circle'
09:08:28.75   SPEECHMANAGER -- Loaded in 0.507664 seconds
09:08:30.41   GameObjLoader - upgrading load_count from 0 to 349
09:08:31.54   GameObjLoader 07723a20 - resetting counters
09:08:31.54   GameObjLoader 07723a20 - LOAD_DONE
09:08:33.70   PreloadResources took 2084ms.
09:08:33.73   GAME -- Loading completed (38 seconds)
09:08:33.73   SIM -- Setting SyncErrorChecking level to None
09:08:34.48   Re-winding a compressed stream for file 'data:sound\wav\music_nonstream\coh_force_beyond_reckoning_lower_load.smf'.  Expensive operation
09:08:37.05   Activating screen: GameScreen
09:08:37.05   Activating screen: Decorators
09:08:37.05   Activating screen: Taskbar
09:08:37.05   Activating screen: SubtitleScreen
09:08:37.05   Activating screen: TextOverlayScreen
09:08:37.15   PerformanceRecorder::StartRecording for game size 6
09:08:37.15   GAME -- Starting mission...
09:08:38.34   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:08:38.34   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:08:38.34   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:08:38.34   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:08:38.34   MOD -- Player CPU - Expert set to AI Type: AI Player (frame 1) (CmdAI)
09:08:42.97   Warning: non auto-match upgrade not found in AE, tuning
09:08:45.50   Activating screen: Command_Tree
09:08:48.89   Activating screen: Command_Branch
09:09:02.74   Warning: binding repeat_2(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:09:11.00   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.9/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:09:33.74   Activating screen: pause_menu
09:09:33.76   GAME -- SimulationController::Pause 0
09:09:35.04   Activating screen: pause_options
09:09:43.46   GAME -- SimulationController::Pause 1
09:09:49.34   Activating screen: pause_menu
09:09:49.35   GAME -- SimulationController::Pause 0
09:09:50.67   Activating screen: pause_options
09:09:55.52   GAME -- SimulationController::Pause 1
09:10:01.32   Warning: binding selection bindings_child6() -- Binding selection bindings_child6: failed bind to widget 'build_max_background'
09:10:12.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.9/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:10:13.78   Warning: binding repeat_3(Ability: abilities\smg_pps) -- ui index '0' out of bounds; range is [1, 12]
09:10:13.78   Warning: binding repeat_4(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:10:37.98   Warning: binding repeat_0(Ability: abilities\reenable_capture_ability) -- ui index '0' out of bounds; range is [1, 12]
09:11:13.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.9/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:11:42.10   Activating screen: pause_menu
09:11:42.10   GAME -- SimulationController::Pause 0
09:11:45.02   SPDx9 -- 1755MB available Texture Memory
09:11:47.69   GAME -- SimulationController::Pause 1
09:12:07.39   Activating screen: pause_menu
09:12:07.43   GAME -- SimulationController::Pause 0
09:12:08.89   Activating screen: SaveGamePopup
09:12:14.01   Transport - median kBPS [hi/cur] sent = 0.1/0.0, recvd = 1.9/0.0, #p/sec[s/r] = 0.3/0.5, max unsent 0, version err 0, merge 0
09:12:14.15   Saving Terrain....
09:12:14.51       HeightManager::Save took 0.356407 seconds
09:12:14.56       TChunkManagerIO::Save took 0.0498155 seconds
09:12:14.56   GRASSMANAGER -- Save() called with grass disabled. Data lost.
09:12:14.56       GrassManager::Save took 3.9253e-005 seconds
09:12:15.01       TerrainTextureLoad::Save took 0.448746 seconds
09:12:15.01       DecalManager::Save took 0.00154025 seconds
09:12:15.01       TerrainMaterial::Save took 0.000412583 seconds
09:12:15.01       DeformationMask::Save took 0.000557222 seconds
09:12:15.01       ShellManager::Save took 1.74932e-005 seconds
09:12:15.01       LitterManager::Save took 1.91998e-005 seconds
09:12:15.01       WeatherManager::Save took 4.60796e-005 seconds
09:12:18.17   Pathfinder::Save...
09:12:20.90   Pathfinder::Save Done
09:12:30.53   Activating screen: prompt_generic
09:12:31.42   MOD -- Player NGOCQUANG-PC (network abort) (frame 1502) (KillPlayer)
09:12:31.42   GameApp::ReportStats
09:12:31.42   ReportStats - untracked game, no need to report match 4294967295:4294967295
09:12:31.42   ReportSimStats - nothing to report, no connection to the server
09:12:31.42   ReportStats - ReportSimStats failed
09:12:31.42   GameApp::Quit( exitValue = 0 )
09:12:31.45   GAME -- SimulationController::Pause 1
09:12:31.45   Activating screen: AppRestartingForm
09:12:31.45   SetupProductLoadingArt - choosing bgArt = 4 (gold=0)
09:12:31.45   Widget attempting to remove a non-existance listener. Widget:bkg_COH
09:12:31.45   Widget attempting to remove a non-existance listener. Widget:bkg_CXP1
09:12:31.45   Widget attempting to remove a non-existance listener. Widget:bkg_CXP2
09:12:31.45   Widget attempting to remove a non-existance listener. Widget:bkg_COHCXP1
09:12:31.45   Widget attempting to remove a non-existance listener. Widget:bkg_ToV
09:12:31.46   GameApp::ShutFrontEnd
09:12:31.46   GameObj::ShutdownGameObj
09:12:31.46   GAME -- Ending mission (Game over)
09:12:31.61   GameObjLoader 07723a20 - Unload
09:12:31.61   GameObjLoader 07723a20 - resetting counters
09:12:31.66   MessageInternal::DestroyChannel: Destroyed channel 4d4f444d
09:12:31.66   MOD -- Game Over at frame 1502
09:12:31.92   GameObjLoader 077238c0 - Unload
09:12:31.92   GameObjLoader 077238c0 - resetting counters
09:12:32.07   SOUND -- Shutting down ...
09:12:32.17   SOUND -- Shutdown completed!
09:12:32.19   MessageInternal::DestroyChannel: Destroyed channel 474d4343
09:12:32.19   ~FEAppListener - Flushing queued online notifications
09:12:32.73   DLLDriverLinker -- 2 DLL drivers found.
09:12:32.73   ActionDatabase : [2344] global actions, [36] dummy actions.
09:12:32.73   NetworkManager::Destroy - destroying network manager
09:12:32.73   MessageInternal::DestroyChannel: Destroyed channel 51434b4d
09:12:32.73   MessageInternal::DestroyChannel: Destroyed channel 50525459
09:12:32.73   PartyInternal: Fade to black
09:12:32.73   AutomatchInternal: Fade to black
09:12:32.73   PeerRemoveAll - flushing local session peer data
09:12:32.73   Session::Reset with reason 999 and MatchInternal::PeerRemoveAll
09:12:32.73   MessageInternal::DestroyChannel: Destroyed channel 47535450
09:12:32.73   Session - Requested Disconnect for connectionID 1
09:12:32.73   SessionManager::UnregisterSession - Unregistering session 076a1e08
09:12:32.73   SessionManager::~SessionManager - uninitializing
09:12:32.74   Net::ThreadFunction - Returning from the network thread function...
09:12:32.75   Transport::~Transport - shutting down transport
09:12:32.75   Transport::~Connection - closing WINaddr:255.255.255.255:6112;,WINaddr:255.255.255.255:6112;
09:12:32.75   Transport::~Connection - closing WINaddr:127.0.0.1:6112;,WINaddr:127.0.0.1:6112;
09:12:32.75   Transport::~Connection - closing WINaddr:5.3.208.164:6112;,WINaddr:5.3.208.164:6112;
09:12:32.75   Wrote 269 bytes to network datastore login_cache.bin
09:12:32.75   Wrote 52 bytes to network datastore global_cache.bin
09:12:32.75   Wrote 28 bytes to network datastore ping_cache.bin
09:12:32.75   Datastore -- uninitialize complete
09:12:32.75   QuazalInitializer - static uninit of Quazal library
09:12:32.75   QuazalInitializer - unhooking memory 0 currently allocated, 455 allocations, total of 44180 bytes
